2025-10-11 03:12:46.371876 | Job console starting 2025-10-11 03:12:46.384015 | Updating git repos 2025-10-11 03:12:46.413656 | Cloning repos into workspace 2025-10-11 03:12:46.483849 | Restoring repo states 2025-10-11 03:12:46.498166 | Merging changes 2025-10-11 03:12:46.498186 | Checking out repos 2025-10-11 03:12:46.572165 | Preparing playbooks 2025-10-11 03:12:47.312599 | Running Ansible setup 2025-10-11 03:12:51.477962 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-11 03:12:52.285971 | 2025-10-11 03:12:52.286172 | PLAY [Base pre] 2025-10-11 03:12:52.314997 | 2025-10-11 03:12:52.315146 | TASK [Setup log path fact] 2025-10-11 03:12:52.344305 | debian-bookworm | ok 2025-10-11 03:12:52.360028 | 2025-10-11 03:12:52.360163 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-11 03:12:52.390520 | debian-bookworm | ok 2025-10-11 03:12:52.400583 | 2025-10-11 03:12:52.400695 | TASK [emit-job-header : Print job information] 2025-10-11 03:12:52.441023 | # Job Information 2025-10-11 03:12:52.441224 | Ansible Version: 2.16.14 2025-10-11 03:12:52.441270 | Job: python-black 2025-10-11 03:12:52.441312 | Pipeline: periodic-daily 2025-10-11 03:12:52.441342 | Executor: 521e9411259a 2025-10-11 03:12:52.441369 | Triggered by: https://github.com/osism/python-osism 2025-10-11 03:12:52.441398 | Event ID: f4c039be89bf42428c27699713fad6e9 2025-10-11 03:12:52.447354 | 2025-10-11 03:12:52.447483 | LOOP [emit-job-header : Print node information] 2025-10-11 03:12:52.552394 | debian-bookworm | ok: 2025-10-11 03:12:52.552601 | debian-bookworm | # Node Information 2025-10-11 03:12:52.552636 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-11 03:12:52.552662 | debian-bookworm | Hostname: debian 2025-10-11 03:12:52.552684 | debian-bookworm | Username: zuul 2025-10-11 03:12:52.552716 | debian-bookworm | Distro: Debian 12.12 2025-10-11 03:12:52.552749 | debian-bookworm | Provider: regiocloud-a 2025-10-11 03:12:52.552778 | debian-bookworm | Region: 2025-10-11 03:12:52.552806 | debian-bookworm | Label: debian-bookworm 2025-10-11 03:12:52.552833 | debian-bookworm | Product Name: OpenStack Nova 2025-10-11 03:12:52.552860 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6d:5e20 2025-10-11 03:12:52.575537 | 2025-10-11 03:12:52.575688 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-11 03:12:53.059663 | debian-bookworm -> localhost | changed 2025-10-11 03:12:53.067647 | 2025-10-11 03:12:53.067778 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-11 03:12:54.095522 | debian-bookworm -> localhost | changed 2025-10-11 03:12:54.114470 | 2025-10-11 03:12:54.114609 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-11 03:12:54.411861 | debian-bookworm -> localhost | ok 2025-10-11 03:12:54.418768 | 2025-10-11 03:12:54.418947 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-11 03:12:54.451751 | debian-bookworm | ok 2025-10-11 03:12:54.471958 | debian-bookworm | included: /var/lib/zuul/builds/e6c7576280754b938e08d2483e520409/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-11 03:12:54.478051 | 2025-10-11 03:12:54.478151 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-11 03:12:56.562464 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-11 03:12:56.562907 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e6c7576280754b938e08d2483e520409/work/e6c7576280754b938e08d2483e520409_id_rsa 2025-10-11 03:12:56.562983 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e6c7576280754b938e08d2483e520409/work/e6c7576280754b938e08d2483e520409_id_rsa.pub 2025-10-11 03:12:56.563030 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-11 03:12:56.563071 | debian-bookworm -> localhost | SHA256:UwFnodAtCBB72uz3lzPeOsO6BmfNxXVGX4dylhva8bE zuul-build-sshkey 2025-10-11 03:12:56.563107 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-11 03:12:56.563157 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-11 03:12:56.563193 | debian-bookworm -> localhost | | oo...o.o=. ++| 2025-10-11 03:12:56.563229 | debian-bookworm -> localhost | | . ..o+... O.*| 2025-10-11 03:12:56.563262 | debian-bookworm -> localhost | | . . .... B B+| 2025-10-11 03:12:56.563295 | debian-bookworm -> localhost | | = . + oE.| 2025-10-11 03:12:56.563328 | debian-bookworm -> localhost | | . o So . | 2025-10-11 03:12:56.563372 | debian-bookworm -> localhost | | . . o.o | 2025-10-11 03:12:56.563407 | debian-bookworm -> localhost | | . .+ . . | 2025-10-11 03:12:56.563494 | debian-bookworm -> localhost | | . .. O. | 2025-10-11 03:12:56.563531 | debian-bookworm -> localhost | | .+=o*. | 2025-10-11 03:12:56.563566 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-11 03:12:56.563653 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.571103 2025-10-11 03:12:56.575323 | 2025-10-11 03:12:56.575466 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-11 03:12:56.606906 | debian-bookworm | ok 2025-10-11 03:12:56.618766 | debian-bookworm | included: /var/lib/zuul/builds/e6c7576280754b938e08d2483e520409/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-11 03:12:56.630063 | 2025-10-11 03:12:56.630234 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-11 03:12:56.654308 | debian-bookworm | skipping: Conditional result was False 2025-10-11 03:12:56.661353 | 2025-10-11 03:12:56.661514 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-11 03:12:57.264746 | debian-bookworm | changed 2025-10-11 03:12:57.272994 | 2025-10-11 03:12:57.273120 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-11 03:12:57.533801 | debian-bookworm | ok 2025-10-11 03:12:57.542477 | 2025-10-11 03:12:57.542613 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-11 03:12:58.181203 | debian-bookworm | changed 2025-10-11 03:12:58.191876 | 2025-10-11 03:12:58.192017 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-11 03:12:58.842899 | debian-bookworm | changed 2025-10-11 03:12:58.850597 | 2025-10-11 03:12:58.850724 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-11 03:12:58.876156 | debian-bookworm | skipping: Conditional result was False 2025-10-11 03:12:58.886094 | 2025-10-11 03:12:58.886228 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-11 03:12:59.372070 | debian-bookworm -> localhost | changed 2025-10-11 03:12:59.383200 | 2025-10-11 03:12:59.383317 | TASK [add-build-sshkey : Add back temp key] 2025-10-11 03:12:59.772672 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e6c7576280754b938e08d2483e520409/work/e6c7576280754b938e08d2483e520409_id_rsa (zuul-build-sshkey) 2025-10-11 03:12:59.772945 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018163 2025-10-11 03:12:59.792909 | 2025-10-11 03:12:59.793024 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-11 03:13:00.178679 | debian-bookworm | ok 2025-10-11 03:13:00.187311 | 2025-10-11 03:13:00.187687 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-11 03:13:00.223563 | debian-bookworm | skipping: Conditional result was False 2025-10-11 03:13:00.241995 | 2025-10-11 03:13:00.242137 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-11 03:13:00.756968 | debian-bookworm | ok 2025-10-11 03:13:00.772222 | 2025-10-11 03:13:00.772384 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-11 03:13:00.803884 | debian-bookworm | ok 2025-10-11 03:13:00.810629 | 2025-10-11 03:13:00.810744 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-11 03:13:01.116727 | debian-bookworm -> localhost | ok 2025-10-11 03:13:01.132537 | 2025-10-11 03:13:01.132656 | TASK [validate-host : Collect information about the host] 2025-10-11 03:13:02.380663 | debian-bookworm | ok 2025-10-11 03:13:02.395472 | 2025-10-11 03:13:02.395594 | TASK [validate-host : Sanitize hostname] 2025-10-11 03:13:02.502553 | debian-bookworm | ok 2025-10-11 03:13:02.545772 | 2025-10-11 03:13:02.546019 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-11 03:13:03.118790 | debian-bookworm -> localhost | changed 2025-10-11 03:13:03.125045 | 2025-10-11 03:13:03.125156 | TASK [validate-host : Collect information about zuul worker] 2025-10-11 03:13:03.564225 | debian-bookworm | ok 2025-10-11 03:13:03.571921 | 2025-10-11 03:13:03.572067 | TASK [validate-host : Write out all zuul information for each host] 2025-10-11 03:13:04.099841 | debian-bookworm -> localhost | changed 2025-10-11 03:13:04.112629 | 2025-10-11 03:13:04.112752 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-11 03:13:04.392555 | debian-bookworm | ok 2025-10-11 03:13:04.399320 | 2025-10-11 03:13:04.399450 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-11 03:13:05.348571 | debian-bookworm | changed: 2025-10-11 03:13:05.348777 | debian-bookworm | cd+++++++++ src/ 2025-10-11 03:13:05.348812 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-11 03:13:05.348836 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-11 03:13:05.348857 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-11 03:13:05.348877 | debian-bookworm | Containerfile 2025-10-11 03:13:05.348988 | debian-bookworm | Containerfile 2025-10-11 03:13:05.375268 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004839 2025-10-11 03:13:31.127431 | 2025-10-11 03:13:31.127550 | TASK [upload-logs : Upload logs to log server] 2025-10-11 03:13:31.697267 | localhost | Output suppressed because no_log was given 2025-10-11 03:13:31.699690 | 2025-10-11 03:13:31.699818 | LOOP [upload-logs : Compress console log and json output] 2025-10-11 03:13:31.747063 | localhost | skipping: Conditional result was False 2025-10-11 03:13:31.752891 | localhost | skipping: Conditional result was False 2025-10-11 03:13:31.760610 | 2025-10-11 03:13:31.760850 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-11 03:13:31.823231 | localhost | skipping: Conditional result was False 2025-10-11 03:13:31.823565 | 2025-10-11 03:13:31.828791 | localhost | skipping: Conditional result was False 2025-10-11 03:13:31.839777 | 2025-10-11 03:13:31.839904 | LOOP [upload-logs : Upload console log and json output]