2025-08-07 11:58:13.221188 | Job console starting 2025-08-07 11:58:13.249422 | Updating git repos 2025-08-07 11:58:13.307887 | Cloning repos into workspace 2025-08-07 11:58:13.387243 | Restoring repo states 2025-08-07 11:58:13.403187 | Merging changes 2025-08-07 11:58:13.909736 | Checking out repos 2025-08-07 11:58:13.961371 | Preparing playbooks 2025-08-07 11:58:14.756762 | Running Ansible setup 2025-08-07 11:58:20.078396 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-07 11:58:21.268638 | 2025-08-07 11:58:21.268808 | PLAY [Base pre] 2025-08-07 11:58:21.285274 | 2025-08-07 11:58:21.285420 | TASK [Setup log path fact] 2025-08-07 11:58:21.316898 | debian-bookworm | ok 2025-08-07 11:58:21.334218 | 2025-08-07 11:58:21.334394 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-07 11:58:21.364549 | debian-bookworm | ok 2025-08-07 11:58:21.380591 | 2025-08-07 11:58:21.380724 | TASK [emit-job-header : Print job information] 2025-08-07 11:58:21.422870 | # Job Information 2025-08-07 11:58:21.423057 | Ansible Version: 2.16.14 2025-08-07 11:58:21.423125 | Job: python-black 2025-08-07 11:58:21.423159 | Pipeline: check 2025-08-07 11:58:21.423182 | Executor: 521e9411259a 2025-08-07 11:58:21.423202 | Triggered by: https://github.com/osism/python-osism/pull/1620 2025-08-07 11:58:21.423224 | Event ID: c6122d50-7385-11f0-8609-4d50c497923c 2025-08-07 11:58:21.431455 | 2025-08-07 11:58:21.431591 | LOOP [emit-job-header : Print node information] 2025-08-07 11:58:21.625377 | debian-bookworm | ok: 2025-08-07 11:58:21.625625 | debian-bookworm | # Node Information 2025-08-07 11:58:21.625661 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-07 11:58:21.625687 | debian-bookworm | Hostname: debian 2025-08-07 11:58:21.625710 | debian-bookworm | Username: zuul 2025-08-07 11:58:21.625732 | debian-bookworm | Distro: Debian 12.11 2025-08-07 11:58:21.625756 | debian-bookworm | Provider: regiocloud-a 2025-08-07 11:58:21.625777 | debian-bookworm | Region: 2025-08-07 11:58:21.625799 | debian-bookworm | Label: debian-bookworm 2025-08-07 11:58:21.625819 | debian-bookworm | Product Name: OpenStack Nova 2025-08-07 11:58:21.625839 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe19:37f0 2025-08-07 11:58:21.652505 | 2025-08-07 11:58:21.652655 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-07 11:58:22.410614 | debian-bookworm -> localhost | changed 2025-08-07 11:58:22.418378 | 2025-08-07 11:58:22.418508 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-07 11:58:23.922932 | debian-bookworm -> localhost | changed 2025-08-07 11:58:23.938606 | 2025-08-07 11:58:23.938740 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-07 11:58:24.270149 | debian-bookworm -> localhost | ok 2025-08-07 11:58:24.276619 | 2025-08-07 11:58:24.276739 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-07 11:58:24.315946 | debian-bookworm | ok 2025-08-07 11:58:24.357283 | debian-bookworm | included: /var/lib/zuul/builds/7e6d2078b01540209d9c18535c0ec1f2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-07 11:58:24.377187 | 2025-08-07 11:58:24.377324 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-07 11:58:26.053728 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-07 11:58:26.053904 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7e6d2078b01540209d9c18535c0ec1f2/work/7e6d2078b01540209d9c18535c0ec1f2_id_rsa 2025-08-07 11:58:26.053940 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7e6d2078b01540209d9c18535c0ec1f2/work/7e6d2078b01540209d9c18535c0ec1f2_id_rsa.pub 2025-08-07 11:58:26.053962 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-07 11:58:26.053982 | debian-bookworm -> localhost | SHA256:MZXcqyXkGLhqDPOgKKopjUcMcRS6YWUfr0gEmbzDRqI zuul-build-sshkey 2025-08-07 11:58:26.054000 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-07 11:58:26.054026 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-07 11:58:26.054044 | debian-bookworm -> localhost | |.o*= . . ..o | 2025-08-07 11:58:26.054082 | debian-bookworm -> localhost | |o*= . + ..+ . | 2025-08-07 11:58:26.054102 | debian-bookworm -> localhost | |B+.. . oo= . | 2025-08-07 11:58:26.054119 | debian-bookworm -> localhost | |EB= . o .oo o | 2025-08-07 11:58:26.054135 | debian-bookworm -> localhost | |++.B o S + | 2025-08-07 11:58:26.054156 | debian-bookworm -> localhost | |+ o = . | 2025-08-07 11:58:26.054173 | debian-bookworm -> localhost | |o+ . | 2025-08-07 11:58:26.054189 | debian-bookworm -> localhost | |+.o | 2025-08-07 11:58:26.054206 | debian-bookworm -> localhost | |=. | 2025-08-07 11:58:26.054223 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-07 11:58:26.054263 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.933691 2025-08-07 11:58:26.059970 | 2025-08-07 11:58:26.060094 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-07 11:58:26.096472 | debian-bookworm | ok 2025-08-07 11:58:26.107800 | debian-bookworm | included: /var/lib/zuul/builds/7e6d2078b01540209d9c18535c0ec1f2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-07 11:58:26.119846 | 2025-08-07 11:58:26.119912 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-07 11:58:26.155232 | debian-bookworm | skipping: Conditional result was False 2025-08-07 11:58:26.159714 | 2025-08-07 11:58:26.159783 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-07 11:58:26.744335 | debian-bookworm | changed 2025-08-07 11:58:26.748599 | 2025-08-07 11:58:26.748673 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-07 11:58:26.997912 | debian-bookworm | ok 2025-08-07 11:58:27.003253 | 2025-08-07 11:58:27.003345 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-07 11:58:27.686918 | debian-bookworm | changed 2025-08-07 11:58:27.695769 | 2025-08-07 11:58:27.695888 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-07 11:58:28.303035 | debian-bookworm | changed 2025-08-07 11:58:28.308178 | 2025-08-07 11:58:28.308267 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-07 11:58:28.330913 | debian-bookworm | skipping: Conditional result was False 2025-08-07 11:58:28.337734 | 2025-08-07 11:58:28.337890 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-07 11:58:28.721720 | debian-bookworm -> localhost | changed 2025-08-07 11:58:28.749640 | 2025-08-07 11:58:28.749743 | TASK [add-build-sshkey : Add back temp key] 2025-08-07 11:58:29.120107 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7e6d2078b01540209d9c18535c0ec1f2/work/7e6d2078b01540209d9c18535c0ec1f2_id_rsa (zuul-build-sshkey) 2025-08-07 11:58:29.120375 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016089 2025-08-07 11:58:29.127605 | 2025-08-07 11:58:29.127704 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-07 11:58:29.499486 | debian-bookworm | ok 2025-08-07 11:58:29.504248 | 2025-08-07 11:58:29.504334 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-07 11:58:29.527011 | debian-bookworm | skipping: Conditional result was False 2025-08-07 11:58:29.536667 | 2025-08-07 11:58:29.536761 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-07 11:58:29.988748 | debian-bookworm | ok 2025-08-07 11:58:30.010951 | 2025-08-07 11:58:30.011059 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-07 11:58:30.038481 | debian-bookworm | ok 2025-08-07 11:58:30.055481 | 2025-08-07 11:58:30.055593 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-07 11:58:30.340821 | debian-bookworm -> localhost | ok 2025-08-07 11:58:30.346931 | 2025-08-07 11:58:30.347016 | TASK [validate-host : Collect information about the host] 2025-08-07 11:58:31.483480 | debian-bookworm | ok 2025-08-07 11:58:31.498450 | 2025-08-07 11:58:31.498560 | TASK [validate-host : Sanitize hostname] 2025-08-07 11:58:31.580141 | debian-bookworm | ok 2025-08-07 11:58:31.610697 | 2025-08-07 11:58:31.610795 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-07 11:58:32.221479 | debian-bookworm -> localhost | changed 2025-08-07 11:58:32.227623 | 2025-08-07 11:58:32.227740 | TASK [validate-host : Collect information about zuul worker] 2025-08-07 11:58:32.673116 | debian-bookworm | ok 2025-08-07 11:58:32.678035 | 2025-08-07 11:58:32.678184 | TASK [validate-host : Write out all zuul information for each host] 2025-08-07 11:58:33.423417 | debian-bookworm -> localhost | changed 2025-08-07 11:58:33.439924 | 2025-08-07 11:58:33.440057 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-07 11:58:33.742810 | debian-bookworm | ok 2025-08-07 11:58:33.748607 | 2025-08-07 11:58:33.748717 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-07 11:58:34.845586 | debian-bookworm | changed: 2025-08-07 11:58:34.845798 | debian-bookworm | cd+++++++++ src/ 2025-08-07 11:58:34.845833 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-07 11:58:34.845858 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-07 11:58:34.845879 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-07 11:58:34.845899 | debian-bookworm | Containerfile 2025-08-07 11:58:34.846013 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008141 2025-08-07 11:59:01.822529 | 2025-08-07 11:59:01.822651 | TASK [upload-logs : Upload logs to log server] 2025-08-07 11:59:02.385458 | localhost | Output suppressed because no_log was given 2025-08-07 11:59:02.387811 | 2025-08-07 11:59:02.387937 | LOOP [upload-logs : Compress console log and json output] 2025-08-07 11:59:02.440724 | localhost | skipping: Conditional result was False 2025-08-07 11:59:02.446412 | localhost | skipping: Conditional result was False 2025-08-07 11:59:02.458743 | 2025-08-07 11:59:02.458987 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-07 11:59:02.510506 | localhost | skipping: Conditional result was False 2025-08-07 11:59:02.511246 | 2025-08-07 11:59:02.514785 | localhost | skipping: Conditional result was False 2025-08-07 11:59:02.526773 | 2025-08-07 11:59:02.527038 | LOOP [upload-logs : Upload console log and json output]