2025-10-29 03:02:26.534657 | Job console starting 2025-10-29 03:02:26.551801 | Updating git repos 2025-10-29 03:02:26.592098 | Cloning repos into workspace 2025-10-29 03:02:26.667565 | Restoring repo states 2025-10-29 03:02:26.682814 | Merging changes 2025-10-29 03:02:26.684083 | Checking out repos 2025-10-29 03:02:26.768187 | Preparing playbooks 2025-10-29 03:02:28.136562 | Running Ansible setup 2025-10-29 03:02:33.447530 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-29 03:02:34.062184 | 2025-10-29 03:02:34.062296 | PLAY [Base pre] 2025-10-29 03:02:34.075679 | 2025-10-29 03:02:34.075772 | TASK [Setup log path fact] 2025-10-29 03:02:34.092562 | debian-bookworm | ok 2025-10-29 03:02:34.109492 | 2025-10-29 03:02:34.109605 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-29 03:02:34.147212 | debian-bookworm | ok 2025-10-29 03:02:34.159401 | 2025-10-29 03:02:34.159489 | TASK [emit-job-header : Print job information] 2025-10-29 03:02:34.186219 | # Job Information 2025-10-29 03:02:34.186350 | Ansible Version: 2.16.14 2025-10-29 03:02:34.186377 | Job: python-black 2025-10-29 03:02:34.186403 | Pipeline: periodic-daily 2025-10-29 03:02:34.186421 | Executor: 521e9411259a 2025-10-29 03:02:34.186438 | Triggered by: https://github.com/osism/node-image 2025-10-29 03:02:34.186456 | Event ID: 40023e727a994e89bea71d36a16f3fc5 2025-10-29 03:02:34.190386 | 2025-10-29 03:02:34.190464 | LOOP [emit-job-header : Print node information] 2025-10-29 03:02:34.284616 | debian-bookworm | ok: 2025-10-29 03:02:34.284810 | debian-bookworm | # Node Information 2025-10-29 03:02:34.284844 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-29 03:02:34.284871 | debian-bookworm | Hostname: debian 2025-10-29 03:02:34.284892 | debian-bookworm | Username: zuul 2025-10-29 03:02:34.284968 | debian-bookworm | Distro: Debian 12.12 2025-10-29 03:02:34.285005 | debian-bookworm | Provider: regiocloud-a 2025-10-29 03:02:34.285033 | debian-bookworm | Region: 2025-10-29 03:02:34.285061 | debian-bookworm | Label: debian-bookworm 2025-10-29 03:02:34.285087 | debian-bookworm | Product Name: OpenStack Nova 2025-10-29 03:02:34.285113 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe10:f974 2025-10-29 03:02:34.294329 | 2025-10-29 03:02:34.294423 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-29 03:02:34.674399 | debian-bookworm -> localhost | changed 2025-10-29 03:02:34.680099 | 2025-10-29 03:02:34.680195 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-29 03:02:35.573122 | debian-bookworm -> localhost | changed 2025-10-29 03:02:35.582500 | 2025-10-29 03:02:35.582605 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-29 03:02:36.070229 | debian-bookworm -> localhost | ok 2025-10-29 03:02:36.075711 | 2025-10-29 03:02:36.075821 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-29 03:02:36.112728 | debian-bookworm | ok 2025-10-29 03:02:36.126827 | debian-bookworm | included: /var/lib/zuul/builds/36295463b14f4778adfc9ca3ba884364/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-29 03:02:36.131675 | 2025-10-29 03:02:36.131758 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-29 03:02:37.645356 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-29 03:02:37.645536 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/36295463b14f4778adfc9ca3ba884364/work/36295463b14f4778adfc9ca3ba884364_id_rsa 2025-10-29 03:02:37.645567 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/36295463b14f4778adfc9ca3ba884364/work/36295463b14f4778adfc9ca3ba884364_id_rsa.pub 2025-10-29 03:02:37.645600 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-29 03:02:37.645620 | debian-bookworm -> localhost | SHA256:fItEpchy4hIgPg8xQTcE/OgaB+mj034xv4Sh1TStmGA zuul-build-sshkey 2025-10-29 03:02:37.645639 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-29 03:02:37.645665 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-29 03:02:37.645683 | debian-bookworm -> localhost | |=*++ . | 2025-10-29 03:02:37.645701 | debian-bookworm -> localhost | |oo+ .. o o | 2025-10-29 03:02:37.645717 | debian-bookworm -> localhost | | =E o * + | 2025-10-29 03:02:37.645734 | debian-bookworm -> localhost | |oo+= O = | 2025-10-29 03:02:37.645749 | debian-bookworm -> localhost | |o...* o S . | 2025-10-29 03:02:37.645771 | debian-bookworm -> localhost | |.+.+oo . o . | 2025-10-29 03:02:37.645787 | debian-bookworm -> localhost | |o+o .+. . . | 2025-10-29 03:02:37.645803 | debian-bookworm -> localhost | |+ . ... | 2025-10-29 03:02:37.645819 | debian-bookworm -> localhost | | o.. .. | 2025-10-29 03:02:37.645835 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-29 03:02:37.645877 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.075295 2025-10-29 03:02:37.651003 | 2025-10-29 03:02:37.651083 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-29 03:02:37.677955 | debian-bookworm | ok 2025-10-29 03:02:37.690516 | debian-bookworm | included: /var/lib/zuul/builds/36295463b14f4778adfc9ca3ba884364/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-29 03:02:37.699866 | 2025-10-29 03:02:37.699945 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-29 03:02:37.713288 | debian-bookworm | skipping: Conditional result was False 2025-10-29 03:02:37.718802 | 2025-10-29 03:02:37.718897 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-29 03:02:38.416630 | debian-bookworm | changed 2025-10-29 03:02:38.422016 | 2025-10-29 03:02:38.422106 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-29 03:02:38.687614 | debian-bookworm | ok 2025-10-29 03:02:38.692993 | 2025-10-29 03:02:38.693080 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-29 03:02:39.336030 | debian-bookworm | changed 2025-10-29 03:02:39.345605 | 2025-10-29 03:02:39.345706 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-29 03:02:40.060320 | debian-bookworm | changed 2025-10-29 03:02:40.070515 | 2025-10-29 03:02:40.070661 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-29 03:02:40.093770 | debian-bookworm | skipping: Conditional result was False 2025-10-29 03:02:40.103965 | 2025-10-29 03:02:40.104089 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-29 03:02:40.693210 | debian-bookworm -> localhost | changed 2025-10-29 03:02:40.706202 | 2025-10-29 03:02:40.706310 | TASK [add-build-sshkey : Add back temp key] 2025-10-29 03:02:41.357476 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/36295463b14f4778adfc9ca3ba884364/work/36295463b14f4778adfc9ca3ba884364_id_rsa (zuul-build-sshkey) 2025-10-29 03:02:41.357735 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.024325 2025-10-29 03:02:41.367646 | 2025-10-29 03:02:41.367748 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-29 03:02:41.796105 | debian-bookworm | ok 2025-10-29 03:02:41.801429 | 2025-10-29 03:02:41.801514 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-29 03:02:41.855038 | debian-bookworm | skipping: Conditional result was False 2025-10-29 03:02:41.871126 | 2025-10-29 03:02:41.871234 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-29 03:02:42.396733 | debian-bookworm | ok 2025-10-29 03:02:42.410763 | 2025-10-29 03:02:42.415352 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-29 03:02:42.463692 | debian-bookworm | ok 2025-10-29 03:02:42.468630 | 2025-10-29 03:02:42.468713 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-29 03:02:42.974640 | debian-bookworm -> localhost | ok 2025-10-29 03:02:42.988165 | 2025-10-29 03:02:42.988253 | TASK [validate-host : Collect information about the host] 2025-10-29 03:02:44.350949 | debian-bookworm | ok 2025-10-29 03:02:44.362549 | 2025-10-29 03:02:44.362633 | TASK [validate-host : Sanitize hostname] 2025-10-29 03:02:44.454266 | debian-bookworm | ok 2025-10-29 03:02:44.481514 | 2025-10-29 03:02:44.481630 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-29 03:02:45.301297 | debian-bookworm -> localhost | changed 2025-10-29 03:02:45.305875 | 2025-10-29 03:02:45.305950 | TASK [validate-host : Collect information about zuul worker] 2025-10-29 03:02:45.691794 | debian-bookworm | ok 2025-10-29 03:02:45.698240 | 2025-10-29 03:02:45.698347 | TASK [validate-host : Write out all zuul information for each host] 2025-10-29 03:02:46.237239 | debian-bookworm -> localhost | changed 2025-10-29 03:02:46.245839 | 2025-10-29 03:02:46.245919 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-29 03:02:46.557783 | debian-bookworm | ok 2025-10-29 03:02:46.563477 | 2025-10-29 03:02:46.563557 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-29 03:02:48.252740 | debian-bookworm | changed: 2025-10-29 03:02:48.253012 | debian-bookworm | cd+++++++++ src/ 2025-10-29 03:02:48.253044 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-29 03:02:48.253064 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-29 03:02:48.253082 | debian-bookworm | cd+++++++++ src/github.com/osism/node-image/ 2025-10-29 03:02:48.253098 | debian-bookworm | Containerfile 2025-10-29 03:02:48.253204 | debian-bookworm | localhost | ok: Runtime: 0:00:00.013706 2025-10-29 03:03:18.039880 | 2025-10-29 03:03:18.039984 | TASK [upload-logs : Upload logs to log server] 2025-10-29 03:03:18.950351 | localhost | Output suppressed because no_log was given 2025-10-29 03:03:18.951983 | 2025-10-29 03:03:18.952064 | LOOP [upload-logs : Compress console log and json output] 2025-10-29 03:03:19.016371 | localhost | skipping: Conditional result was False 2025-10-29 03:03:19.020820 | localhost | skipping: Conditional result was False 2025-10-29 03:03:19.027466 | 2025-10-29 03:03:19.027555 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-29 03:03:19.104726 | localhost | skipping: Conditional result was False 2025-10-29 03:03:19.104967 | 2025-10-29 03:03:19.115194 | localhost | skipping: Conditional result was False 2025-10-29 03:03:19.123414 | 2025-10-29 03:03:19.123518 | LOOP [upload-logs : Upload console log and json output]