2025-06-03 16:00:44.901692 | Job console starting 2025-06-03 16:00:44.912109 | Updating git repos 2025-06-03 16:00:44.933147 | Cloning repos into workspace 2025-06-03 16:00:44.976603 | Restoring repo states 2025-06-03 16:00:44.993163 | Merging changes 2025-06-03 16:00:45.448827 | Checking out repos 2025-06-03 16:00:45.491989 | Preparing playbooks 2025-06-03 16:00:46.237843 | Running Ansible setup 2025-06-03 16:00:51.695558 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-03 16:00:52.527667 | 2025-06-03 16:00:52.527835 | PLAY [Base pre] 2025-06-03 16:00:52.545672 | 2025-06-03 16:00:52.545813 | TASK [Setup log path fact] 2025-06-03 16:00:52.567954 | debian-bookworm | ok 2025-06-03 16:00:52.583579 | 2025-06-03 16:00:52.583723 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-03 16:00:52.626020 | debian-bookworm | ok 2025-06-03 16:00:52.636195 | 2025-06-03 16:00:52.636388 | TASK [emit-job-header : Print job information] 2025-06-03 16:00:52.677243 | # Job Information 2025-06-03 16:00:52.677496 | Ansible Version: 2.16.14 2025-06-03 16:00:52.677545 | Job: python-black 2025-06-03 16:00:52.677581 | Pipeline: check 2025-06-03 16:00:52.677606 | Executor: 521e9411259a 2025-06-03 16:00:52.677629 | Triggered by: https://github.com/osism/openstack-sandbox-manager/pull/91 2025-06-03 16:00:52.677653 | Event ID: e278c0a0-4093-11f0-9198-e745d1e18e61 2025-06-03 16:00:52.683139 | 2025-06-03 16:00:52.683265 | LOOP [emit-job-header : Print node information] 2025-06-03 16:00:52.793588 | debian-bookworm | ok: 2025-06-03 16:00:52.793856 | debian-bookworm | # Node Information 2025-06-03 16:00:52.793895 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-03 16:00:52.793921 | debian-bookworm | Hostname: debian 2025-06-03 16:00:52.793944 | debian-bookworm | Username: zuul 2025-06-03 16:00:52.793965 | debian-bookworm | Distro: Debian 12.11 2025-06-03 16:00:52.793992 | debian-bookworm | Provider: regiocloud-a 2025-06-03 16:00:52.794014 | debian-bookworm | Region: 2025-06-03 16:00:52.794034 | debian-bookworm | Label: debian-bookworm 2025-06-03 16:00:52.794054 | debian-bookworm | Product Name: OpenStack Nova 2025-06-03 16:00:52.794073 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6e:c3e8 2025-06-03 16:00:52.819717 | 2025-06-03 16:00:52.819882 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-03 16:00:53.331860 | debian-bookworm -> localhost | changed 2025-06-03 16:00:53.339748 | 2025-06-03 16:00:53.339898 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-03 16:00:54.420183 | debian-bookworm -> localhost | changed 2025-06-03 16:00:54.432750 | 2025-06-03 16:00:54.432938 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-03 16:00:54.740606 | debian-bookworm -> localhost | ok 2025-06-03 16:00:54.751905 | 2025-06-03 16:00:54.752081 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-03 16:00:54.782390 | debian-bookworm | ok 2025-06-03 16:00:54.801621 | debian-bookworm | included: /var/lib/zuul/builds/5eca11933074447ab9d5831fc3bb994c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-03 16:00:54.808392 | 2025-06-03 16:00:54.808517 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-03 16:00:55.945443 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-03 16:00:55.945707 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5eca11933074447ab9d5831fc3bb994c/work/5eca11933074447ab9d5831fc3bb994c_id_rsa 2025-06-03 16:00:55.945765 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5eca11933074447ab9d5831fc3bb994c/work/5eca11933074447ab9d5831fc3bb994c_id_rsa.pub 2025-06-03 16:00:55.945794 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-03 16:00:55.945820 | debian-bookworm -> localhost | SHA256:mBRPxisWEGt0KZLST6ldg4hS1OApQ965PvdOpoqsJ38 zuul-build-sshkey 2025-06-03 16:00:55.945843 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-03 16:00:55.945880 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-03 16:00:55.945902 | debian-bookworm -> localhost | | *+=+=ooo | 2025-06-03 16:00:55.945923 | debian-bookworm -> localhost | |*.*oBo==. | 2025-06-03 16:00:55.945943 | debian-bookworm -> localhost | |+ooOoo.o.. | 2025-06-03 16:00:55.945962 | debian-bookworm -> localhost | | o..+.oo. | 2025-06-03 16:00:55.945982 | debian-bookworm -> localhost | | . .o.S | 2025-06-03 16:00:55.946006 | debian-bookworm -> localhost | | . | 2025-06-03 16:00:55.946026 | debian-bookworm -> localhost | | o . o | 2025-06-03 16:00:55.946045 | debian-bookworm -> localhost | |o o E = | 2025-06-03 16:00:55.946065 | debian-bookworm -> localhost | |o*.o...o | 2025-06-03 16:00:55.946085 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-03 16:00:55.946140 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.630655 2025-06-03 16:00:55.953282 | 2025-06-03 16:00:55.953420 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-03 16:00:55.982614 | debian-bookworm | ok 2025-06-03 16:00:55.992428 | debian-bookworm | included: /var/lib/zuul/builds/5eca11933074447ab9d5831fc3bb994c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-03 16:00:56.003411 | 2025-06-03 16:00:56.003537 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-03 16:00:56.027671 | debian-bookworm | skipping: Conditional result was False 2025-06-03 16:00:56.034087 | 2025-06-03 16:00:56.034210 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-03 16:00:56.685843 | debian-bookworm | changed 2025-06-03 16:00:56.698367 | 2025-06-03 16:00:56.698498 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-03 16:00:56.967565 | debian-bookworm | ok 2025-06-03 16:00:56.975686 | 2025-06-03 16:00:56.975847 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-03 16:00:57.655478 | debian-bookworm | changed 2025-06-03 16:00:57.664068 | 2025-06-03 16:00:57.664194 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-03 16:00:58.298707 | debian-bookworm | changed 2025-06-03 16:00:58.306044 | 2025-06-03 16:00:58.306169 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-03 16:00:58.332001 | debian-bookworm | skipping: Conditional result was False 2025-06-03 16:00:58.338921 | 2025-06-03 16:00:58.339043 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-03 16:00:58.793250 | debian-bookworm -> localhost | changed 2025-06-03 16:00:58.804428 | 2025-06-03 16:00:58.804559 | TASK [add-build-sshkey : Add back temp key] 2025-06-03 16:00:59.152942 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5eca11933074447ab9d5831fc3bb994c/work/5eca11933074447ab9d5831fc3bb994c_id_rsa (zuul-build-sshkey) 2025-06-03 16:00:59.153356 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012598 2025-06-03 16:00:59.170604 | 2025-06-03 16:00:59.170746 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-03 16:00:59.597912 | debian-bookworm | ok 2025-06-03 16:00:59.603882 | 2025-06-03 16:00:59.604024 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-03 16:00:59.638372 | debian-bookworm | skipping: Conditional result was False 2025-06-03 16:00:59.657487 | 2025-06-03 16:00:59.657638 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-03 16:01:00.151277 | debian-bookworm | ok 2025-06-03 16:01:00.162854 | 2025-06-03 16:01:00.162980 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-03 16:01:00.198142 | debian-bookworm | ok 2025-06-03 16:01:00.203236 | 2025-06-03 16:01:00.203384 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-03 16:01:00.500495 | debian-bookworm -> localhost | ok 2025-06-03 16:01:00.507412 | 2025-06-03 16:01:00.507525 | TASK [validate-host : Collect information about the host] 2025-06-03 16:01:01.611340 | debian-bookworm | ok 2025-06-03 16:01:01.623959 | 2025-06-03 16:01:01.624088 | TASK [validate-host : Sanitize hostname] 2025-06-03 16:01:01.736441 | debian-bookworm | ok 2025-06-03 16:01:01.780417 | 2025-06-03 16:01:01.780553 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-03 16:01:02.355705 | debian-bookworm -> localhost | changed 2025-06-03 16:01:02.362046 | 2025-06-03 16:01:02.362163 | TASK [validate-host : Collect information about zuul worker] 2025-06-03 16:01:02.766193 | debian-bookworm | ok 2025-06-03 16:01:02.771500 | 2025-06-03 16:01:02.771641 | TASK [validate-host : Write out all zuul information for each host] 2025-06-03 16:01:03.385809 | debian-bookworm -> localhost | changed 2025-06-03 16:01:03.403559 | 2025-06-03 16:01:03.403725 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-03 16:01:03.701750 | debian-bookworm | ok 2025-06-03 16:01:03.712074 | 2025-06-03 16:01:03.712229 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-03 16:01:04.503773 | debian-bookworm | changed: 2025-06-03 16:01:04.504001 | debian-bookworm | cd+++++++++ src/ 2025-06-03 16:01:04.504042 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-03 16:01:04.504070 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-03 16:01:04.504095 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2025-06-03 16:01:04.504118 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008770 2025-06-03 16:01:28.490893 | 2025-06-03 16:01:28.491454 | TASK [upload-logs : Upload logs to log server] 2025-06-03 16:01:29.052206 | localhost | Output suppressed because no_log was given 2025-06-03 16:01:29.054383 | 2025-06-03 16:01:29.054490 | LOOP [upload-logs : Compress console log and json output] 2025-06-03 16:01:29.108532 | localhost | skipping: Conditional result was False 2025-06-03 16:01:29.116659 | localhost | skipping: Conditional result was False 2025-06-03 16:01:29.121940 | 2025-06-03 16:01:29.122055 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-03 16:01:29.174300 | localhost | skipping: Conditional result was False 2025-06-03 16:01:29.174635 | 2025-06-03 16:01:29.179757 | localhost | skipping: Conditional result was False 2025-06-03 16:01:29.193215 | 2025-06-03 16:01:29.193476 | LOOP [upload-logs : Upload console log and json output]