2025-07-09 16:41:40.062756 | Job console starting 2025-07-09 16:41:40.090676 | Updating git repos 2025-07-09 16:41:40.157198 | Cloning repos into workspace 2025-07-09 16:41:40.209252 | Restoring repo states 2025-07-09 16:41:40.232308 | Merging changes 2025-07-09 16:41:40.838028 | Checking out repos 2025-07-09 16:41:40.903063 | Preparing playbooks 2025-07-09 16:41:41.911314 | Running Ansible setup 2025-07-09 16:41:46.872964 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-09 16:41:47.971351 | 2025-07-09 16:41:47.971523 | PLAY [Base pre] 2025-07-09 16:41:48.010058 | 2025-07-09 16:41:48.010225 | TASK [Setup log path fact] 2025-07-09 16:41:48.059014 | debian-bookworm | ok 2025-07-09 16:41:48.084593 | 2025-07-09 16:41:48.084789 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-09 16:41:48.135170 | debian-bookworm | ok 2025-07-09 16:41:48.148891 | 2025-07-09 16:41:48.149031 | TASK [emit-job-header : Print job information] 2025-07-09 16:41:48.209454 | # Job Information 2025-07-09 16:41:48.209839 | Ansible Version: 2.16.14 2025-07-09 16:41:48.209888 | Job: python-black 2025-07-09 16:41:48.209929 | Pipeline: check 2025-07-09 16:41:48.209958 | Executor: 521e9411259a 2025-07-09 16:41:48.209979 | Triggered by: https://github.com/osism/python-osism/pull/1566 2025-07-09 16:41:48.210002 | Event ID: 905693d0-5ce3-11f0-9ff7-53b43c284657 2025-07-09 16:41:48.215399 | 2025-07-09 16:41:48.215556 | LOOP [emit-job-header : Print node information] 2025-07-09 16:41:48.388191 | debian-bookworm | ok: 2025-07-09 16:41:48.388393 | debian-bookworm | # Node Information 2025-07-09 16:41:48.388429 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-09 16:41:48.388455 | debian-bookworm | Hostname: debian 2025-07-09 16:41:48.388477 | debian-bookworm | Username: zuul 2025-07-09 16:41:48.388497 | debian-bookworm | Distro: Debian 12.11 2025-07-09 16:41:48.388520 | debian-bookworm | Provider: regiocloud-a 2025-07-09 16:41:48.388540 | debian-bookworm | Region: 2025-07-09 16:41:48.388560 | debian-bookworm | Label: debian-bookworm 2025-07-09 16:41:48.388580 | debian-bookworm | Product Name: OpenStack Nova 2025-07-09 16:41:48.388599 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7a:45a8 2025-07-09 16:41:48.402218 | 2025-07-09 16:41:48.402354 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-09 16:41:49.237177 | debian-bookworm -> localhost | changed 2025-07-09 16:41:49.247254 | 2025-07-09 16:41:49.247429 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-09 16:41:51.041817 | debian-bookworm -> localhost | changed 2025-07-09 16:41:51.059705 | 2025-07-09 16:41:51.059893 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-09 16:41:51.384201 | debian-bookworm -> localhost | ok 2025-07-09 16:41:51.390552 | 2025-07-09 16:41:51.390691 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-09 16:41:51.434068 | debian-bookworm | ok 2025-07-09 16:41:51.467984 | debian-bookworm | included: /var/lib/zuul/builds/aec65b5167e74b6a8b29e690608d4fb8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-09 16:41:51.484398 | 2025-07-09 16:41:51.484542 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-09 16:41:52.895755 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-09 16:41:52.896018 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/aec65b5167e74b6a8b29e690608d4fb8/work/aec65b5167e74b6a8b29e690608d4fb8_id_rsa 2025-07-09 16:41:52.896065 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/aec65b5167e74b6a8b29e690608d4fb8/work/aec65b5167e74b6a8b29e690608d4fb8_id_rsa.pub 2025-07-09 16:41:52.896094 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-09 16:41:52.896189 | debian-bookworm -> localhost | SHA256:2LIOwx7qEVv0TRzRNCLP/td1BpfyuirOBvU2VeuLu+s zuul-build-sshkey 2025-07-09 16:41:52.896222 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-09 16:41:52.896254 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-09 16:41:52.896277 | debian-bookworm -> localhost | | . ++o | 2025-07-09 16:41:52.896298 | debian-bookworm -> localhost | | = o.. ..| 2025-07-09 16:41:52.896318 | debian-bookworm -> localhost | | . = .o.o| 2025-07-09 16:41:52.896338 | debian-bookworm -> localhost | | . . * . .o+ | 2025-07-09 16:41:52.896358 | debian-bookworm -> localhost | | . . + S . . ..+| 2025-07-09 16:41:52.896457 | debian-bookworm -> localhost | | = + . + ..+.| 2025-07-09 16:41:52.896486 | debian-bookworm -> localhost | | o = . . o o.o .| 2025-07-09 16:41:52.896508 | debian-bookworm -> localhost | | + = .o . ... | 2025-07-09 16:41:52.896530 | debian-bookworm -> localhost | | .o . . oo..oE+ | 2025-07-09 16:41:52.896550 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-09 16:41:52.896605 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.814620 2025-07-09 16:41:52.904863 | 2025-07-09 16:41:52.904955 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-09 16:41:52.960842 | debian-bookworm | ok 2025-07-09 16:41:52.979487 | debian-bookworm | included: /var/lib/zuul/builds/aec65b5167e74b6a8b29e690608d4fb8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-09 16:41:53.003643 | 2025-07-09 16:41:53.004130 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-09 16:41:53.051882 | debian-bookworm | skipping: Conditional result was False 2025-07-09 16:41:53.059713 | 2025-07-09 16:41:53.059920 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-09 16:41:53.869337 | debian-bookworm | changed 2025-07-09 16:41:53.885991 | 2025-07-09 16:41:53.886099 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-09 16:41:54.205579 | debian-bookworm | ok 2025-07-09 16:41:54.247978 | 2025-07-09 16:41:54.248110 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-09 16:41:54.941466 | debian-bookworm | changed 2025-07-09 16:41:54.953130 | 2025-07-09 16:41:54.953234 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-09 16:41:55.657773 | debian-bookworm | changed 2025-07-09 16:41:55.665281 | 2025-07-09 16:41:55.665456 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-09 16:41:55.699382 | debian-bookworm | skipping: Conditional result was False 2025-07-09 16:41:55.710217 | 2025-07-09 16:41:55.710319 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-09 16:41:56.421835 | debian-bookworm -> localhost | changed 2025-07-09 16:41:56.438501 | 2025-07-09 16:41:56.438909 | TASK [add-build-sshkey : Add back temp key] 2025-07-09 16:41:57.094893 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/aec65b5167e74b6a8b29e690608d4fb8/work/aec65b5167e74b6a8b29e690608d4fb8_id_rsa (zuul-build-sshkey) 2025-07-09 16:41:57.095258 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.028035 2025-07-09 16:41:57.110376 | 2025-07-09 16:41:57.110550 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-09 16:41:57.601128 | debian-bookworm | ok 2025-07-09 16:41:57.607214 | 2025-07-09 16:41:57.607406 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-09 16:41:57.703026 | debian-bookworm | skipping: Conditional result was False 2025-07-09 16:41:57.721060 | 2025-07-09 16:41:57.721507 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-09 16:41:58.200485 | debian-bookworm | ok 2025-07-09 16:41:58.220863 | 2025-07-09 16:41:58.220983 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-09 16:41:58.328596 | debian-bookworm | ok 2025-07-09 16:41:58.351230 | 2025-07-09 16:41:58.351973 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-09 16:41:58.813271 | debian-bookworm -> localhost | ok 2025-07-09 16:41:58.823618 | 2025-07-09 16:41:58.823869 | TASK [validate-host : Collect information about the host] 2025-07-09 16:42:00.062142 | debian-bookworm | ok 2025-07-09 16:42:00.074323 | 2025-07-09 16:42:00.074423 | TASK [validate-host : Sanitize hostname] 2025-07-09 16:42:00.215833 | debian-bookworm | ok 2025-07-09 16:42:00.288078 | 2025-07-09 16:42:00.288189 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-09 16:42:00.950022 | debian-bookworm -> localhost | changed 2025-07-09 16:42:00.955653 | 2025-07-09 16:42:00.955777 | TASK [validate-host : Collect information about zuul worker] 2025-07-09 16:42:01.392086 | debian-bookworm | ok 2025-07-09 16:42:01.396682 | 2025-07-09 16:42:01.396795 | TASK [validate-host : Write out all zuul information for each host] 2025-07-09 16:42:01.845425 | debian-bookworm -> localhost | changed 2025-07-09 16:42:01.853082 | 2025-07-09 16:42:01.853169 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-09 16:42:02.140539 | debian-bookworm | ok 2025-07-09 16:42:02.151923 | 2025-07-09 16:42:02.152029 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-09 16:42:03.050232 | debian-bookworm | changed: 2025-07-09 16:42:03.050406 | debian-bookworm | cd+++++++++ src/ 2025-07-09 16:42:03.050441 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-09 16:42:03.050465 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-09 16:42:03.050486 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-07-09 16:42:03.050506 | debian-bookworm | Containerfile 2025-07-09 16:42:03.050616 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007338 2025-07-09 16:42:29.576397 | 2025-07-09 16:42:29.576620 | TASK [upload-logs : Upload logs to log server] 2025-07-09 16:42:30.201534 | localhost | Output suppressed because no_log was given 2025-07-09 16:42:30.205929 | 2025-07-09 16:42:30.206123 | LOOP [upload-logs : Compress console log and json output] 2025-07-09 16:42:30.260961 | localhost | skipping: Conditional result was False 2025-07-09 16:42:30.266347 | localhost | skipping: Conditional result was False 2025-07-09 16:42:30.279490 | 2025-07-09 16:42:30.279821 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-09 16:42:30.332036 | localhost | skipping: Conditional result was False 2025-07-09 16:42:30.332714 | 2025-07-09 16:42:30.335905 | localhost | skipping: Conditional result was False 2025-07-09 16:42:30.344209 | 2025-07-09 16:42:30.344489 | LOOP [upload-logs : Upload console log and json output]