2025-12-01 20:13:56.352328 | Job console starting 2025-12-01 20:13:56.384016 | Updating git repos 2025-12-01 20:13:56.521488 | Cloning repos into workspace 2025-12-01 20:13:56.629392 | Restoring repo states 2025-12-01 20:13:56.663745 | Merging changes 2025-12-01 20:13:57.305436 | Checking out repos 2025-12-01 20:13:57.369190 | Preparing playbooks 2025-12-01 20:13:58.711259 | Running Ansible setup 2025-12-01 20:14:04.751261 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-01 20:14:06.133034 | 2025-12-01 20:14:06.133216 | PLAY [Base pre] 2025-12-01 20:14:06.160387 | 2025-12-01 20:14:06.160562 | TASK [Setup log path fact] 2025-12-01 20:14:06.190170 | debian-bookworm | ok 2025-12-01 20:14:06.215143 | 2025-12-01 20:14:06.215323 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-01 20:14:06.245095 | debian-bookworm | ok 2025-12-01 20:14:06.256497 | 2025-12-01 20:14:06.256630 | TASK [emit-job-header : Print job information] 2025-12-01 20:14:06.331534 | # Job Information 2025-12-01 20:14:06.331916 | Ansible Version: 2.16.14 2025-12-01 20:14:06.331982 | Job: python-black 2025-12-01 20:14:06.332032 | Pipeline: check 2025-12-01 20:14:06.332071 | Executor: 521e9411259a 2025-12-01 20:14:06.332093 | Triggered by: https://github.com/osism/python-osism/pull/1872 2025-12-01 20:14:06.332128 | Event ID: 3dbe1400-cef2-11f0-906a-ac6a9d260e39 2025-12-01 20:14:06.342058 | 2025-12-01 20:14:06.342208 | LOOP [emit-job-header : Print node information] 2025-12-01 20:14:06.581473 | debian-bookworm | ok: 2025-12-01 20:14:06.581674 | debian-bookworm | # Node Information 2025-12-01 20:14:06.581708 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-01 20:14:06.581733 | debian-bookworm | Hostname: debian 2025-12-01 20:14:06.581775 | debian-bookworm | Username: zuul 2025-12-01 20:14:06.581797 | debian-bookworm | Distro: Debian 12.12 2025-12-01 20:14:06.581821 | debian-bookworm | Provider: regiocloud-a 2025-12-01 20:14:06.581841 | debian-bookworm | Region: 2025-12-01 20:14:06.581862 | debian-bookworm | Label: debian-bookworm 2025-12-01 20:14:06.581881 | debian-bookworm | Product Name: OpenStack Nova 2025-12-01 20:14:06.581900 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed4:1fcc 2025-12-01 20:14:06.600166 | 2025-12-01 20:14:06.600448 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-01 20:14:07.393333 | debian-bookworm -> localhost | changed 2025-12-01 20:14:07.401302 | 2025-12-01 20:14:07.401466 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-01 20:14:09.583970 | debian-bookworm -> localhost | changed 2025-12-01 20:14:09.600151 | 2025-12-01 20:14:09.600390 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-01 20:14:10.271213 | debian-bookworm -> localhost | ok 2025-12-01 20:14:10.277762 | 2025-12-01 20:14:10.277918 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-01 20:14:10.316986 | debian-bookworm | ok 2025-12-01 20:14:10.368348 | debian-bookworm | included: /var/lib/zuul/builds/792fcceaef5d420790ef6a33f5075996/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-01 20:14:10.385557 | 2025-12-01 20:14:10.385819 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-01 20:14:13.908174 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-01 20:14:13.908658 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/792fcceaef5d420790ef6a33f5075996/work/792fcceaef5d420790ef6a33f5075996_id_rsa 2025-12-01 20:14:13.908826 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/792fcceaef5d420790ef6a33f5075996/work/792fcceaef5d420790ef6a33f5075996_id_rsa.pub 2025-12-01 20:14:13.908904 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-01 20:14:13.908968 | debian-bookworm -> localhost | SHA256:4SpSABKTGle3Nw84d/kOMvds8t1n963XLgd1zHZYGrE zuul-build-sshkey 2025-12-01 20:14:13.909025 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-01 20:14:13.909102 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-01 20:14:13.909159 | debian-bookworm -> localhost | |=o .. . .. | 2025-12-01 20:14:13.909224 | debian-bookworm -> localhost | |+o. . o . ...| 2025-12-01 20:14:13.909275 | debian-bookworm -> localhost | |.o. + * o EB | 2025-12-01 20:14:13.909324 | debian-bookworm -> localhost | |. . = * . o B| 2025-12-01 20:14:13.909373 | debian-bookworm -> localhost | | . S + . oo| 2025-12-01 20:14:13.909436 | debian-bookworm -> localhost | | . . + = . | 2025-12-01 20:14:13.909493 | debian-bookworm -> localhost | | . . . . = ..| 2025-12-01 20:14:13.909546 | debian-bookworm -> localhost | | . . + ...O| 2025-12-01 20:14:13.909599 | debian-bookworm -> localhost | | . oBO| 2025-12-01 20:14:13.909650 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-01 20:14:13.909803 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.898824 2025-12-01 20:14:13.932150 | 2025-12-01 20:14:13.933194 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-01 20:14:13.960905 | debian-bookworm | ok 2025-12-01 20:14:13.971269 | debian-bookworm | included: /var/lib/zuul/builds/792fcceaef5d420790ef6a33f5075996/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-01 20:14:13.980141 | 2025-12-01 20:14:13.980236 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-01 20:14:13.993096 | debian-bookworm | skipping: Conditional result was False 2025-12-01 20:14:13.999158 | 2025-12-01 20:14:13.999245 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-01 20:14:14.658343 | debian-bookworm | changed 2025-12-01 20:14:14.666904 | 2025-12-01 20:14:14.667007 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-01 20:14:14.915551 | debian-bookworm | ok 2025-12-01 20:14:14.922700 | 2025-12-01 20:14:14.922823 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-01 20:14:15.596545 | debian-bookworm | changed 2025-12-01 20:14:15.613820 | 2025-12-01 20:14:15.613961 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-01 20:14:16.270618 | debian-bookworm | changed 2025-12-01 20:14:16.276114 | 2025-12-01 20:14:16.276217 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-01 20:14:16.309182 | debian-bookworm | skipping: Conditional result was False 2025-12-01 20:14:16.315768 | 2025-12-01 20:14:16.315876 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-01 20:14:16.915842 | debian-bookworm -> localhost | changed 2025-12-01 20:14:16.931461 | 2025-12-01 20:14:16.931579 | TASK [add-build-sshkey : Add back temp key] 2025-12-01 20:14:17.300193 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/792fcceaef5d420790ef6a33f5075996/work/792fcceaef5d420790ef6a33f5075996_id_rsa (zuul-build-sshkey) 2025-12-01 20:14:17.300417 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009654 2025-12-01 20:14:17.308577 | 2025-12-01 20:14:17.308703 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-01 20:14:17.793959 | debian-bookworm | ok 2025-12-01 20:14:17.799955 | 2025-12-01 20:14:17.800091 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-01 20:14:17.833463 | debian-bookworm | skipping: Conditional result was False 2025-12-01 20:14:17.845494 | 2025-12-01 20:14:17.845641 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-01 20:14:18.429782 | debian-bookworm | ok 2025-12-01 20:14:18.449125 | 2025-12-01 20:14:18.449288 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-01 20:14:18.509052 | debian-bookworm | ok 2025-12-01 20:14:18.515291 | 2025-12-01 20:14:18.515431 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-01 20:14:18.858662 | debian-bookworm -> localhost | ok 2025-12-01 20:14:18.866102 | 2025-12-01 20:14:18.866251 | TASK [validate-host : Collect information about the host] 2025-12-01 20:14:20.044417 | debian-bookworm | ok 2025-12-01 20:14:20.056003 | 2025-12-01 20:14:20.056135 | TASK [validate-host : Sanitize hostname] 2025-12-01 20:14:20.177909 | debian-bookworm | ok 2025-12-01 20:14:20.229176 | 2025-12-01 20:14:20.229330 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-01 20:14:21.295517 | debian-bookworm -> localhost | changed 2025-12-01 20:14:21.302616 | 2025-12-01 20:14:21.302781 | TASK [validate-host : Collect information about zuul worker] 2025-12-01 20:14:21.738537 | debian-bookworm | ok 2025-12-01 20:14:21.746602 | 2025-12-01 20:14:21.746789 | TASK [validate-host : Write out all zuul information for each host] 2025-12-01 20:14:22.522919 | debian-bookworm -> localhost | changed 2025-12-01 20:14:22.532923 | 2025-12-01 20:14:22.533055 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-01 20:14:22.811607 | debian-bookworm | ok 2025-12-01 20:14:22.831521 | 2025-12-01 20:14:22.831665 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-01 20:14:24.116513 | debian-bookworm | changed: 2025-12-01 20:14:24.116835 | debian-bookworm | cd+++++++++ src/ 2025-12-01 20:14:24.116879 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-01 20:14:24.116905 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-01 20:14:24.116926 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-01 20:14:24.116946 | debian-bookworm | Containerfile 2025-12-01 20:14:24.117058 | debian-bookworm | Containerfile 2025-12-01 20:14:24.225729 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007145 2025-12-01 20:14:52.422008 | 2025-12-01 20:14:52.422128 | TASK [upload-logs : Upload logs to log server] 2025-12-01 20:14:53.048672 | localhost | Output suppressed because no_log was given 2025-12-01 20:14:53.054279 | 2025-12-01 20:14:53.054493 | LOOP [upload-logs : Compress console log and json output] 2025-12-01 20:14:53.124403 | localhost | skipping: Conditional result was False 2025-12-01 20:14:53.132972 | localhost | skipping: Conditional result was False 2025-12-01 20:14:53.147164 | 2025-12-01 20:14:53.147415 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-01 20:14:53.195900 | localhost | skipping: Conditional result was False 2025-12-01 20:14:53.196184 | 2025-12-01 20:14:53.201421 | localhost | skipping: Conditional result was False 2025-12-01 20:14:53.211448 | 2025-12-01 20:14:53.211826 | LOOP [upload-logs : Upload console log and json output]