2025-12-04 21:11:22.617968 | Job console starting 2025-12-04 21:11:22.630440 | Updating git repos 2025-12-04 21:11:22.679182 | Cloning repos into workspace 2025-12-04 21:11:22.817709 | Restoring repo states 2025-12-04 21:11:22.846865 | Merging changes 2025-12-04 21:11:23.586647 | Checking out repos 2025-12-04 21:11:23.659938 | Preparing playbooks 2025-12-04 21:11:24.754405 | Running Ansible setup 2025-12-04 21:11:30.776988 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-04 21:11:31.737286 | 2025-12-04 21:11:31.737476 | PLAY [Base pre] 2025-12-04 21:11:31.754933 | 2025-12-04 21:11:31.755092 | TASK [Setup log path fact] 2025-12-04 21:11:31.785795 | debian-bookworm | ok 2025-12-04 21:11:31.814629 | 2025-12-04 21:11:31.814882 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-04 21:11:31.876816 | debian-bookworm | ok 2025-12-04 21:11:31.899662 | 2025-12-04 21:11:31.899809 | TASK [emit-job-header : Print job information] 2025-12-04 21:11:31.965152 | # Job Information 2025-12-04 21:11:31.965355 | Ansible Version: 2.16.14 2025-12-04 21:11:31.965392 | Job: python-black 2025-12-04 21:11:31.965424 | Pipeline: check 2025-12-04 21:11:31.965447 | Executor: 521e9411259a 2025-12-04 21:11:31.965468 | Triggered by: https://github.com/osism/python-osism/pull/1897 2025-12-04 21:11:31.965490 | Event ID: 6545e470-d155-11f0-9d7f-17977e7270b3 2025-12-04 21:11:31.970539 | 2025-12-04 21:11:31.970662 | LOOP [emit-job-header : Print node information] 2025-12-04 21:11:32.107518 | debian-bookworm | ok: 2025-12-04 21:11:32.107715 | debian-bookworm | # Node Information 2025-12-04 21:11:32.107749 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-04 21:11:32.107775 | debian-bookworm | Hostname: debian 2025-12-04 21:11:32.107871 | debian-bookworm | Username: zuul 2025-12-04 21:11:32.107898 | debian-bookworm | Distro: Debian 12.12 2025-12-04 21:11:32.107925 | debian-bookworm | Provider: regiocloud-a 2025-12-04 21:11:32.107947 | debian-bookworm | Region: 2025-12-04 21:11:32.107969 | debian-bookworm | Label: debian-bookworm 2025-12-04 21:11:32.107990 | debian-bookworm | Product Name: OpenStack Nova 2025-12-04 21:11:32.108009 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5b:2c43 2025-12-04 21:11:32.121217 | 2025-12-04 21:11:32.121403 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-04 21:11:32.889405 | debian-bookworm -> localhost | changed 2025-12-04 21:11:32.897180 | 2025-12-04 21:11:32.897351 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-04 21:11:34.756611 | debian-bookworm -> localhost | changed 2025-12-04 21:11:34.773157 | 2025-12-04 21:11:34.773382 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-04 21:11:35.245206 | debian-bookworm -> localhost | ok 2025-12-04 21:11:35.254168 | 2025-12-04 21:11:35.254372 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-04 21:11:35.306782 | debian-bookworm | ok 2025-12-04 21:11:35.336439 | debian-bookworm | included: /var/lib/zuul/builds/8cab5f6053ac4ea5b88cbfca5956b7db/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-04 21:11:35.343334 | 2025-12-04 21:11:35.343444 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-04 21:11:38.457095 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-04 21:11:38.457541 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8cab5f6053ac4ea5b88cbfca5956b7db/work/8cab5f6053ac4ea5b88cbfca5956b7db_id_rsa 2025-12-04 21:11:38.457631 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8cab5f6053ac4ea5b88cbfca5956b7db/work/8cab5f6053ac4ea5b88cbfca5956b7db_id_rsa.pub 2025-12-04 21:11:38.457692 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-04 21:11:38.457749 | debian-bookworm -> localhost | SHA256:ZajCGsSm31ZBZw0nZNO04pp+/M2ShonGfXhuvz5oHAs zuul-build-sshkey 2025-12-04 21:11:38.457800 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-04 21:11:38.457880 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-04 21:11:38.457931 | debian-bookworm -> localhost | | ..O=o | 2025-12-04 21:11:38.457981 | debian-bookworm -> localhost | | . . + =o. | 2025-12-04 21:11:38.458027 | debian-bookworm -> localhost | | + . o + | 2025-12-04 21:11:38.458073 | debian-bookworm -> localhost | | + . + + | 2025-12-04 21:11:38.458117 | debian-bookworm -> localhost | |. . o o S | 2025-12-04 21:11:38.458175 | debian-bookworm -> localhost | | . + o oE . | 2025-12-04 21:11:38.458222 | debian-bookworm -> localhost | | o o.o+ * = | 2025-12-04 21:11:38.458269 | debian-bookworm -> localhost | | . .+ B %o. | 2025-12-04 21:11:38.458344 | debian-bookworm -> localhost | | ... Oo+*o | 2025-12-04 21:11:38.458393 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-04 21:11:38.458502 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.327341 2025-12-04 21:11:38.475689 | 2025-12-04 21:11:38.475845 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-04 21:11:38.513702 | debian-bookworm | ok 2025-12-04 21:11:38.523802 | debian-bookworm | included: /var/lib/zuul/builds/8cab5f6053ac4ea5b88cbfca5956b7db/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-04 21:11:38.533500 | 2025-12-04 21:11:38.533654 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-04 21:11:38.557900 | debian-bookworm | skipping: Conditional result was False 2025-12-04 21:11:38.564443 | 2025-12-04 21:11:38.564589 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-04 21:11:39.345969 | debian-bookworm | changed 2025-12-04 21:11:39.353337 | 2025-12-04 21:11:39.353475 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-04 21:11:39.629267 | debian-bookworm | ok 2025-12-04 21:11:39.636485 | 2025-12-04 21:11:39.636651 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-04 21:11:40.381536 | debian-bookworm | changed 2025-12-04 21:11:40.391293 | 2025-12-04 21:11:40.391462 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-04 21:11:41.091572 | debian-bookworm | changed 2025-12-04 21:11:41.102769 | 2025-12-04 21:11:41.102953 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-04 21:11:41.128361 | debian-bookworm | skipping: Conditional result was False 2025-12-04 21:11:41.147785 | 2025-12-04 21:11:41.147985 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-04 21:11:41.988630 | debian-bookworm -> localhost | changed 2025-12-04 21:11:42.002256 | 2025-12-04 21:11:42.002418 | TASK [add-build-sshkey : Add back temp key] 2025-12-04 21:11:42.459673 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8cab5f6053ac4ea5b88cbfca5956b7db/work/8cab5f6053ac4ea5b88cbfca5956b7db_id_rsa (zuul-build-sshkey) 2025-12-04 21:11:42.459923 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.023519 2025-12-04 21:11:42.468913 | 2025-12-04 21:11:42.469054 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-04 21:11:42.914403 | debian-bookworm | ok 2025-12-04 21:11:42.924661 | 2025-12-04 21:11:42.925221 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-04 21:11:42.962075 | debian-bookworm | skipping: Conditional result was False 2025-12-04 21:11:42.976965 | 2025-12-04 21:11:42.977106 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-04 21:11:43.489733 | debian-bookworm | ok 2025-12-04 21:11:43.506761 | 2025-12-04 21:11:43.506983 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-04 21:11:43.574622 | debian-bookworm | ok 2025-12-04 21:11:43.584970 | 2025-12-04 21:11:43.585112 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-04 21:11:43.986655 | debian-bookworm -> localhost | ok 2025-12-04 21:11:43.993710 | 2025-12-04 21:11:43.993831 | TASK [validate-host : Collect information about the host] 2025-12-04 21:11:45.246774 | debian-bookworm | ok 2025-12-04 21:11:45.258067 | 2025-12-04 21:11:45.258197 | TASK [validate-host : Sanitize hostname] 2025-12-04 21:11:45.379787 | debian-bookworm | ok 2025-12-04 21:11:45.448519 | 2025-12-04 21:11:45.448666 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-04 21:11:46.138039 | debian-bookworm -> localhost | changed 2025-12-04 21:11:46.147027 | 2025-12-04 21:11:46.147173 | TASK [validate-host : Collect information about zuul worker] 2025-12-04 21:11:46.598543 | debian-bookworm | ok 2025-12-04 21:11:46.605016 | 2025-12-04 21:11:46.605909 | TASK [validate-host : Write out all zuul information for each host] 2025-12-04 21:11:47.762655 | debian-bookworm -> localhost | changed 2025-12-04 21:11:47.779915 | 2025-12-04 21:11:47.780060 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-04 21:11:48.073968 | debian-bookworm | ok 2025-12-04 21:11:48.083142 | 2025-12-04 21:11:48.083276 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-04 21:11:49.554210 | debian-bookworm | changed: 2025-12-04 21:11:49.554514 | debian-bookworm | cd+++++++++ src/ 2025-12-04 21:11:49.554575 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-04 21:11:49.554603 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-04 21:11:49.554626 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-04 21:11:49.554647 | debian-bookworm | Containerfile 2025-12-04 21:11:49.554778 | debian-bookworm | Containerfile 2025-12-04 21:11:49.620279 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009652 2025-12-04 21:12:20.846651 | 2025-12-04 21:12:20.846773 | TASK [upload-logs : Upload logs to log server] 2025-12-04 21:12:22.108885 | localhost | Output suppressed because no_log was given 2025-12-04 21:12:22.113212 | 2025-12-04 21:12:22.113401 | LOOP [upload-logs : Compress console log and json output] 2025-12-04 21:12:22.369393 | localhost | skipping: Conditional result was False 2025-12-04 21:12:22.389491 | localhost | skipping: Conditional result was False 2025-12-04 21:12:22.395880 | 2025-12-04 21:12:22.396027 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-04 21:12:22.559872 | localhost | skipping: Conditional result was False 2025-12-04 21:12:22.560195 | 2025-12-04 21:12:22.582345 | localhost | skipping: Conditional result was False 2025-12-04 21:12:22.599190 | 2025-12-04 21:12:22.599440 | LOOP [upload-logs : Upload console log and json output]