2025-06-15 17:38:56.356499 | Job console starting 2025-06-15 17:38:56.375119 | Updating git repos 2025-06-15 17:38:56.485003 | Cloning repos into workspace 2025-06-15 17:38:56.578523 | Restoring repo states 2025-06-15 17:38:56.597355 | Merging changes 2025-06-15 17:38:57.290691 | Checking out repos 2025-06-15 17:38:57.369746 | Preparing playbooks 2025-06-15 17:38:58.842153 | Running Ansible setup 2025-06-15 17:39:05.908928 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-15 17:39:06.679585 | 2025-06-15 17:39:06.679714 | PLAY [Base pre] 2025-06-15 17:39:06.697309 | 2025-06-15 17:39:06.697420 | TASK [Setup log path fact] 2025-06-15 17:39:06.715195 | debian-bookworm | ok 2025-06-15 17:39:06.729726 | 2025-06-15 17:39:06.729834 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-15 17:39:06.827616 | debian-bookworm | ok 2025-06-15 17:39:06.856425 | 2025-06-15 17:39:06.856541 | TASK [emit-job-header : Print job information] 2025-06-15 17:39:06.935268 | # Job Information 2025-06-15 17:39:06.935441 | Ansible Version: 2.16.14 2025-06-15 17:39:06.935477 | Job: python-black 2025-06-15 17:39:06.935511 | Pipeline: check 2025-06-15 17:39:06.935536 | Executor: 521e9411259a 2025-06-15 17:39:06.935557 | Triggered by: https://github.com/osism/python-osism/pull/1427 2025-06-15 17:39:06.935580 | Event ID: 96972ca0-4a0f-11f0-9227-5727a09656c9 2025-06-15 17:39:06.944928 | 2025-06-15 17:39:06.945035 | LOOP [emit-job-header : Print node information] 2025-06-15 17:39:07.080575 | debian-bookworm | ok: 2025-06-15 17:39:07.080796 | debian-bookworm | # Node Information 2025-06-15 17:39:07.080833 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-15 17:39:07.080889 | debian-bookworm | Hostname: debian 2025-06-15 17:39:07.080913 | debian-bookworm | Username: zuul 2025-06-15 17:39:07.080934 | debian-bookworm | Distro: Debian 12.11 2025-06-15 17:39:07.080958 | debian-bookworm | Provider: regiocloud-a 2025-06-15 17:39:07.080980 | debian-bookworm | Region: 2025-06-15 17:39:07.081002 | debian-bookworm | Label: debian-bookworm 2025-06-15 17:39:07.081022 | debian-bookworm | Product Name: OpenStack Nova 2025-06-15 17:39:07.081041 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:febf:943f 2025-06-15 17:39:07.101197 | 2025-06-15 17:39:07.101312 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-15 17:39:07.831631 | debian-bookworm -> localhost | changed 2025-06-15 17:39:07.838650 | 2025-06-15 17:39:07.838761 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-15 17:39:09.327264 | debian-bookworm -> localhost | changed 2025-06-15 17:39:09.342612 | 2025-06-15 17:39:09.342897 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-15 17:39:09.882688 | debian-bookworm -> localhost | ok 2025-06-15 17:39:09.889732 | 2025-06-15 17:39:09.889932 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-15 17:39:09.930033 | debian-bookworm | ok 2025-06-15 17:39:09.981935 | debian-bookworm | included: /var/lib/zuul/builds/ed50e04e3ef044d88068c4ef1f09ee0e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-15 17:39:10.005171 | 2025-06-15 17:39:10.005308 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-15 17:39:12.185692 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-15 17:39:12.185932 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ed50e04e3ef044d88068c4ef1f09ee0e/work/ed50e04e3ef044d88068c4ef1f09ee0e_id_rsa 2025-06-15 17:39:12.185973 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ed50e04e3ef044d88068c4ef1f09ee0e/work/ed50e04e3ef044d88068c4ef1f09ee0e_id_rsa.pub 2025-06-15 17:39:12.186001 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-15 17:39:12.186026 | debian-bookworm -> localhost | SHA256:iZqthL9708x/iyoxY8dasZZWWgmQvtYxzQ7dDIe9Z/U zuul-build-sshkey 2025-06-15 17:39:12.186050 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-15 17:39:12.186083 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-15 17:39:12.186106 | debian-bookworm -> localhost | | .o o | 2025-06-15 17:39:12.186129 | debian-bookworm -> localhost | | . . o o .| 2025-06-15 17:39:12.186150 | debian-bookworm -> localhost | | . = * . ..| 2025-06-15 17:39:12.186171 | debian-bookworm -> localhost | | ..=.B + o E| 2025-06-15 17:39:12.186191 | debian-bookworm -> localhost | | .+S% o | 2025-06-15 17:39:12.186214 | debian-bookworm -> localhost | | . +B @ . | 2025-06-15 17:39:12.186235 | debian-bookworm -> localhost | | . +o.& | 2025-06-15 17:39:12.186256 | debian-bookworm -> localhost | | o .= + .. | 2025-06-15 17:39:12.186278 | debian-bookworm -> localhost | | =+ o.oo... | 2025-06-15 17:39:12.186298 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-15 17:39:12.186353 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.189293 2025-06-15 17:39:12.192730 | 2025-06-15 17:39:12.192864 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-15 17:39:12.215867 | debian-bookworm | ok 2025-06-15 17:39:12.231133 | debian-bookworm | included: /var/lib/zuul/builds/ed50e04e3ef044d88068c4ef1f09ee0e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-15 17:39:12.241667 | 2025-06-15 17:39:12.241757 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-15 17:39:12.265932 | debian-bookworm | skipping: Conditional result was False 2025-06-15 17:39:12.279669 | 2025-06-15 17:39:12.279883 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-15 17:39:12.959486 | debian-bookworm | changed 2025-06-15 17:39:12.966303 | 2025-06-15 17:39:12.966409 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-15 17:39:13.247348 | debian-bookworm | ok 2025-06-15 17:39:13.256939 | 2025-06-15 17:39:13.257090 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-15 17:39:13.907249 | debian-bookworm | changed 2025-06-15 17:39:13.914258 | 2025-06-15 17:39:13.914355 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-15 17:39:14.565319 | debian-bookworm | changed 2025-06-15 17:39:14.573968 | 2025-06-15 17:39:14.574103 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-15 17:39:14.598253 | debian-bookworm | skipping: Conditional result was False 2025-06-15 17:39:14.608687 | 2025-06-15 17:39:14.608798 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-15 17:39:15.143942 | debian-bookworm -> localhost | changed 2025-06-15 17:39:15.154447 | 2025-06-15 17:39:15.154533 | TASK [add-build-sshkey : Add back temp key] 2025-06-15 17:39:15.693132 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ed50e04e3ef044d88068c4ef1f09ee0e/work/ed50e04e3ef044d88068c4ef1f09ee0e_id_rsa (zuul-build-sshkey) 2025-06-15 17:39:15.693476 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.034218 2025-06-15 17:39:15.705285 | 2025-06-15 17:39:15.705401 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-15 17:39:16.375422 | debian-bookworm | ok 2025-06-15 17:39:16.387381 | 2025-06-15 17:39:16.387604 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-15 17:39:16.422199 | debian-bookworm | skipping: Conditional result was False 2025-06-15 17:39:16.433677 | 2025-06-15 17:39:16.433824 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-15 17:39:16.934320 | debian-bookworm | ok 2025-06-15 17:39:16.961362 | 2025-06-15 17:39:16.961519 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-15 17:39:17.009437 | debian-bookworm | ok 2025-06-15 17:39:17.016383 | 2025-06-15 17:39:17.016522 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-15 17:39:17.391571 | debian-bookworm -> localhost | ok 2025-06-15 17:39:17.403605 | 2025-06-15 17:39:17.403732 | TASK [validate-host : Collect information about the host] 2025-06-15 17:39:18.585967 | debian-bookworm | ok 2025-06-15 17:39:18.601470 | 2025-06-15 17:39:18.601675 | TASK [validate-host : Sanitize hostname] 2025-06-15 17:39:18.737547 | debian-bookworm | ok 2025-06-15 17:39:18.833419 | 2025-06-15 17:39:18.833565 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-15 17:39:19.702757 | debian-bookworm -> localhost | changed 2025-06-15 17:39:19.709188 | 2025-06-15 17:39:19.709318 | TASK [validate-host : Collect information about zuul worker] 2025-06-15 17:39:20.133344 | debian-bookworm | ok 2025-06-15 17:39:20.138258 | 2025-06-15 17:39:20.138365 | TASK [validate-host : Write out all zuul information for each host] 2025-06-15 17:39:20.824187 | debian-bookworm -> localhost | changed 2025-06-15 17:39:20.834179 | 2025-06-15 17:39:20.834327 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-15 17:39:21.105717 | debian-bookworm | ok 2025-06-15 17:39:21.111988 | 2025-06-15 17:39:21.112114 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-15 17:39:22.270317 | debian-bookworm | changed: 2025-06-15 17:39:22.270665 | debian-bookworm | cd+++++++++ src/ 2025-06-15 17:39:22.275283 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-15 17:39:22.275325 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-15 17:39:22.275350 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-06-15 17:39:22.275372 | debian-bookworm | Containerfile 2025-06-15 17:39:22.276645 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008252 2025-06-15 17:39:48.332605 | 2025-06-15 17:39:48.332796 | TASK [upload-logs : Upload logs to log server] 2025-06-15 17:39:48.897246 | localhost | Output suppressed because no_log was given 2025-06-15 17:39:48.900943 | 2025-06-15 17:39:48.901117 | LOOP [upload-logs : Compress console log and json output] 2025-06-15 17:39:48.972757 | localhost | skipping: Conditional result was False 2025-06-15 17:39:48.978114 | localhost | skipping: Conditional result was False 2025-06-15 17:39:48.983912 | 2025-06-15 17:39:48.984077 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-15 17:39:49.044127 | localhost | skipping: Conditional result was False 2025-06-15 17:39:49.044897 | 2025-06-15 17:39:49.048293 | localhost | skipping: Conditional result was False 2025-06-15 17:39:49.055778 | 2025-06-15 17:39:49.055968 | LOOP [upload-logs : Upload console log and json output]