2025-10-15 07:04:04.059448 | Job console starting 2025-10-15 07:04:04.100005 | Updating git repos 2025-10-15 07:04:04.160510 | Cloning repos into workspace 2025-10-15 07:04:04.233125 | Restoring repo states 2025-10-15 07:04:04.264571 | Merging changes 2025-10-15 07:04:04.815622 | Checking out repos 2025-10-15 07:04:04.845826 | Preparing playbooks 2025-10-15 07:04:05.789470 | Running Ansible setup 2025-10-15 07:04:10.959333 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-15 07:04:12.328033 | 2025-10-15 07:04:12.328216 | PLAY [Base pre] 2025-10-15 07:04:12.344336 | 2025-10-15 07:04:12.344475 | TASK [Setup log path fact] 2025-10-15 07:04:12.384721 | debian-bookworm | ok 2025-10-15 07:04:12.410597 | 2025-10-15 07:04:12.410764 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-15 07:04:12.468305 | debian-bookworm | ok 2025-10-15 07:04:12.477714 | 2025-10-15 07:04:12.477818 | TASK [emit-job-header : Print job information] 2025-10-15 07:04:12.524210 | # Job Information 2025-10-15 07:04:12.524367 | Ansible Version: 2.16.14 2025-10-15 07:04:12.524401 | Job: python-black 2025-10-15 07:04:12.524434 | Pipeline: check 2025-10-15 07:04:12.524457 | Executor: 521e9411259a 2025-10-15 07:04:12.524477 | Triggered by: https://github.com/osism/openstack-image-manager/pull/960 2025-10-15 07:04:12.524499 | Event ID: 1d123880-a995-11f0-81e2-6154fbf9a0f7 2025-10-15 07:04:12.529280 | 2025-10-15 07:04:12.529379 | LOOP [emit-job-header : Print node information] 2025-10-15 07:04:12.641198 | debian-bookworm | ok: 2025-10-15 07:04:12.641427 | debian-bookworm | # Node Information 2025-10-15 07:04:12.641465 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-15 07:04:12.641490 | debian-bookworm | Hostname: debian 2025-10-15 07:04:12.641513 | debian-bookworm | Username: zuul 2025-10-15 07:04:12.641534 | debian-bookworm | Distro: Debian 12.12 2025-10-15 07:04:12.641557 | debian-bookworm | Provider: regiocloud-a 2025-10-15 07:04:12.641578 | debian-bookworm | Region: 2025-10-15 07:04:12.641600 | debian-bookworm | Label: debian-bookworm 2025-10-15 07:04:12.641619 | debian-bookworm | Product Name: OpenStack Nova 2025-10-15 07:04:12.641639 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9b:73fc 2025-10-15 07:04:12.662260 | 2025-10-15 07:04:12.662376 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-15 07:04:13.239679 | debian-bookworm -> localhost | changed 2025-10-15 07:04:13.246379 | 2025-10-15 07:04:13.246472 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-15 07:04:14.757264 | debian-bookworm -> localhost | changed 2025-10-15 07:04:14.765725 | 2025-10-15 07:04:14.765818 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-15 07:04:15.147958 | debian-bookworm -> localhost | ok 2025-10-15 07:04:15.152749 | 2025-10-15 07:04:15.152832 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-15 07:04:15.189619 | debian-bookworm | ok 2025-10-15 07:04:15.213098 | debian-bookworm | included: /var/lib/zuul/builds/2dc82bdcc1fd42bcace043560bcd4074/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-15 07:04:15.217882 | 2025-10-15 07:04:15.217956 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-15 07:04:16.755371 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-15 07:04:16.755548 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2dc82bdcc1fd42bcace043560bcd4074/work/2dc82bdcc1fd42bcace043560bcd4074_id_rsa 2025-10-15 07:04:16.755581 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2dc82bdcc1fd42bcace043560bcd4074/work/2dc82bdcc1fd42bcace043560bcd4074_id_rsa.pub 2025-10-15 07:04:16.755603 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-15 07:04:16.755625 | debian-bookworm -> localhost | SHA256:Imy/hCjVY2jwl8iryMoJFxa3Kedc+kqn4LNrki6X9s8 zuul-build-sshkey 2025-10-15 07:04:16.755644 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-15 07:04:16.755669 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-15 07:04:16.755689 | debian-bookworm -> localhost | | | 2025-10-15 07:04:16.755708 | debian-bookworm -> localhost | | | 2025-10-15 07:04:16.755726 | debian-bookworm -> localhost | |. . . | 2025-10-15 07:04:16.755744 | debian-bookworm -> localhost | | + B + | 2025-10-15 07:04:16.755762 | debian-bookworm -> localhost | | @ & o S | 2025-10-15 07:04:16.755786 | debian-bookworm -> localhost | | + % B . | 2025-10-15 07:04:16.755805 | debian-bookworm -> localhost | |o.=.* + | 2025-10-15 07:04:16.755823 | debian-bookworm -> localhost | |O=Bo * . | 2025-10-15 07:04:16.755842 | debian-bookworm -> localhost | |BX+=+oE | 2025-10-15 07:04:16.755860 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-15 07:04:16.755903 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.922888 2025-10-15 07:04:16.760871 | 2025-10-15 07:04:16.760954 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-15 07:04:16.777725 | debian-bookworm | ok 2025-10-15 07:04:16.784842 | debian-bookworm | included: /var/lib/zuul/builds/2dc82bdcc1fd42bcace043560bcd4074/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-15 07:04:16.792000 | 2025-10-15 07:04:16.792095 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-15 07:04:16.804436 | debian-bookworm | skipping: Conditional result was False 2025-10-15 07:04:16.809140 | 2025-10-15 07:04:16.809213 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-15 07:04:17.441069 | debian-bookworm | changed 2025-10-15 07:04:17.446743 | 2025-10-15 07:04:17.446850 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-15 07:04:17.708857 | debian-bookworm | ok 2025-10-15 07:04:17.715102 | 2025-10-15 07:04:17.715192 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-15 07:04:18.351126 | debian-bookworm | changed 2025-10-15 07:04:18.357577 | 2025-10-15 07:04:18.357668 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-15 07:04:18.940065 | debian-bookworm | changed 2025-10-15 07:04:18.945444 | 2025-10-15 07:04:18.945530 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-15 07:04:18.968439 | debian-bookworm | skipping: Conditional result was False 2025-10-15 07:04:18.973981 | 2025-10-15 07:04:18.974082 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-15 07:04:19.376665 | debian-bookworm -> localhost | changed 2025-10-15 07:04:19.389625 | 2025-10-15 07:04:19.389842 | TASK [add-build-sshkey : Add back temp key] 2025-10-15 07:04:20.002692 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2dc82bdcc1fd42bcace043560bcd4074/work/2dc82bdcc1fd42bcace043560bcd4074_id_rsa (zuul-build-sshkey) 2025-10-15 07:04:20.002919 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009212 2025-10-15 07:04:20.010205 | 2025-10-15 07:04:20.010298 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-15 07:04:20.401729 | debian-bookworm | ok 2025-10-15 07:04:20.406505 | 2025-10-15 07:04:20.406590 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-15 07:04:20.430209 | debian-bookworm | skipping: Conditional result was False 2025-10-15 07:04:20.440246 | 2025-10-15 07:04:20.440333 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-15 07:04:20.856492 | debian-bookworm | ok 2025-10-15 07:04:20.877842 | 2025-10-15 07:04:20.877956 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-15 07:04:20.915280 | debian-bookworm | ok 2025-10-15 07:04:20.931995 | 2025-10-15 07:04:20.932104 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-15 07:04:21.316462 | debian-bookworm -> localhost | ok 2025-10-15 07:04:21.328848 | 2025-10-15 07:04:21.329101 | TASK [validate-host : Collect information about the host] 2025-10-15 07:04:22.440371 | debian-bookworm | ok 2025-10-15 07:04:22.451887 | 2025-10-15 07:04:22.451971 | TASK [validate-host : Sanitize hostname] 2025-10-15 07:04:22.563832 | debian-bookworm | ok 2025-10-15 07:04:22.604827 | 2025-10-15 07:04:22.604917 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-15 07:04:23.254887 | debian-bookworm -> localhost | changed 2025-10-15 07:04:23.259522 | 2025-10-15 07:04:23.259602 | TASK [validate-host : Collect information about zuul worker] 2025-10-15 07:04:23.655667 | debian-bookworm | ok 2025-10-15 07:04:23.664018 | 2025-10-15 07:04:23.665858 | TASK [validate-host : Write out all zuul information for each host] 2025-10-15 07:04:24.737940 | debian-bookworm -> localhost | changed 2025-10-15 07:04:24.753189 | 2025-10-15 07:04:24.753292 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-15 07:04:25.032789 | debian-bookworm | ok 2025-10-15 07:04:25.041146 | 2025-10-15 07:04:25.041233 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-15 07:04:26.326543 | debian-bookworm | changed: 2025-10-15 07:04:26.326691 | debian-bookworm | cd+++++++++ src/ 2025-10-15 07:04:26.326719 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-15 07:04:26.326739 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-15 07:04:26.326757 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-10-15 07:04:26.326773 | debian-bookworm | localhost | ok: Runtime: 0:00:00.011383 2025-10-15 07:04:53.894664 | 2025-10-15 07:04:53.894780 | TASK [upload-logs : Upload logs to log server] 2025-10-15 07:04:54.500771 | localhost | Output suppressed because no_log was given 2025-10-15 07:04:54.502695 | 2025-10-15 07:04:54.502798 | LOOP [upload-logs : Compress console log and json output] 2025-10-15 07:04:54.566322 | localhost | skipping: Conditional result was False 2025-10-15 07:04:54.572313 | localhost | skipping: Conditional result was False 2025-10-15 07:04:54.580781 | 2025-10-15 07:04:54.580904 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-15 07:04:54.640329 | localhost | skipping: Conditional result was False 2025-10-15 07:04:54.640709 | 2025-10-15 07:04:54.646161 | localhost | skipping: Conditional result was False 2025-10-15 07:04:54.657393 | 2025-10-15 07:04:54.657968 | LOOP [upload-logs : Upload console log and json output]