2025-08-03 00:21:54.818938 | Job console starting 2025-08-03 00:21:54.831933 | Updating git repos 2025-08-03 00:21:54.862517 | Cloning repos into workspace 2025-08-03 00:21:54.894010 | Restoring repo states 2025-08-03 00:21:54.901042 | Merging changes 2025-08-03 00:21:55.518721 | Checking out repos 2025-08-03 00:21:55.571988 | Preparing playbooks 2025-08-03 00:21:57.096490 | Running Ansible setup 2025-08-03 00:22:03.315258 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-03 00:22:05.832063 | 2025-08-03 00:22:05.832215 | PLAY [Base pre] 2025-08-03 00:22:05.862978 | 2025-08-03 00:22:05.863107 | TASK [Setup log path fact] 2025-08-03 00:22:05.907239 | debian-bookworm | ok 2025-08-03 00:22:05.941012 | 2025-08-03 00:22:05.941150 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-03 00:22:05.984403 | debian-bookworm | ok 2025-08-03 00:22:06.005327 | 2025-08-03 00:22:06.005454 | TASK [emit-job-header : Print job information] 2025-08-03 00:22:06.079676 | # Job Information 2025-08-03 00:22:06.079849 | Ansible Version: 2.16.14 2025-08-03 00:22:06.079884 | Job: python-black 2025-08-03 00:22:06.079918 | Pipeline: check 2025-08-03 00:22:06.079941 | Executor: 521e9411259a 2025-08-03 00:22:06.079962 | Triggered by: https://github.com/osism/openstack-image-manager/pull/936 2025-08-03 00:22:06.079984 | Event ID: cb930940-6fff-11f0-866d-8d980a825b53 2025-08-03 00:22:06.084930 | 2025-08-03 00:22:06.085024 | LOOP [emit-job-header : Print node information] 2025-08-03 00:22:06.341494 | debian-bookworm | ok: 2025-08-03 00:22:06.341649 | debian-bookworm | # Node Information 2025-08-03 00:22:06.341680 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-03 00:22:06.341702 | debian-bookworm | Hostname: debian 2025-08-03 00:22:06.341720 | debian-bookworm | Username: zuul 2025-08-03 00:22:06.341738 | debian-bookworm | Distro: Debian 12.11 2025-08-03 00:22:06.341757 | debian-bookworm | Provider: regiocloud-a 2025-08-03 00:22:06.341775 | debian-bookworm | Region: 2025-08-03 00:22:06.341792 | debian-bookworm | Label: debian-bookworm 2025-08-03 00:22:06.341809 | debian-bookworm | Product Name: OpenStack Nova 2025-08-03 00:22:06.341825 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe37:7924 2025-08-03 00:22:06.360464 | 2025-08-03 00:22:06.360577 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-03 00:22:07.473119 | debian-bookworm -> localhost | changed 2025-08-03 00:22:07.481765 | 2025-08-03 00:22:07.481861 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-03 00:22:09.974600 | debian-bookworm -> localhost | changed 2025-08-03 00:22:09.983016 | 2025-08-03 00:22:09.983099 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-03 00:22:10.977532 | debian-bookworm -> localhost | ok 2025-08-03 00:22:10.982953 | 2025-08-03 00:22:10.983046 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-03 00:22:11.060093 | debian-bookworm | ok 2025-08-03 00:22:11.096476 | debian-bookworm | included: /var/lib/zuul/builds/c933e1675b91429d9324d5157738e97b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-03 00:22:11.117627 | 2025-08-03 00:22:11.117717 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-03 00:22:13.069440 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-03 00:22:13.069609 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c933e1675b91429d9324d5157738e97b/work/c933e1675b91429d9324d5157738e97b_id_rsa 2025-08-03 00:22:13.069646 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c933e1675b91429d9324d5157738e97b/work/c933e1675b91429d9324d5157738e97b_id_rsa.pub 2025-08-03 00:22:13.069669 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-03 00:22:13.069690 | debian-bookworm -> localhost | SHA256:KRpIXNEVQj5FNsJMEcvuLuSdVgzV1oz+U17/qb5+Pis zuul-build-sshkey 2025-08-03 00:22:13.069710 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-03 00:22:13.069736 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-03 00:22:13.069755 | debian-bookworm -> localhost | | oBB=Bo + | 2025-08-03 00:22:13.069774 | debian-bookworm -> localhost | | . . o+*..+ o | 2025-08-03 00:22:13.069791 | debian-bookworm -> localhost | | o =. o | 2025-08-03 00:22:13.069808 | debian-bookworm -> localhost | | . . ... .. . .| 2025-08-03 00:22:13.069825 | debian-bookworm -> localhost | | . . ooS . o ..| 2025-08-03 00:22:13.069847 | debian-bookworm -> localhost | | .+ .o o . .| 2025-08-03 00:22:13.069864 | debian-bookworm -> localhost | | o...o . o| 2025-08-03 00:22:13.069880 | debian-bookworm -> localhost | | o.+ E +.| 2025-08-03 00:22:13.069898 | debian-bookworm -> localhost | | o. o=*oo| 2025-08-03 00:22:13.069916 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-03 00:22:13.069960 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.450317 2025-08-03 00:22:13.077087 | 2025-08-03 00:22:13.077192 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-03 00:22:13.126085 | debian-bookworm | ok 2025-08-03 00:22:13.134101 | debian-bookworm | included: /var/lib/zuul/builds/c933e1675b91429d9324d5157738e97b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-03 00:22:13.158631 | 2025-08-03 00:22:13.158726 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-03 00:22:13.196507 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:22:13.201484 | 2025-08-03 00:22:13.201583 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-03 00:22:14.094078 | debian-bookworm | changed 2025-08-03 00:22:14.100793 | 2025-08-03 00:22:14.100880 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-03 00:22:14.399345 | debian-bookworm | ok 2025-08-03 00:22:14.405355 | 2025-08-03 00:22:14.405447 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-03 00:22:15.152343 | debian-bookworm | changed 2025-08-03 00:22:15.158013 | 2025-08-03 00:22:15.158112 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-03 00:22:15.941322 | debian-bookworm | changed 2025-08-03 00:22:15.945907 | 2025-08-03 00:22:15.945988 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-03 00:22:15.996858 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:22:16.002122 | 2025-08-03 00:22:16.002234 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-03 00:22:17.073533 | debian-bookworm -> localhost | changed 2025-08-03 00:22:17.083069 | 2025-08-03 00:22:17.083165 | TASK [add-build-sshkey : Add back temp key] 2025-08-03 00:22:17.917008 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c933e1675b91429d9324d5157738e97b/work/c933e1675b91429d9324d5157738e97b_id_rsa (zuul-build-sshkey) 2025-08-03 00:22:17.917213 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025938 2025-08-03 00:22:17.924026 | 2025-08-03 00:22:17.924116 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-03 00:22:18.697536 | debian-bookworm | ok 2025-08-03 00:22:18.701928 | 2025-08-03 00:22:18.702011 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-03 00:22:18.771167 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:22:18.791592 | 2025-08-03 00:22:18.791689 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-03 00:22:19.468554 | debian-bookworm | ok 2025-08-03 00:22:19.478676 | 2025-08-03 00:22:19.478774 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-03 00:22:19.537114 | debian-bookworm | ok 2025-08-03 00:22:19.541472 | 2025-08-03 00:22:19.541557 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-03 00:22:20.456577 | debian-bookworm -> localhost | ok 2025-08-03 00:22:20.464667 | 2025-08-03 00:22:20.464758 | TASK [validate-host : Collect information about the host] 2025-08-03 00:22:22.656728 | debian-bookworm | ok 2025-08-03 00:22:22.688470 | 2025-08-03 00:22:22.704838 | TASK [validate-host : Sanitize hostname] 2025-08-03 00:22:22.938554 | debian-bookworm | ok 2025-08-03 00:22:23.012235 | 2025-08-03 00:22:23.012349 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-03 00:22:24.041269 | debian-bookworm -> localhost | changed 2025-08-03 00:22:24.053002 | 2025-08-03 00:22:24.053095 | TASK [validate-host : Collect information about zuul worker] 2025-08-03 00:22:24.488972 | debian-bookworm | ok 2025-08-03 00:22:24.492796 | 2025-08-03 00:22:24.492884 | TASK [validate-host : Write out all zuul information for each host] 2025-08-03 00:22:26.151988 | debian-bookworm -> localhost | changed 2025-08-03 00:22:26.159884 | 2025-08-03 00:22:26.159970 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-03 00:22:26.527714 | debian-bookworm | ok 2025-08-03 00:22:26.532791 | 2025-08-03 00:22:26.532881 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-03 00:22:28.002349 | debian-bookworm | changed: 2025-08-03 00:22:28.002510 | debian-bookworm | cd+++++++++ src/ 2025-08-03 00:22:28.002543 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-03 00:22:28.002564 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-03 00:22:28.002583 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-08-03 00:22:28.002600 | debian-bookworm | localhost | ok: Runtime: 0:00:00.036219 2025-08-03 00:22:57.692160 | 2025-08-03 00:22:57.692251 | TASK [upload-logs : Upload logs to log server] 2025-08-03 00:22:59.097654 | localhost | Output suppressed because no_log was given 2025-08-03 00:22:59.099095 | 2025-08-03 00:22:59.099170 | LOOP [upload-logs : Compress console log and json output] 2025-08-03 00:22:59.170057 | localhost | skipping: Conditional result was False 2025-08-03 00:22:59.180127 | localhost | skipping: Conditional result was False 2025-08-03 00:22:59.186969 | 2025-08-03 00:22:59.187083 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-03 00:22:59.297508 | localhost | skipping: Conditional result was False 2025-08-03 00:22:59.297742 | 2025-08-03 00:22:59.314454 | localhost | skipping: Conditional result was False 2025-08-03 00:22:59.327672 | 2025-08-03 00:22:59.327775 | LOOP [upload-logs : Upload console log and json output]