2025-10-02 03:09:47.868344 | Job console starting 2025-10-02 03:09:47.882797 | Updating git repos 2025-10-02 03:09:47.919539 | Cloning repos into workspace 2025-10-02 03:09:48.018175 | Restoring repo states 2025-10-02 03:09:48.038614 | Merging changes 2025-10-02 03:09:48.038630 | Checking out repos 2025-10-02 03:09:48.166282 | Preparing playbooks 2025-10-02 03:09:49.356713 | Running Ansible setup 2025-10-02 03:09:53.887684 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-02 03:09:54.653009 | 2025-10-02 03:09:54.653144 | PLAY [Base pre] 2025-10-02 03:09:54.680681 | 2025-10-02 03:09:54.680799 | TASK [Setup log path fact] 2025-10-02 03:09:54.709074 | debian-bookworm | ok 2025-10-02 03:09:54.728171 | 2025-10-02 03:09:54.728296 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-02 03:09:54.766865 | debian-bookworm | ok 2025-10-02 03:09:54.776092 | 2025-10-02 03:09:54.776184 | TASK [emit-job-header : Print job information] 2025-10-02 03:09:54.825565 | # Job Information 2025-10-02 03:09:54.825716 | Ansible Version: 2.16.14 2025-10-02 03:09:54.825749 | Job: python-black 2025-10-02 03:09:54.825781 | Pipeline: periodic-daily 2025-10-02 03:09:54.825803 | Executor: 521e9411259a 2025-10-02 03:09:54.825824 | Triggered by: https://github.com/osism/python-osism 2025-10-02 03:09:54.825846 | Event ID: 28998876599a43329962e3e27e4eb71f 2025-10-02 03:09:54.836595 | 2025-10-02 03:09:54.836705 | LOOP [emit-job-header : Print node information] 2025-10-02 03:09:54.996371 | debian-bookworm | ok: 2025-10-02 03:09:54.996529 | debian-bookworm | # Node Information 2025-10-02 03:09:54.996563 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-02 03:09:54.996588 | debian-bookworm | Hostname: debian 2025-10-02 03:09:54.996610 | debian-bookworm | Username: zuul 2025-10-02 03:09:54.996630 | debian-bookworm | Distro: Debian 12.12 2025-10-02 03:09:54.996654 | debian-bookworm | Provider: regiocloud-a 2025-10-02 03:09:54.996675 | debian-bookworm | Region: 2025-10-02 03:09:54.996696 | debian-bookworm | Label: debian-bookworm 2025-10-02 03:09:54.996716 | debian-bookworm | Product Name: OpenStack Nova 2025-10-02 03:09:54.996736 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef3:2f7a 2025-10-02 03:09:55.014538 | 2025-10-02 03:09:55.014645 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-02 03:09:55.525766 | debian-bookworm -> localhost | changed 2025-10-02 03:09:55.533267 | 2025-10-02 03:09:55.533375 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-02 03:09:56.816273 | debian-bookworm -> localhost | changed 2025-10-02 03:09:56.824814 | 2025-10-02 03:09:56.824900 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-02 03:09:57.212718 | debian-bookworm -> localhost | ok 2025-10-02 03:09:57.217500 | 2025-10-02 03:09:57.217579 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-02 03:09:57.237171 | debian-bookworm | ok 2025-10-02 03:09:57.250605 | debian-bookworm | included: /var/lib/zuul/builds/dc5f93e9ee524012a815d5ceb0e774b9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-02 03:09:57.255359 | 2025-10-02 03:09:57.255428 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-02 03:09:58.533257 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-02 03:09:58.533419 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/dc5f93e9ee524012a815d5ceb0e774b9/work/dc5f93e9ee524012a815d5ceb0e774b9_id_rsa 2025-10-02 03:09:58.533463 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/dc5f93e9ee524012a815d5ceb0e774b9/work/dc5f93e9ee524012a815d5ceb0e774b9_id_rsa.pub 2025-10-02 03:09:58.533485 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-02 03:09:58.533505 | debian-bookworm -> localhost | SHA256:6a1pqO/ARzwJ5w2b41hqRd2dFUZwH0NJqmK8S0qqSEw zuul-build-sshkey 2025-10-02 03:09:58.533523 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-02 03:09:58.533549 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-02 03:09:58.533567 | debian-bookworm -> localhost | | .oO*.| 2025-10-02 03:09:58.533585 | debian-bookworm -> localhost | | . . . =.oo| 2025-10-02 03:09:58.533602 | debian-bookworm -> localhost | | . + . . o. .| 2025-10-02 03:09:58.533618 | debian-bookworm -> localhost | | * *.. . | 2025-10-02 03:09:58.533634 | debian-bookworm -> localhost | | E % S+ . | 2025-10-02 03:09:58.533655 | debian-bookworm -> localhost | |o . B +..o | 2025-10-02 03:09:58.533673 | debian-bookworm -> localhost | | o * oo.o. | 2025-10-02 03:09:58.533689 | debian-bookworm -> localhost | |. .. o+ +o. | 2025-10-02 03:09:58.533707 | debian-bookworm -> localhost | | . .o=ooo. | 2025-10-02 03:09:58.533723 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-02 03:09:58.533762 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.813301 2025-10-02 03:09:58.538760 | 2025-10-02 03:09:58.539003 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-02 03:09:58.559373 | debian-bookworm | ok 2025-10-02 03:09:58.574821 | debian-bookworm | included: /var/lib/zuul/builds/dc5f93e9ee524012a815d5ceb0e774b9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-02 03:09:58.586127 | 2025-10-02 03:09:58.586208 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-02 03:09:58.623283 | debian-bookworm | skipping: Conditional result was False 2025-10-02 03:09:58.628092 | 2025-10-02 03:09:58.628177 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-02 03:09:59.398480 | debian-bookworm | changed 2025-10-02 03:09:59.402726 | 2025-10-02 03:09:59.402798 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-02 03:09:59.651353 | debian-bookworm | ok 2025-10-02 03:09:59.655762 | 2025-10-02 03:09:59.655846 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-02 03:10:00.319793 | debian-bookworm | changed 2025-10-02 03:10:00.330614 | 2025-10-02 03:10:00.330727 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-02 03:10:01.013983 | debian-bookworm | changed 2025-10-02 03:10:01.019218 | 2025-10-02 03:10:01.019311 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-02 03:10:01.042847 | debian-bookworm | skipping: Conditional result was False 2025-10-02 03:10:01.048686 | 2025-10-02 03:10:01.048789 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-02 03:10:01.808404 | debian-bookworm -> localhost | changed 2025-10-02 03:10:01.818574 | 2025-10-02 03:10:01.818673 | TASK [add-build-sshkey : Add back temp key] 2025-10-02 03:10:02.569656 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/dc5f93e9ee524012a815d5ceb0e774b9/work/dc5f93e9ee524012a815d5ceb0e774b9_id_rsa (zuul-build-sshkey) 2025-10-02 03:10:02.569869 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.033784 2025-10-02 03:10:02.577928 | 2025-10-02 03:10:02.578049 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-02 03:10:03.298916 | debian-bookworm | ok 2025-10-02 03:10:03.303677 | 2025-10-02 03:10:03.303773 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-02 03:10:03.357109 | debian-bookworm | skipping: Conditional result was False 2025-10-02 03:10:03.367205 | 2025-10-02 03:10:03.367317 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-02 03:10:03.804687 | debian-bookworm | ok 2025-10-02 03:10:03.815891 | 2025-10-02 03:10:03.816008 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-02 03:10:03.857591 | debian-bookworm | ok 2025-10-02 03:10:03.861928 | 2025-10-02 03:10:03.862033 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-02 03:10:04.140383 | debian-bookworm -> localhost | ok 2025-10-02 03:10:04.145453 | 2025-10-02 03:10:04.145530 | TASK [validate-host : Collect information about the host] 2025-10-02 03:10:05.205485 | debian-bookworm | ok 2025-10-02 03:10:05.213829 | 2025-10-02 03:10:05.213915 | TASK [validate-host : Sanitize hostname] 2025-10-02 03:10:05.293477 | debian-bookworm | ok 2025-10-02 03:10:05.343136 | 2025-10-02 03:10:05.343240 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-02 03:10:06.036319 | debian-bookworm -> localhost | changed 2025-10-02 03:10:06.040789 | 2025-10-02 03:10:06.040878 | TASK [validate-host : Collect information about zuul worker] 2025-10-02 03:10:06.507291 | debian-bookworm | ok 2025-10-02 03:10:06.513259 | 2025-10-02 03:10:06.513356 | TASK [validate-host : Write out all zuul information for each host] 2025-10-02 03:10:07.713996 | debian-bookworm -> localhost | changed 2025-10-02 03:10:07.733167 | 2025-10-02 03:10:07.733263 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-02 03:10:08.055126 | debian-bookworm | ok 2025-10-02 03:10:08.062019 | 2025-10-02 03:10:08.062105 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-02 03:10:09.636743 | debian-bookworm | changed: 2025-10-02 03:10:09.636896 | debian-bookworm | cd+++++++++ src/ 2025-10-02 03:10:09.636925 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-02 03:10:09.636945 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-02 03:10:09.636990 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-02 03:10:09.637008 | debian-bookworm | Containerfile 2025-10-02 03:10:09.637105 | debian-bookworm | Containerfile 2025-10-02 03:10:09.707591 | debian-bookworm | localhost | ok: Runtime: 0:00:00.003997 2025-10-02 03:10:39.949737 | 2025-10-02 03:10:39.949826 | TASK [upload-logs : Upload logs to log server] 2025-10-02 03:10:40.549447 | localhost | Output suppressed because no_log was given 2025-10-02 03:10:40.551097 | 2025-10-02 03:10:40.551181 | LOOP [upload-logs : Compress console log and json output] 2025-10-02 03:10:40.594492 | localhost | skipping: Conditional result was False 2025-10-02 03:10:40.600497 | localhost | skipping: Conditional result was False 2025-10-02 03:10:40.607032 | 2025-10-02 03:10:40.607120 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-02 03:10:40.652320 | localhost | skipping: Conditional result was False 2025-10-02 03:10:40.652560 | 2025-10-02 03:10:40.655981 | localhost | skipping: Conditional result was False 2025-10-02 03:10:40.667209 | 2025-10-02 03:10:40.667299 | LOOP [upload-logs : Upload console log and json output]