2025-08-27 09:51:41.123453 | Job console starting 2025-08-27 09:51:41.157496 | Updating git repos 2025-08-27 09:51:41.221286 | Cloning repos into workspace 2025-08-27 09:51:41.320508 | Restoring repo states 2025-08-27 09:51:41.344215 | Merging changes 2025-08-27 09:51:41.971823 | Checking out repos 2025-08-27 09:51:42.046810 | Preparing playbooks 2025-08-27 09:51:43.305898 | Running Ansible setup 2025-08-27 09:51:49.319506 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-27 09:51:50.331315 | 2025-08-27 09:51:50.331505 | PLAY [Base pre] 2025-08-27 09:51:50.361368 | 2025-08-27 09:51:50.361549 | TASK [Setup log path fact] 2025-08-27 09:51:50.399417 | debian-bookworm | ok 2025-08-27 09:51:50.425210 | 2025-08-27 09:51:50.425378 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-27 09:51:50.474152 | debian-bookworm | ok 2025-08-27 09:51:50.492801 | 2025-08-27 09:51:50.492942 | TASK [emit-job-header : Print job information] 2025-08-27 09:51:50.559602 | # Job Information 2025-08-27 09:51:50.559800 | Ansible Version: 2.16.14 2025-08-27 09:51:50.559836 | Job: python-black 2025-08-27 09:51:50.559869 | Pipeline: check 2025-08-27 09:51:50.559893 | Executor: 521e9411259a 2025-08-27 09:51:50.559914 | Triggered by: https://github.com/osism/python-osism/pull/1692 2025-08-27 09:51:50.559936 | Event ID: 69b5a630-832b-11f0-9367-a9f86f868145 2025-08-27 09:51:50.564849 | 2025-08-27 09:51:50.564963 | LOOP [emit-job-header : Print node information] 2025-08-27 09:51:50.785259 | debian-bookworm | ok: 2025-08-27 09:51:50.785537 | debian-bookworm | # Node Information 2025-08-27 09:51:50.785574 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-27 09:51:50.785599 | debian-bookworm | Hostname: debian 2025-08-27 09:51:50.785622 | debian-bookworm | Username: zuul 2025-08-27 09:51:50.785643 | debian-bookworm | Distro: Debian 12.11 2025-08-27 09:51:50.785667 | debian-bookworm | Provider: regiocloud-a 2025-08-27 09:51:50.785687 | debian-bookworm | Region: 2025-08-27 09:51:50.785708 | debian-bookworm | Label: debian-bookworm 2025-08-27 09:51:50.785728 | debian-bookworm | Product Name: OpenStack Nova 2025-08-27 09:51:50.785748 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3c:2340 2025-08-27 09:51:50.809338 | 2025-08-27 09:51:50.809505 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-27 09:51:51.717330 | debian-bookworm -> localhost | changed 2025-08-27 09:51:51.724849 | 2025-08-27 09:51:51.724993 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-27 09:51:53.827347 | debian-bookworm -> localhost | changed 2025-08-27 09:51:53.837858 | 2025-08-27 09:51:53.837956 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-27 09:51:54.211802 | debian-bookworm -> localhost | ok 2025-08-27 09:51:54.218144 | 2025-08-27 09:51:54.218244 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-27 09:51:54.245616 | debian-bookworm | ok 2025-08-27 09:51:54.271901 | debian-bookworm | included: /var/lib/zuul/builds/c3718cab7bfa4e60b7ad6512a53df70d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-27 09:51:54.287828 | 2025-08-27 09:51:54.287930 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-27 09:51:55.987197 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-27 09:51:55.987444 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c3718cab7bfa4e60b7ad6512a53df70d/work/c3718cab7bfa4e60b7ad6512a53df70d_id_rsa 2025-08-27 09:51:55.987491 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c3718cab7bfa4e60b7ad6512a53df70d/work/c3718cab7bfa4e60b7ad6512a53df70d_id_rsa.pub 2025-08-27 09:51:55.987521 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-27 09:51:55.987546 | debian-bookworm -> localhost | SHA256:72OMR327cKCQ4NMn932DiuYnRTUoIbBsAPsqYPJyXNM zuul-build-sshkey 2025-08-27 09:51:55.987569 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-27 09:51:55.987599 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-27 09:51:55.987623 | debian-bookworm -> localhost | | ... ... .. . | 2025-08-27 09:51:55.987645 | debian-bookworm -> localhost | | . o . .. . o | 2025-08-27 09:51:55.987665 | debian-bookworm -> localhost | | . +. . . . | 2025-08-27 09:51:55.987686 | debian-bookworm -> localhost | | . .o o . . | 2025-08-27 09:51:55.987706 | debian-bookworm -> localhost | |o. .o E S +.. | 2025-08-27 09:51:55.987729 | debian-bookworm -> localhost | |+o.. . . *.+.oo | 2025-08-27 09:51:55.987750 | debian-bookworm -> localhost | |o.+ ++ oooo.| 2025-08-27 09:51:55.987769 | debian-bookworm -> localhost | |.o .+*..o...| 2025-08-27 09:51:55.987789 | debian-bookworm -> localhost | | o=+o .. | 2025-08-27 09:51:55.987810 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-27 09:51:55.987863 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.025375 2025-08-27 09:51:55.993828 | 2025-08-27 09:51:55.993906 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-27 09:51:56.011108 | debian-bookworm | ok 2025-08-27 09:51:56.019637 | debian-bookworm | included: /var/lib/zuul/builds/c3718cab7bfa4e60b7ad6512a53df70d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-27 09:51:56.028008 | 2025-08-27 09:51:56.028085 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-27 09:51:56.040969 | debian-bookworm | skipping: Conditional result was False 2025-08-27 09:51:56.047677 | 2025-08-27 09:51:56.047776 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-27 09:51:56.666197 | debian-bookworm | changed 2025-08-27 09:51:56.674480 | 2025-08-27 09:51:56.674585 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-27 09:51:56.927282 | debian-bookworm | ok 2025-08-27 09:51:56.932564 | 2025-08-27 09:51:56.932654 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-27 09:51:57.591223 | debian-bookworm | changed 2025-08-27 09:51:57.597579 | 2025-08-27 09:51:57.597669 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-27 09:51:58.221699 | debian-bookworm | changed 2025-08-27 09:51:58.232700 | 2025-08-27 09:51:58.232837 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-27 09:51:58.248361 | debian-bookworm | skipping: Conditional result was False 2025-08-27 09:51:58.256165 | 2025-08-27 09:51:58.256264 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-27 09:51:58.826299 | debian-bookworm -> localhost | changed 2025-08-27 09:51:58.839057 | 2025-08-27 09:51:58.839159 | TASK [add-build-sshkey : Add back temp key] 2025-08-27 09:51:59.296954 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c3718cab7bfa4e60b7ad6512a53df70d/work/c3718cab7bfa4e60b7ad6512a53df70d_id_rsa (zuul-build-sshkey) 2025-08-27 09:51:59.297161 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021718 2025-08-27 09:51:59.304899 | 2025-08-27 09:51:59.304994 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-27 09:51:59.738629 | debian-bookworm | ok 2025-08-27 09:51:59.746151 | 2025-08-27 09:51:59.746269 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-27 09:51:59.780040 | debian-bookworm | skipping: Conditional result was False 2025-08-27 09:51:59.794879 | 2025-08-27 09:51:59.795017 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-27 09:52:00.229044 | debian-bookworm | ok 2025-08-27 09:52:00.244945 | 2025-08-27 09:52:00.245070 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-27 09:52:00.283020 | debian-bookworm | ok 2025-08-27 09:52:00.291128 | 2025-08-27 09:52:00.291222 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-27 09:52:00.815401 | debian-bookworm -> localhost | ok 2025-08-27 09:52:00.821351 | 2025-08-27 09:52:00.821431 | TASK [validate-host : Collect information about the host] 2025-08-27 09:52:01.965135 | debian-bookworm | ok 2025-08-27 09:52:01.976010 | 2025-08-27 09:52:01.976105 | TASK [validate-host : Sanitize hostname] 2025-08-27 09:52:02.095095 | debian-bookworm | ok 2025-08-27 09:52:02.161231 | 2025-08-27 09:52:02.161350 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-27 09:52:02.893921 | debian-bookworm -> localhost | changed 2025-08-27 09:52:02.899818 | 2025-08-27 09:52:02.899926 | TASK [validate-host : Collect information about zuul worker] 2025-08-27 09:52:03.537322 | debian-bookworm | ok 2025-08-27 09:52:03.542468 | 2025-08-27 09:52:03.542589 | TASK [validate-host : Write out all zuul information for each host] 2025-08-27 09:52:04.387326 | debian-bookworm -> localhost | changed 2025-08-27 09:52:04.400293 | 2025-08-27 09:52:04.400413 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-27 09:52:04.694306 | debian-bookworm | ok 2025-08-27 09:52:04.710539 | 2025-08-27 09:52:04.710668 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-27 09:52:05.885555 | debian-bookworm | changed: 2025-08-27 09:52:05.885893 | debian-bookworm | cd+++++++++ src/ 2025-08-27 09:52:05.885932 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-27 09:52:05.885957 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-27 09:52:05.885980 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-27 09:52:05.886001 | debian-bookworm | Containerfile 2025-08-27 09:52:05.886120 | debian-bookworm | Containerfile 2025-08-27 09:52:05.900431 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006893 2025-08-27 09:52:32.388082 | 2025-08-27 09:52:32.388244 | TASK [upload-logs : Upload logs to log server] 2025-08-27 09:52:32.957405 | localhost | Output suppressed because no_log was given 2025-08-27 09:52:32.961542 | 2025-08-27 09:52:32.961734 | LOOP [upload-logs : Compress console log and json output] 2025-08-27 09:52:33.016709 | localhost | skipping: Conditional result was False 2025-08-27 09:52:33.022312 | localhost | skipping: Conditional result was False 2025-08-27 09:52:33.034306 | 2025-08-27 09:52:33.034572 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-27 09:52:33.091888 | localhost | skipping: Conditional result was False 2025-08-27 09:52:33.092619 | 2025-08-27 09:52:33.095947 | localhost | skipping: Conditional result was False 2025-08-27 09:52:33.108663 | 2025-08-27 09:52:33.108879 | LOOP [upload-logs : Upload console log and json output]