2025-09-18 03:01:09.026160 | Job console starting 2025-09-18 03:01:09.036131 | Updating git repos 2025-09-18 03:01:09.279814 | Cloning repos into workspace 2025-09-18 03:01:09.384609 | Restoring repo states 2025-09-18 03:01:09.410875 | Merging changes 2025-09-18 03:01:09.410888 | Checking out repos 2025-09-18 03:01:09.498077 | Preparing playbooks 2025-09-18 03:01:10.893446 | Running Ansible setup 2025-09-18 03:01:17.479119 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-18 03:01:18.524110 | 2025-09-18 03:01:18.524219 | PLAY [Base pre] 2025-09-18 03:01:18.556531 | 2025-09-18 03:01:18.556637 | TASK [Setup log path fact] 2025-09-18 03:01:18.583188 | debian-bookworm | ok 2025-09-18 03:01:18.606396 | 2025-09-18 03:01:18.606556 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-18 03:01:18.644269 | debian-bookworm | ok 2025-09-18 03:01:18.652017 | 2025-09-18 03:01:18.652109 | TASK [emit-job-header : Print job information] 2025-09-18 03:01:18.728007 | # Job Information 2025-09-18 03:01:18.728141 | Ansible Version: 2.16.14 2025-09-18 03:01:18.728170 | Job: python-black 2025-09-18 03:01:18.728196 | Pipeline: periodic-daily 2025-09-18 03:01:18.728215 | Executor: 521e9411259a 2025-09-18 03:01:18.728232 | Triggered by: https://github.com/osism/ansible-collection-services 2025-09-18 03:01:18.728250 | Event ID: 6588ede8a20848d19d22a55abf196d18 2025-09-18 03:01:18.732190 | 2025-09-18 03:01:18.732272 | LOOP [emit-job-header : Print node information] 2025-09-18 03:01:18.850624 | debian-bookworm | ok: 2025-09-18 03:01:18.850804 | debian-bookworm | # Node Information 2025-09-18 03:01:18.850847 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-18 03:01:18.850869 | debian-bookworm | Hostname: debian 2025-09-18 03:01:18.850887 | debian-bookworm | Username: zuul 2025-09-18 03:01:18.850903 | debian-bookworm | Distro: Debian 12.12 2025-09-18 03:01:18.850923 | debian-bookworm | Provider: regiocloud-a 2025-09-18 03:01:18.850941 | debian-bookworm | Region: 2025-09-18 03:01:18.850958 | debian-bookworm | Label: debian-bookworm 2025-09-18 03:01:18.850974 | debian-bookworm | Product Name: OpenStack Nova 2025-09-18 03:01:18.850991 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7c:621 2025-09-18 03:01:18.861303 | 2025-09-18 03:01:18.861409 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-18 03:01:19.713441 | debian-bookworm -> localhost | changed 2025-09-18 03:01:19.720888 | 2025-09-18 03:01:19.721013 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-18 03:01:21.323431 | debian-bookworm -> localhost | changed 2025-09-18 03:01:21.333472 | 2025-09-18 03:01:21.333561 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-18 03:01:21.831759 | debian-bookworm -> localhost | ok 2025-09-18 03:01:21.842234 | 2025-09-18 03:01:21.842333 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-18 03:01:21.892629 | debian-bookworm | ok 2025-09-18 03:01:21.952318 | debian-bookworm | included: /var/lib/zuul/builds/8db38376f5434a30a70df5cbe7ceeedd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-18 03:01:21.961339 | 2025-09-18 03:01:21.961557 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-18 03:01:23.299584 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-18 03:01:23.299899 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8db38376f5434a30a70df5cbe7ceeedd/work/8db38376f5434a30a70df5cbe7ceeedd_id_rsa 2025-09-18 03:01:23.299942 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8db38376f5434a30a70df5cbe7ceeedd/work/8db38376f5434a30a70df5cbe7ceeedd_id_rsa.pub 2025-09-18 03:01:23.299978 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-18 03:01:23.300086 | debian-bookworm -> localhost | SHA256:zlgM7mlFREa3DY08MIPTlqBhCyTdJJHlVfVDFC9TFzc zuul-build-sshkey 2025-09-18 03:01:23.300114 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-18 03:01:23.300145 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-18 03:01:23.300168 | debian-bookworm -> localhost | |.o=*= oBX=+++..E+| 2025-09-18 03:01:23.300215 | debian-bookworm -> localhost | | .o=.=oo+++*.o .o| 2025-09-18 03:01:23.300237 | debian-bookworm -> localhost | | + .o. ..* . | 2025-09-18 03:01:23.300257 | debian-bookworm -> localhost | | . + + | 2025-09-18 03:01:23.300277 | debian-bookworm -> localhost | | . S | 2025-09-18 03:01:23.300344 | debian-bookworm -> localhost | | . B | 2025-09-18 03:01:23.300457 | debian-bookworm -> localhost | | = o | 2025-09-18 03:01:23.300483 | debian-bookworm -> localhost | | . | 2025-09-18 03:01:23.300507 | debian-bookworm -> localhost | | | 2025-09-18 03:01:23.300528 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-18 03:01:23.300587 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.569224 2025-09-18 03:01:23.314998 | 2025-09-18 03:01:23.315296 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-18 03:01:23.344956 | debian-bookworm | ok 2025-09-18 03:01:23.359535 | debian-bookworm | included: /var/lib/zuul/builds/8db38376f5434a30a70df5cbe7ceeedd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-18 03:01:23.377661 | 2025-09-18 03:01:23.377744 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-18 03:01:23.404616 | debian-bookworm | skipping: Conditional result was False 2025-09-18 03:01:23.409970 | 2025-09-18 03:01:23.410051 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-18 03:01:24.323628 | debian-bookworm | changed 2025-09-18 03:01:24.331824 | 2025-09-18 03:01:24.331922 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-18 03:01:24.603687 | debian-bookworm | ok 2025-09-18 03:01:24.609474 | 2025-09-18 03:01:24.609555 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-18 03:01:25.262408 | debian-bookworm | changed 2025-09-18 03:01:25.267901 | 2025-09-18 03:01:25.267987 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-18 03:01:25.860078 | debian-bookworm | changed 2025-09-18 03:01:25.868692 | 2025-09-18 03:01:25.868970 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-18 03:01:25.883931 | debian-bookworm | skipping: Conditional result was False 2025-09-18 03:01:25.891333 | 2025-09-18 03:01:25.891533 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-18 03:01:26.224200 | debian-bookworm -> localhost | changed 2025-09-18 03:01:26.239251 | 2025-09-18 03:01:26.239340 | TASK [add-build-sshkey : Add back temp key] 2025-09-18 03:01:26.547169 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8db38376f5434a30a70df5cbe7ceeedd/work/8db38376f5434a30a70df5cbe7ceeedd_id_rsa (zuul-build-sshkey) 2025-09-18 03:01:26.547391 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018110 2025-09-18 03:01:26.561385 | 2025-09-18 03:01:26.561485 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-18 03:01:26.924310 | debian-bookworm | ok 2025-09-18 03:01:26.928681 | 2025-09-18 03:01:26.928764 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-18 03:01:26.974519 | debian-bookworm | skipping: Conditional result was False 2025-09-18 03:01:26.984085 | 2025-09-18 03:01:26.984176 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-18 03:01:27.467735 | debian-bookworm | ok 2025-09-18 03:01:27.477823 | 2025-09-18 03:01:27.477914 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-18 03:01:27.518015 | debian-bookworm | ok 2025-09-18 03:01:27.525510 | 2025-09-18 03:01:27.525600 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-18 03:01:28.517463 | debian-bookworm -> localhost | ok 2025-09-18 03:01:28.522982 | 2025-09-18 03:01:28.523060 | TASK [validate-host : Collect information about the host] 2025-09-18 03:01:30.721714 | debian-bookworm | ok 2025-09-18 03:01:30.739269 | 2025-09-18 03:01:30.739439 | TASK [validate-host : Sanitize hostname] 2025-09-18 03:01:30.920600 | debian-bookworm | ok 2025-09-18 03:01:30.961865 | 2025-09-18 03:01:30.961971 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-18 03:01:32.825273 | debian-bookworm -> localhost | changed 2025-09-18 03:01:32.829973 | 2025-09-18 03:01:32.830054 | TASK [validate-host : Collect information about zuul worker] 2025-09-18 03:01:33.241458 | debian-bookworm | ok 2025-09-18 03:01:33.246447 | 2025-09-18 03:01:33.246535 | TASK [validate-host : Write out all zuul information for each host] 2025-09-18 03:01:34.667010 | debian-bookworm -> localhost | changed 2025-09-18 03:01:34.675435 | 2025-09-18 03:01:34.675514 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-18 03:01:35.004261 | debian-bookworm | ok 2025-09-18 03:01:35.008556 | 2025-09-18 03:01:35.008632 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-18 03:01:36.646644 | debian-bookworm | changed: 2025-09-18 03:01:36.646794 | debian-bookworm | cd+++++++++ src/ 2025-09-18 03:01:36.646822 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-18 03:01:36.646876 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-18 03:01:36.646896 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-09-18 03:01:36.646921 | debian-bookworm | localhost | ok: Runtime: 0:00:00.025204 2025-09-18 03:02:06.944903 | 2025-09-18 03:02:06.945031 | TASK [upload-logs : Upload logs to log server] 2025-09-18 03:02:08.452000 | localhost | Output suppressed because no_log was given 2025-09-18 03:02:08.453326 | 2025-09-18 03:02:08.453420 | LOOP [upload-logs : Compress console log and json output] 2025-09-18 03:02:08.553450 | localhost | skipping: Conditional result was False 2025-09-18 03:02:08.562686 | localhost | skipping: Conditional result was False 2025-09-18 03:02:08.571729 | 2025-09-18 03:02:08.571823 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-18 03:02:08.652942 | localhost | skipping: Conditional result was False 2025-09-18 03:02:08.653144 | 2025-09-18 03:02:08.667501 | localhost | skipping: Conditional result was False 2025-09-18 03:02:08.676764 | 2025-09-18 03:02:08.676854 | LOOP [upload-logs : Upload console log and json output]