2025-05-21 03:50:48.502400 | Job console starting 2025-05-21 03:50:48.546529 | Updating git repos 2025-05-21 03:50:48.621697 | Cloning repos into workspace 2025-05-21 03:50:48.708732 | Restoring repo states 2025-05-21 03:50:48.728924 | Merging changes 2025-05-21 03:50:49.680309 | Checking out repos 2025-05-21 03:50:49.743395 | Preparing playbooks 2025-05-21 03:50:50.841910 | Running Ansible setup 2025-05-21 03:50:58.166937 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-21 03:50:58.945740 | 2025-05-21 03:50:58.945850 | PLAY [Base pre] 2025-05-21 03:50:58.959046 | 2025-05-21 03:50:58.959143 | TASK [Setup log path fact] 2025-05-21 03:50:58.996018 | debian-bookworm | ok 2025-05-21 03:50:59.020256 | 2025-05-21 03:50:59.020403 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-21 03:50:59.058433 | debian-bookworm | ok 2025-05-21 03:50:59.079010 | 2025-05-21 03:50:59.079115 | TASK [emit-job-header : Print job information] 2025-05-21 03:50:59.136180 | # Job Information 2025-05-21 03:50:59.136315 | Ansible Version: 2.16.14 2025-05-21 03:50:59.136363 | Job: python-black 2025-05-21 03:50:59.136391 | Pipeline: check 2025-05-21 03:50:59.136409 | Executor: 521e9411259a 2025-05-21 03:50:59.136427 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/736 2025-05-21 03:50:59.136445 | Event ID: 9c24f4e0-35f6-11f0-804f-51d876e129df 2025-05-21 03:50:59.140276 | 2025-05-21 03:50:59.140362 | LOOP [emit-job-header : Print node information] 2025-05-21 03:50:59.336562 | debian-bookworm | ok: 2025-05-21 03:50:59.336784 | debian-bookworm | # Node Information 2025-05-21 03:50:59.336816 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-21 03:50:59.336838 | debian-bookworm | Hostname: debian 2025-05-21 03:50:59.336856 | debian-bookworm | Username: zuul 2025-05-21 03:50:59.336873 | debian-bookworm | Distro: Debian 12.11 2025-05-21 03:50:59.336898 | debian-bookworm | Provider: regiocloud-a 2025-05-21 03:50:59.336919 | debian-bookworm | Region: 2025-05-21 03:50:59.336936 | debian-bookworm | Label: debian-bookworm 2025-05-21 03:50:59.336952 | debian-bookworm | Product Name: OpenStack Nova 2025-05-21 03:50:59.336968 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec8:fa58 2025-05-21 03:50:59.353497 | 2025-05-21 03:50:59.353596 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-21 03:51:00.143668 | debian-bookworm -> localhost | changed 2025-05-21 03:51:00.149285 | 2025-05-21 03:51:00.149386 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-21 03:51:02.280881 | debian-bookworm -> localhost | changed 2025-05-21 03:51:02.315307 | 2025-05-21 03:51:02.315462 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-21 03:51:03.178826 | debian-bookworm -> localhost | ok 2025-05-21 03:51:03.198162 | 2025-05-21 03:51:03.198278 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-21 03:51:03.263811 | debian-bookworm | ok 2025-05-21 03:51:03.301973 | debian-bookworm | included: /var/lib/zuul/builds/f175dcfa67554fe2a5d2fd433f4519c2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-21 03:51:03.309721 | 2025-05-21 03:51:03.309929 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-21 03:51:06.073409 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-21 03:51:06.073617 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f175dcfa67554fe2a5d2fd433f4519c2/work/f175dcfa67554fe2a5d2fd433f4519c2_id_rsa 2025-05-21 03:51:06.073659 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f175dcfa67554fe2a5d2fd433f4519c2/work/f175dcfa67554fe2a5d2fd433f4519c2_id_rsa.pub 2025-05-21 03:51:06.073689 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-21 03:51:06.073716 | debian-bookworm -> localhost | SHA256:ZNkwbqxAtIX9FwC+XFPvT9sCyQN40NYgW1qYqGlqMfs zuul-build-sshkey 2025-05-21 03:51:06.073741 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-21 03:51:06.073773 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-21 03:51:06.073796 | debian-bookworm -> localhost | | .oooo*==o | 2025-05-21 03:51:06.073818 | debian-bookworm -> localhost | | ..+ooo#+.. | 2025-05-21 03:51:06.073839 | debian-bookworm -> localhost | | oo..&.+.. | 2025-05-21 03:51:06.073860 | debian-bookworm -> localhost | | o +o B.o.+ . | 2025-05-21 03:51:06.073904 | debian-bookworm -> localhost | | * + S. * . | 2025-05-21 03:51:06.073932 | debian-bookworm -> localhost | | + = o | 2025-05-21 03:51:06.073953 | debian-bookworm -> localhost | | . . + .| 2025-05-21 03:51:06.073973 | debian-bookworm -> localhost | | E . | 2025-05-21 03:51:06.073995 | debian-bookworm -> localhost | | | 2025-05-21 03:51:06.074171 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-21 03:51:06.074573 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.042059 2025-05-21 03:51:06.082472 | 2025-05-21 03:51:06.082602 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-21 03:51:06.127254 | debian-bookworm | ok 2025-05-21 03:51:06.160215 | debian-bookworm | included: /var/lib/zuul/builds/f175dcfa67554fe2a5d2fd433f4519c2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-21 03:51:06.172579 | 2025-05-21 03:51:06.172670 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-21 03:51:06.223552 | debian-bookworm | skipping: Conditional result was False 2025-05-21 03:51:06.235933 | 2025-05-21 03:51:06.236029 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-21 03:51:07.095833 | debian-bookworm | changed 2025-05-21 03:51:07.105033 | 2025-05-21 03:51:07.105143 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-21 03:51:07.365882 | debian-bookworm | ok 2025-05-21 03:51:07.371318 | 2025-05-21 03:51:07.371428 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-21 03:51:08.057669 | debian-bookworm | changed 2025-05-21 03:51:08.065077 | 2025-05-21 03:51:08.065180 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-21 03:51:08.710455 | debian-bookworm | changed 2025-05-21 03:51:08.717681 | 2025-05-21 03:51:08.717783 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-21 03:51:08.770639 | debian-bookworm | skipping: Conditional result was False 2025-05-21 03:51:08.785486 | 2025-05-21 03:51:08.786003 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-21 03:51:09.488938 | debian-bookworm -> localhost | changed 2025-05-21 03:51:09.501636 | 2025-05-21 03:51:09.501738 | TASK [add-build-sshkey : Add back temp key] 2025-05-21 03:51:09.891287 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f175dcfa67554fe2a5d2fd433f4519c2/work/f175dcfa67554fe2a5d2fd433f4519c2_id_rsa (zuul-build-sshkey) 2025-05-21 03:51:09.891514 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012210 2025-05-21 03:51:09.899158 | 2025-05-21 03:51:09.899262 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-21 03:51:10.337219 | debian-bookworm | ok 2025-05-21 03:51:10.345751 | 2025-05-21 03:51:10.345846 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-21 03:51:10.390430 | debian-bookworm | skipping: Conditional result was False 2025-05-21 03:51:10.399803 | 2025-05-21 03:51:10.399892 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-21 03:51:10.897916 | debian-bookworm | ok 2025-05-21 03:51:10.912580 | 2025-05-21 03:51:10.912677 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-21 03:51:10.972385 | debian-bookworm | ok 2025-05-21 03:51:10.976437 | 2025-05-21 03:51:10.976519 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-21 03:51:11.303438 | debian-bookworm -> localhost | ok 2025-05-21 03:51:11.309407 | 2025-05-21 03:51:11.309494 | TASK [validate-host : Collect information about the host] 2025-05-21 03:51:12.430459 | debian-bookworm | ok 2025-05-21 03:51:12.439210 | 2025-05-21 03:51:12.439295 | TASK [validate-host : Sanitize hostname] 2025-05-21 03:51:12.583139 | debian-bookworm | ok 2025-05-21 03:51:12.660394 | 2025-05-21 03:51:12.660501 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-21 03:51:13.468204 | debian-bookworm -> localhost | changed 2025-05-21 03:51:13.473887 | 2025-05-21 03:51:13.473982 | TASK [validate-host : Collect information about zuul worker] 2025-05-21 03:51:13.910801 | debian-bookworm | ok 2025-05-21 03:51:13.915786 | 2025-05-21 03:51:13.915883 | TASK [validate-host : Write out all zuul information for each host] 2025-05-21 03:51:14.451736 | debian-bookworm -> localhost | changed 2025-05-21 03:51:14.464220 | 2025-05-21 03:51:14.464316 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-21 03:51:14.717197 | debian-bookworm | ok 2025-05-21 03:51:14.725450 | 2025-05-21 03:51:14.725547 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-21 03:51:15.752534 | debian-bookworm | changed: 2025-05-21 03:51:15.752725 | debian-bookworm | cd+++++++++ src/ 2025-05-21 03:51:15.752760 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-21 03:51:15.752785 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-21 03:51:15.752807 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-05-21 03:51:15.752835 | debian-bookworm | Containerfile 2025-05-21 03:51:15.752969 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006285 2025-05-21 03:51:44.060042 | 2025-05-21 03:51:44.060159 | TASK [upload-logs : Upload logs to log server] 2025-05-21 03:51:44.955056 | localhost | Output suppressed because no_log was given 2025-05-21 03:51:44.957709 | 2025-05-21 03:51:44.957837 | LOOP [upload-logs : Compress console log and json output] 2025-05-21 03:51:45.030663 | localhost | skipping: Conditional result was False 2025-05-21 03:51:45.040987 | localhost | skipping: Conditional result was False 2025-05-21 03:51:45.050912 | 2025-05-21 03:51:45.051047 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-21 03:51:45.116154 | localhost | skipping: Conditional result was False 2025-05-21 03:51:45.116478 | 2025-05-21 03:51:45.125225 | localhost | skipping: Conditional result was False 2025-05-21 03:51:45.140700 | 2025-05-21 03:51:45.140880 | LOOP [upload-logs : Upload console log and json output]