2025-09-16 03:01:04.908260 | Job console starting 2025-09-16 03:01:04.937181 | Updating git repos 2025-09-16 03:01:04.997836 | Cloning repos into workspace 2025-09-16 03:01:05.100847 | Restoring repo states 2025-09-16 03:01:05.168210 | Merging changes 2025-09-16 03:01:05.168231 | Checking out repos 2025-09-16 03:01:05.448113 | Preparing playbooks 2025-09-16 03:01:06.775347 | Running Ansible setup 2025-09-16 03:01:13.274621 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-16 03:01:14.831190 | 2025-09-16 03:01:14.831352 | PLAY [Base pre] 2025-09-16 03:01:14.864858 | 2025-09-16 03:01:14.864967 | TASK [Setup log path fact] 2025-09-16 03:01:14.913253 | debian-bookworm | ok 2025-09-16 03:01:14.938448 | 2025-09-16 03:01:14.938572 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-16 03:01:15.001434 | debian-bookworm | ok 2025-09-16 03:01:15.015846 | 2025-09-16 03:01:15.016002 | TASK [emit-job-header : Print job information] 2025-09-16 03:01:15.088164 | # Job Information 2025-09-16 03:01:15.088351 | Ansible Version: 2.16.14 2025-09-16 03:01:15.088383 | Job: python-black 2025-09-16 03:01:15.088411 | Pipeline: periodic-daily 2025-09-16 03:01:15.088430 | Executor: 521e9411259a 2025-09-16 03:01:15.088447 | Triggered by: https://github.com/osism/ansible-collection-services 2025-09-16 03:01:15.088464 | Event ID: d3bf34711f2c44fca7374cb9d1159e13 2025-09-16 03:01:15.103936 | 2025-09-16 03:01:15.104036 | LOOP [emit-job-header : Print node information] 2025-09-16 03:01:15.239634 | debian-bookworm | ok: 2025-09-16 03:01:15.239790 | debian-bookworm | # Node Information 2025-09-16 03:01:15.239823 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-16 03:01:15.239849 | debian-bookworm | Hostname: debian 2025-09-16 03:01:15.239871 | debian-bookworm | Username: zuul 2025-09-16 03:01:15.239892 | debian-bookworm | Distro: Debian 12.12 2025-09-16 03:01:15.239914 | debian-bookworm | Provider: regiocloud-a 2025-09-16 03:01:15.239935 | debian-bookworm | Region: 2025-09-16 03:01:15.239956 | debian-bookworm | Label: debian-bookworm 2025-09-16 03:01:15.239975 | debian-bookworm | Product Name: OpenStack Nova 2025-09-16 03:01:15.239994 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea0:47dc 2025-09-16 03:01:15.253806 | 2025-09-16 03:01:15.253906 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-16 03:01:15.967392 | debian-bookworm -> localhost | changed 2025-09-16 03:01:15.973118 | 2025-09-16 03:01:15.973208 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-16 03:01:17.123355 | debian-bookworm -> localhost | changed 2025-09-16 03:01:17.136902 | 2025-09-16 03:01:17.137010 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-16 03:01:17.328642 | debian-bookworm -> localhost | ok 2025-09-16 03:01:17.334706 | 2025-09-16 03:01:17.334809 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-16 03:01:17.351922 | debian-bookworm | ok 2025-09-16 03:01:17.369214 | debian-bookworm | included: /var/lib/zuul/builds/d0bd38d5ca1a43e5b186dce53c3cdb3a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-16 03:01:17.375198 | 2025-09-16 03:01:17.375285 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-16 03:01:20.170472 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-16 03:01:20.170655 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d0bd38d5ca1a43e5b186dce53c3cdb3a/work/d0bd38d5ca1a43e5b186dce53c3cdb3a_id_rsa 2025-09-16 03:01:20.170693 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d0bd38d5ca1a43e5b186dce53c3cdb3a/work/d0bd38d5ca1a43e5b186dce53c3cdb3a_id_rsa.pub 2025-09-16 03:01:20.170720 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-16 03:01:20.170746 | debian-bookworm -> localhost | SHA256:4etgjK9nJth7huJ4OqFZlV/XGIWMrJL5fzul0wiXwnc zuul-build-sshkey 2025-09-16 03:01:20.170768 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-16 03:01:20.170800 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-16 03:01:20.170822 | debian-bookworm -> localhost | | . o o. | 2025-09-16 03:01:20.170954 | debian-bookworm -> localhost | | o + | 2025-09-16 03:01:20.170978 | debian-bookworm -> localhost | | + .. + | 2025-09-16 03:01:20.170998 | debian-bookworm -> localhost | | * ....o . | 2025-09-16 03:01:20.171018 | debian-bookworm -> localhost | | . + oS. . | 2025-09-16 03:01:20.171041 | debian-bookworm -> localhost | |. . oo +.+ E | 2025-09-16 03:01:20.171061 | debian-bookworm -> localhost | |.+ o..+..= * | 2025-09-16 03:01:20.171080 | debian-bookworm -> localhost | |+.+ +o*o. * . | 2025-09-16 03:01:20.171100 | debian-bookworm -> localhost | |o=..oX. ...+ | 2025-09-16 03:01:20.171120 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-16 03:01:20.171170 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.252297 2025-09-16 03:01:20.177689 | 2025-09-16 03:01:20.177786 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-16 03:01:20.200509 | debian-bookworm | ok 2025-09-16 03:01:20.218515 | debian-bookworm | included: /var/lib/zuul/builds/d0bd38d5ca1a43e5b186dce53c3cdb3a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-16 03:01:20.236001 | 2025-09-16 03:01:20.236117 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-16 03:01:20.260565 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:01:20.269128 | 2025-09-16 03:01:20.269221 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-16 03:01:20.962012 | debian-bookworm | changed 2025-09-16 03:01:20.967878 | 2025-09-16 03:01:20.967985 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-16 03:01:21.248174 | debian-bookworm | ok 2025-09-16 03:01:21.256847 | 2025-09-16 03:01:21.257120 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-16 03:01:21.982716 | debian-bookworm | changed 2025-09-16 03:01:22.002181 | 2025-09-16 03:01:22.002447 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-16 03:01:22.733952 | debian-bookworm | changed 2025-09-16 03:01:22.748172 | 2025-09-16 03:01:22.748326 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-16 03:01:22.803096 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:01:22.818895 | 2025-09-16 03:01:22.819034 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-16 03:01:24.505110 | debian-bookworm -> localhost | changed 2025-09-16 03:01:24.535367 | 2025-09-16 03:01:24.542981 | TASK [add-build-sshkey : Add back temp key] 2025-09-16 03:01:25.815475 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d0bd38d5ca1a43e5b186dce53c3cdb3a/work/d0bd38d5ca1a43e5b186dce53c3cdb3a_id_rsa (zuul-build-sshkey) 2025-09-16 03:01:25.815659 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.023120 2025-09-16 03:01:25.822038 | 2025-09-16 03:01:25.822122 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-16 03:01:26.353765 | debian-bookworm | ok 2025-09-16 03:01:26.358112 | 2025-09-16 03:01:26.358201 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-16 03:01:26.370803 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:01:26.380058 | 2025-09-16 03:01:26.380148 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-16 03:01:26.766494 | debian-bookworm | ok 2025-09-16 03:01:26.784947 | 2025-09-16 03:01:26.785090 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-16 03:01:26.817889 | debian-bookworm | ok 2025-09-16 03:01:26.822796 | 2025-09-16 03:01:26.822922 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-16 03:01:27.060479 | debian-bookworm -> localhost | ok 2025-09-16 03:01:27.068144 | 2025-09-16 03:01:27.068248 | TASK [validate-host : Collect information about the host] 2025-09-16 03:01:28.396677 | debian-bookworm | ok 2025-09-16 03:01:28.406752 | 2025-09-16 03:01:28.423448 | TASK [validate-host : Sanitize hostname] 2025-09-16 03:01:28.613744 | debian-bookworm | ok 2025-09-16 03:01:28.695699 | 2025-09-16 03:01:28.695820 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-16 03:01:30.624326 | debian-bookworm -> localhost | changed 2025-09-16 03:01:30.630915 | 2025-09-16 03:01:30.631006 | TASK [validate-host : Collect information about zuul worker] 2025-09-16 03:01:31.059376 | debian-bookworm | ok 2025-09-16 03:01:31.072557 | 2025-09-16 03:01:31.073331 | TASK [validate-host : Write out all zuul information for each host] 2025-09-16 03:01:32.462219 | debian-bookworm -> localhost | changed 2025-09-16 03:01:32.479205 | 2025-09-16 03:01:32.479307 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-16 03:01:32.804253 | debian-bookworm | ok 2025-09-16 03:01:32.809737 | 2025-09-16 03:01:32.809838 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-16 03:01:35.026827 | debian-bookworm | changed: 2025-09-16 03:01:35.027005 | debian-bookworm | cd+++++++++ src/ 2025-09-16 03:01:35.027033 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-16 03:01:35.027053 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-16 03:01:35.027071 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-09-16 03:01:35.027088 | debian-bookworm | localhost | ok: Runtime: 0:00:00.003246 2025-09-16 03:02:06.060620 | 2025-09-16 03:02:06.060704 | TASK [upload-logs : Upload logs to log server] 2025-09-16 03:02:06.604213 | localhost | Output suppressed because no_log was given 2025-09-16 03:02:06.606166 | 2025-09-16 03:02:06.606250 | LOOP [upload-logs : Compress console log and json output] 2025-09-16 03:02:06.660503 | localhost | skipping: Conditional result was False 2025-09-16 03:02:06.667894 | localhost | skipping: Conditional result was False 2025-09-16 03:02:06.681789 | 2025-09-16 03:02:06.681895 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-16 03:02:06.797097 | localhost | skipping: Conditional result was False 2025-09-16 03:02:06.797297 | 2025-09-16 03:02:06.815028 | localhost | skipping: Conditional result was False 2025-09-16 03:02:06.818595 | 2025-09-16 03:02:06.818683 | LOOP [upload-logs : Upload console log and json output]