2025-06-01 00:21:07.327242 | Job console starting 2025-06-01 00:21:07.358173 | Updating git repos 2025-06-01 00:21:07.424991 | Cloning repos into workspace 2025-06-01 00:21:07.475340 | Restoring repo states 2025-06-01 00:21:07.498898 | Merging changes 2025-06-01 00:21:08.048220 | Checking out repos 2025-06-01 00:21:08.086230 | Preparing playbooks 2025-06-01 00:21:09.128190 | Running Ansible setup 2025-06-01 00:21:14.428623 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-01 00:21:15.923336 | 2025-06-01 00:21:15.923524 | PLAY [Base pre] 2025-06-01 00:21:15.961915 | 2025-06-01 00:21:15.962146 | TASK [Setup log path fact] 2025-06-01 00:21:16.005786 | debian-bookworm | ok 2025-06-01 00:21:16.026918 | 2025-06-01 00:21:16.027110 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-01 00:21:16.058659 | debian-bookworm | ok 2025-06-01 00:21:16.072901 | 2025-06-01 00:21:16.073097 | TASK [emit-job-header : Print job information] 2025-06-01 00:21:16.115475 | # Job Information 2025-06-01 00:21:16.116300 | Ansible Version: 2.16.14 2025-06-01 00:21:16.116356 | Job: python-black 2025-06-01 00:21:16.116397 | Pipeline: check 2025-06-01 00:21:16.116426 | Executor: 521e9411259a 2025-06-01 00:21:16.116449 | Triggered by: https://github.com/osism/openstack-image-manager/pull/910 2025-06-01 00:21:16.116474 | Event ID: 4a7a0f00-3e7e-11f0-8080-925c3bb27ddf 2025-06-01 00:21:16.126396 | 2025-06-01 00:21:16.126538 | LOOP [emit-job-header : Print node information] 2025-06-01 00:21:16.263733 | debian-bookworm | ok: 2025-06-01 00:21:16.267221 | debian-bookworm | # Node Information 2025-06-01 00:21:16.267334 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-01 00:21:16.267364 | debian-bookworm | Hostname: debian 2025-06-01 00:21:16.267387 | debian-bookworm | Username: zuul 2025-06-01 00:21:16.267408 | debian-bookworm | Distro: Debian 12.11 2025-06-01 00:21:16.267436 | debian-bookworm | Provider: regiocloud-a 2025-06-01 00:21:16.267457 | debian-bookworm | Region: 2025-06-01 00:21:16.267479 | debian-bookworm | Label: debian-bookworm 2025-06-01 00:21:16.267499 | debian-bookworm | Product Name: OpenStack Nova 2025-06-01 00:21:16.267518 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe01:f461 2025-06-01 00:21:16.292093 | 2025-06-01 00:21:16.292343 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-01 00:21:17.311414 | debian-bookworm -> localhost | changed 2025-06-01 00:21:17.319654 | 2025-06-01 00:21:17.319775 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-01 00:21:19.021311 | debian-bookworm -> localhost | changed 2025-06-01 00:21:19.036782 | 2025-06-01 00:21:19.037097 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-01 00:21:19.436209 | debian-bookworm -> localhost | ok 2025-06-01 00:21:19.442527 | 2025-06-01 00:21:19.442626 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-01 00:21:19.470615 | debian-bookworm | ok 2025-06-01 00:21:19.499592 | debian-bookworm | included: /var/lib/zuul/builds/6cf48925ffaf40c59310c760f1aade27/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-01 00:21:19.515851 | 2025-06-01 00:21:19.515968 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-01 00:21:23.674228 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-01 00:21:23.674501 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6cf48925ffaf40c59310c760f1aade27/work/6cf48925ffaf40c59310c760f1aade27_id_rsa 2025-06-01 00:21:23.674548 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6cf48925ffaf40c59310c760f1aade27/work/6cf48925ffaf40c59310c760f1aade27_id_rsa.pub 2025-06-01 00:21:23.674579 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-01 00:21:23.674608 | debian-bookworm -> localhost | SHA256:6L/DovEmmljOvYqCBBHEfWbS8nBryfT2Dp4p5qEWaQ8 zuul-build-sshkey 2025-06-01 00:21:23.674634 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-01 00:21:23.674674 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-01 00:21:23.674700 | debian-bookworm -> localhost | |+o. . | 2025-06-01 00:21:23.674724 | debian-bookworm -> localhost | |.. = B | 2025-06-01 00:21:23.674748 | debian-bookworm -> localhost | | . % + | 2025-06-01 00:21:23.674770 | debian-bookworm -> localhost | |. * + | 2025-06-01 00:21:23.674792 | debian-bookworm -> localhost | |. o o S | 2025-06-01 00:21:23.674825 | debian-bookworm -> localhost | | . E . . . | 2025-06-01 00:21:23.675059 | debian-bookworm -> localhost | |o o =.o.= | 2025-06-01 00:21:23.675085 | debian-bookworm -> localhost | |o* +o*+=o. | 2025-06-01 00:21:23.675107 | debian-bookworm -> localhost | |+ B+**o.oo | 2025-06-01 00:21:23.675128 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-01 00:21:23.675190 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.466031 2025-06-01 00:21:23.681508 | 2025-06-01 00:21:23.681618 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-01 00:21:23.711762 | debian-bookworm | ok 2025-06-01 00:21:23.722343 | debian-bookworm | included: /var/lib/zuul/builds/6cf48925ffaf40c59310c760f1aade27/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-01 00:21:23.733413 | 2025-06-01 00:21:23.733519 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-01 00:21:23.758294 | debian-bookworm | skipping: Conditional result was False 2025-06-01 00:21:23.764433 | 2025-06-01 00:21:23.764541 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-01 00:21:24.494566 | debian-bookworm | changed 2025-06-01 00:21:24.499918 | 2025-06-01 00:21:24.500039 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-01 00:21:24.812552 | debian-bookworm | ok 2025-06-01 00:21:24.831410 | 2025-06-01 00:21:24.831979 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-01 00:21:25.588303 | debian-bookworm | changed 2025-06-01 00:21:25.596038 | 2025-06-01 00:21:25.596143 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-01 00:21:26.241233 | debian-bookworm | changed 2025-06-01 00:21:26.247184 | 2025-06-01 00:21:26.247303 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-01 00:21:26.309526 | debian-bookworm | skipping: Conditional result was False 2025-06-01 00:21:26.316437 | 2025-06-01 00:21:26.316584 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-01 00:21:27.422975 | debian-bookworm -> localhost | changed 2025-06-01 00:21:27.440268 | 2025-06-01 00:21:27.440427 | TASK [add-build-sshkey : Add back temp key] 2025-06-01 00:21:27.854197 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6cf48925ffaf40c59310c760f1aade27/work/6cf48925ffaf40c59310c760f1aade27_id_rsa (zuul-build-sshkey) 2025-06-01 00:21:27.855249 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014730 2025-06-01 00:21:27.868293 | 2025-06-01 00:21:27.869012 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-01 00:21:28.628075 | debian-bookworm | ok 2025-06-01 00:21:28.651759 | 2025-06-01 00:21:28.651985 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-01 00:21:28.748499 | debian-bookworm | skipping: Conditional result was False 2025-06-01 00:21:28.788883 | 2025-06-01 00:21:28.789089 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-01 00:21:29.366116 | debian-bookworm | ok 2025-06-01 00:21:29.398082 | 2025-06-01 00:21:29.398265 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-01 00:21:29.463454 | debian-bookworm | ok 2025-06-01 00:21:29.482025 | 2025-06-01 00:21:29.482775 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-01 00:21:30.467717 | debian-bookworm -> localhost | ok 2025-06-01 00:21:30.475706 | 2025-06-01 00:21:30.475847 | TASK [validate-host : Collect information about the host] 2025-06-01 00:21:31.704942 | debian-bookworm | ok 2025-06-01 00:21:31.722903 | 2025-06-01 00:21:31.723495 | TASK [validate-host : Sanitize hostname] 2025-06-01 00:21:31.877765 | debian-bookworm | ok 2025-06-01 00:21:32.044789 | 2025-06-01 00:21:32.044958 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-01 00:21:32.981509 | debian-bookworm -> localhost | changed 2025-06-01 00:21:32.987900 | 2025-06-01 00:21:32.988016 | TASK [validate-host : Collect information about zuul worker] 2025-06-01 00:21:33.532327 | debian-bookworm | ok 2025-06-01 00:21:33.537016 | 2025-06-01 00:21:33.537111 | TASK [validate-host : Write out all zuul information for each host] 2025-06-01 00:21:34.764263 | debian-bookworm -> localhost | changed 2025-06-01 00:21:34.773572 | 2025-06-01 00:21:34.781317 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-01 00:21:35.095746 | debian-bookworm | ok 2025-06-01 00:21:35.106325 | 2025-06-01 00:21:35.106432 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-01 00:21:36.048298 | debian-bookworm | changed: 2025-06-01 00:21:36.048550 | debian-bookworm | cd+++++++++ src/ 2025-06-01 00:21:36.048610 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-01 00:21:36.048638 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-01 00:21:36.048660 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-06-01 00:21:36.048681 | debian-bookworm | localhost | ok: Runtime: 0:00:00.020209 2025-06-01 00:22:01.899102 | 2025-06-01 00:22:01.899248 | TASK [upload-logs : Upload logs to log server] 2025-06-01 00:22:02.634682 | localhost | Output suppressed because no_log was given 2025-06-01 00:22:02.642499 | 2025-06-01 00:22:02.643573 | LOOP [upload-logs : Compress console log and json output] 2025-06-01 00:22:02.718284 | localhost | skipping: Conditional result was False 2025-06-01 00:22:02.730392 | localhost | skipping: Conditional result was False 2025-06-01 00:22:02.739534 | 2025-06-01 00:22:02.739673 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-01 00:22:02.800462 | localhost | skipping: Conditional result was False 2025-06-01 00:22:02.800775 | 2025-06-01 00:22:02.808059 | localhost | skipping: Conditional result was False 2025-06-01 00:22:02.818398 | 2025-06-01 00:22:02.818534 | LOOP [upload-logs : Upload console log and json output]