2025-03-30 03:03:47.539062 | Job console starting... 2025-03-30 03:03:47.552132 | Updating repositories 2025-03-30 03:03:47.687230 | Preparing job workspace 2025-03-30 03:03:49.103316 | Running Ansible setup... 2025-03-30 03:03:55.233736 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-30 03:03:56.353800 | 2025-03-30 03:03:56.353912 | PLAY [Base pre] 2025-03-30 03:03:56.394000 | 2025-03-30 03:03:56.394107 | TASK [Setup log path fact] 2025-03-30 03:03:56.428093 | ubuntu-noble | ok 2025-03-30 03:03:56.449671 | 2025-03-30 03:03:56.449777 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-03-30 03:03:56.492991 | ubuntu-noble | ok 2025-03-30 03:03:56.503227 | 2025-03-30 03:03:56.503310 | TASK [emit-job-header : Print job information] 2025-03-30 03:03:56.561196 | # Job Information 2025-03-30 03:03:56.561328 | Ansible Version: 2.15.3 2025-03-30 03:03:56.561355 | Job: python-black 2025-03-30 03:03:56.561381 | Pipeline: periodic-daily 2025-03-30 03:03:56.561399 | Executor: 7d211f194f6a 2025-03-30 03:03:56.561415 | Triggered by: https://github.com/osism/rookify 2025-03-30 03:03:56.561452 | Event ID: b804f9a25223411da6715913d7f13373 2025-03-30 03:03:56.570748 | 2025-03-30 03:03:56.570836 | LOOP [emit-job-header : Print node information] 2025-03-30 03:03:56.724831 | ubuntu-noble | ok: 2025-03-30 03:03:56.725113 | ubuntu-noble | # Node Information 2025-03-30 03:03:56.725154 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-30 03:03:56.725176 | ubuntu-noble | Hostname: ubuntu 2025-03-30 03:03:56.725194 | ubuntu-noble | Username: zuul 2025-03-30 03:03:56.725210 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-30 03:03:56.725229 | ubuntu-noble | Provider: regiocloud-a 2025-03-30 03:03:56.725246 | ubuntu-noble | Label: ubuntu-noble 2025-03-30 03:03:56.725264 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-30 03:03:56.725280 | ubuntu-noble | Interface IP: 81.163.193.61 2025-03-30 03:03:56.746122 | 2025-03-30 03:03:56.746211 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-30 03:03:57.563462 | ubuntu-noble -> localhost | changed 2025-03-30 03:03:57.570217 | 2025-03-30 03:03:57.570300 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-30 03:03:59.157489 | ubuntu-noble -> localhost | changed 2025-03-30 03:03:59.173395 | 2025-03-30 03:03:59.173499 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-30 03:03:59.832199 | ubuntu-noble -> localhost | ok 2025-03-30 03:03:59.838140 | 2025-03-30 03:03:59.838235 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-30 03:03:59.886772 | ubuntu-noble | ok 2025-03-30 03:03:59.900125 | ubuntu-noble | included: /var/lib/zuul/builds/1ad954c8b32d4970b0914abf18c14f21/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-30 03:03:59.907007 | 2025-03-30 03:03:59.907084 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-30 03:04:00.724268 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-30 03:04:00.724445 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/1ad954c8b32d4970b0914abf18c14f21/work/1ad954c8b32d4970b0914abf18c14f21_id_rsa 2025-03-30 03:04:00.724477 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/1ad954c8b32d4970b0914abf18c14f21/work/1ad954c8b32d4970b0914abf18c14f21_id_rsa.pub 2025-03-30 03:04:00.724498 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-30 03:04:00.724518 | ubuntu-noble -> localhost | SHA256:cdwxgIL67u01yJeEwUtmORAw3+8Dqh4milS2dWwxNvc zuul-build-sshkey 2025-03-30 03:04:00.724536 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-30 03:04:00.724553 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-30 03:04:00.724570 | ubuntu-noble -> localhost | | o.oo ...o | 2025-03-30 03:04:00.724585 | ubuntu-noble -> localhost | | o.+.... . o | 2025-03-30 03:04:00.724601 | ubuntu-noble -> localhost | | .. X*..o . | 2025-03-30 03:04:00.724624 | ubuntu-noble -> localhost | | . +o*=o. | 2025-03-30 03:04:00.724640 | ubuntu-noble -> localhost | | + .++S E | 2025-03-30 03:04:00.724656 | ubuntu-noble -> localhost | | o +oo= . | 2025-03-30 03:04:00.724677 | ubuntu-noble -> localhost | |..oo. o B | 2025-03-30 03:04:00.724693 | ubuntu-noble -> localhost | |+o o.. o o | 2025-03-30 03:04:00.724709 | ubuntu-noble -> localhost | |o.o...o | 2025-03-30 03:04:00.724725 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-30 03:04:00.724764 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.317575 2025-03-30 03:04:00.730939 | 2025-03-30 03:04:00.731089 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-30 03:04:00.749997 | ubuntu-noble | ok 2025-03-30 03:04:00.759702 | ubuntu-noble | included: /var/lib/zuul/builds/1ad954c8b32d4970b0914abf18c14f21/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-30 03:04:00.769323 | 2025-03-30 03:04:00.769396 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-30 03:04:00.792568 | ubuntu-noble | skipping: Conditional result was False 2025-03-30 03:04:00.800597 | 2025-03-30 03:04:00.800691 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-30 03:04:01.640875 | ubuntu-noble | changed 2025-03-30 03:04:01.651148 | 2025-03-30 03:04:01.651237 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-30 03:04:02.028460 | ubuntu-noble | ok 2025-03-30 03:04:02.037838 | 2025-03-30 03:04:02.037932 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-30 03:04:02.898304 | ubuntu-noble | changed 2025-03-30 03:04:02.903747 | 2025-03-30 03:04:02.903821 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-30 03:04:03.839861 | ubuntu-noble | changed 2025-03-30 03:04:03.847537 | 2025-03-30 03:04:03.847619 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-30 03:04:03.870868 | ubuntu-noble | skipping: Conditional result was False 2025-03-30 03:04:03.877386 | 2025-03-30 03:04:03.877475 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-30 03:04:04.317015 | ubuntu-noble -> localhost | changed 2025-03-30 03:04:04.340556 | 2025-03-30 03:04:04.340664 | TASK [add-build-sshkey : Add back temp key] 2025-03-30 03:04:04.676485 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/1ad954c8b32d4970b0914abf18c14f21/work/1ad954c8b32d4970b0914abf18c14f21_id_rsa (zuul-build-sshkey) 2025-03-30 03:04:04.676687 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.012804 2025-03-30 03:04:04.684029 | 2025-03-30 03:04:04.684120 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-30 03:04:05.155831 | ubuntu-noble | ok 2025-03-30 03:04:05.162072 | 2025-03-30 03:04:05.162151 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-30 03:04:05.195874 | ubuntu-noble | skipping: Conditional result was False 2025-03-30 03:04:05.230604 | 2025-03-30 03:04:05.230695 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-30 03:04:05.720944 | ubuntu-noble | ok 2025-03-30 03:04:05.737113 | 2025-03-30 03:04:05.737214 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-30 03:04:05.785518 | ubuntu-noble | ok 2025-03-30 03:04:05.795634 | 2025-03-30 03:04:05.795732 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-30 03:04:06.079581 | ubuntu-noble -> localhost | ok 2025-03-30 03:04:06.102461 | 2025-03-30 03:04:06.102560 | TASK [validate-host : Collect information about the host] 2025-03-30 03:04:07.355805 | ubuntu-noble | ok 2025-03-30 03:04:07.370226 | 2025-03-30 03:04:07.370390 | TASK [validate-host : Sanitize hostname] 2025-03-30 03:04:07.442974 | ubuntu-noble | ok 2025-03-30 03:04:07.449461 | 2025-03-30 03:04:07.449543 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-30 03:04:08.164130 | ubuntu-noble -> localhost | changed 2025-03-30 03:04:08.172948 | 2025-03-30 03:04:08.173059 | TASK [validate-host : Collect information about zuul worker] 2025-03-30 03:04:08.672915 | ubuntu-noble | ok 2025-03-30 03:04:08.678048 | 2025-03-30 03:04:08.678491 | TASK [validate-host : Write out all zuul information for each host] 2025-03-30 03:04:09.233798 | ubuntu-noble -> localhost | changed 2025-03-30 03:04:09.245546 | 2025-03-30 03:04:09.245646 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-30 03:04:09.642667 | ubuntu-noble | ok 2025-03-30 03:04:09.649135 | 2025-03-30 03:04:09.649226 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-30 03:04:10.454206 | ubuntu-noble | changed: 2025-03-30 03:04:10.454357 | ubuntu-noble | cd+++++++++ src/ 2025-03-30 03:04:10.454392 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-30 03:04:10.454417 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-30 03:04:10.454467 | ubuntu-noble | cd+++++++++ src/github.com/osism/rookify/ 2025-03-30 03:04:10.454492 | ubuntu-noble | Containerfile 2025-03-30 03:04:10.454640 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.005407 2025-03-30 03:04:50.896417 | 2025-03-30 03:04:50.896521 | TASK [upload-logs : Upload logs to log server] 2025-03-30 03:04:51.765427 | localhost | Output suppressed because no_log was given 2025-03-30 03:04:51.768218 | 2025-03-30 03:04:51.768309 | LOOP [upload-logs : Compress console log and json output] 2025-03-30 03:04:51.845697 | localhost | skipping: Conditional result was False 2025-03-30 03:04:51.863119 | localhost | skipping: Conditional result was False 2025-03-30 03:04:51.867286 | 2025-03-30 03:04:51.867403 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-30 03:04:51.986719 | localhost | skipping: Conditional result was False 2025-03-30 03:04:51.986977 | 2025-03-30 03:04:51.988095 | localhost | skipping: Conditional result was False 2025-03-30 03:04:51.992008 | 2025-03-30 03:04:51.992087 | LOOP [upload-logs : Upload console log and json output]