2026-09-19 19:07:10.478279 | Job console starting 2026-09-19 19:07:10.508575 | Updating git repos 2026-09-19 19:07:10.620610 | Cloning repos into workspace 2026-09-19 19:07:10.688133 | Restoring repo states 2026-09-19 19:07:10.710871 | Merging changes 2026-09-19 19:07:11.658713 | Checking out repos 2026-09-19 19:07:11.716493 | Preparing playbooks 2026-09-19 19:07:13.149985 | Running Ansible setup 2026-09-19 19:07:19.040790 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-19 19:07:19.917128 | 2026-09-19 19:07:19.917256 | PLAY [Base pre] 2026-09-19 19:07:19.932010 | 2026-09-19 19:07:19.932109 | TASK [Setup log path fact] 2026-09-19 19:07:19.979178 | debian-bookworm | ok 2026-09-19 19:07:20.008399 | 2026-09-19 19:07:20.008518 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-19 19:07:20.073886 | debian-bookworm | ok 2026-09-19 19:07:20.085068 | 2026-09-19 19:07:20.085173 | TASK [emit-job-header : Print job information] 2026-09-19 19:07:20.149573 | # Job Information 2026-09-19 19:07:20.149713 | Ansible Version: 2.16.14 2026-09-19 19:07:20.149742 | Job: python-black 2026-09-19 19:07:20.149769 | Pipeline: check 2026-09-19 19:07:20.149788 | Executor: 521e9411259a 2026-09-19 19:07:20.149805 | Triggered by: https://github.com/osism/python-osism/pull/2709 2026-09-19 19:07:20.149825 | Event ID: 4a8f9cc0-b45d-11f1-9cc3-e82d6e952d88 2026-09-19 19:07:20.153809 | 2026-09-19 19:07:20.153887 | LOOP [emit-job-header : Print node information] 2026-09-19 19:07:20.384973 | debian-bookworm | ok: 2026-09-19 19:07:20.385170 | debian-bookworm | # Node Information 2026-09-19 19:07:20.385202 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-19 19:07:20.385223 | debian-bookworm | Hostname: debian 2026-09-19 19:07:20.385242 | debian-bookworm | Username: zuul 2026-09-19 19:07:20.385259 | debian-bookworm | Distro: Debian 12.15 2026-09-19 19:07:20.385279 | debian-bookworm | Provider: regiocloud-a 2026-09-19 19:07:20.385296 | debian-bookworm | Region: 2026-09-19 19:07:20.385315 | debian-bookworm | Label: debian-bookworm 2026-09-19 19:07:20.385331 | debian-bookworm | Product Name: OpenStack Nova 2026-09-19 19:07:20.385348 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe01:f06e 2026-09-19 19:07:20.393442 | 2026-09-19 19:07:20.393536 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-19 19:07:21.296352 | debian-bookworm -> localhost | changed 2026-09-19 19:07:21.301908 | 2026-09-19 19:07:21.301991 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-19 19:07:23.236542 | debian-bookworm -> localhost | changed 2026-09-19 19:07:23.245649 | 2026-09-19 19:07:23.245735 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-19 19:07:23.646041 | debian-bookworm -> localhost | ok 2026-09-19 19:07:23.651468 | 2026-09-19 19:07:23.651555 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-19 19:07:23.689388 | debian-bookworm | ok 2026-09-19 19:07:23.714763 | debian-bookworm | included: /var/lib/zuul/builds/be49e41f00274b90a20bb3c6fdeb864a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-19 19:07:23.720592 | 2026-09-19 19:07:23.720667 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-19 19:07:26.034289 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-19 19:07:26.034455 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/be49e41f00274b90a20bb3c6fdeb864a/work/be49e41f00274b90a20bb3c6fdeb864a_id_rsa 2026-09-19 19:07:26.034488 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/be49e41f00274b90a20bb3c6fdeb864a/work/be49e41f00274b90a20bb3c6fdeb864a_id_rsa.pub 2026-09-19 19:07:26.034511 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-19 19:07:26.034532 | debian-bookworm -> localhost | SHA256:57kEpIezHu8WVNfbNmb/a7+nKKtrqgIJyVb5eVsFfLk zuul-build-sshkey 2026-09-19 19:07:26.034551 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-19 19:07:26.034580 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-19 19:07:26.034599 | debian-bookworm -> localhost | | . ... .. | 2026-09-19 19:07:26.034617 | debian-bookworm -> localhost | | o ..+. . | 2026-09-19 19:07:26.034634 | debian-bookworm -> localhost | |... . . ..o.. o | 2026-09-19 19:07:26.034651 | debian-bookworm -> localhost | |oo o =.. E .+o| 2026-09-19 19:07:26.034668 | debian-bookworm -> localhost | |o. =.S . o.o| 2026-09-19 19:07:26.034688 | debian-bookworm -> localhost | |o =.+ . .| 2026-09-19 19:07:26.034705 | debian-bookworm -> localhost | | . o .+ .| 2026-09-19 19:07:26.034722 | debian-bookworm -> localhost | | . . oo... . .o| 2026-09-19 19:07:26.034740 | debian-bookworm -> localhost | | ...o==ooo. o+*| 2026-09-19 19:07:26.034757 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-19 19:07:26.034800 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.697198 2026-09-19 19:07:26.039867 | 2026-09-19 19:07:26.039938 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-19 19:07:26.066907 | debian-bookworm | ok 2026-09-19 19:07:26.086029 | debian-bookworm | included: /var/lib/zuul/builds/be49e41f00274b90a20bb3c6fdeb864a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-19 19:07:26.131408 | 2026-09-19 19:07:26.131502 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-19 19:07:26.164197 | debian-bookworm | skipping: Conditional result was False 2026-09-19 19:07:26.168860 | 2026-09-19 19:07:26.168936 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-19 19:07:26.986433 | debian-bookworm | changed 2026-09-19 19:07:26.990807 | 2026-09-19 19:07:26.990881 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-19 19:07:27.265458 | debian-bookworm | ok 2026-09-19 19:07:27.269919 | 2026-09-19 19:07:27.269991 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-19 19:07:27.874054 | debian-bookworm | changed 2026-09-19 19:07:27.880276 | 2026-09-19 19:07:27.880368 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-19 19:07:28.511084 | debian-bookworm | changed 2026-09-19 19:07:28.515453 | 2026-09-19 19:07:28.515526 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-19 19:07:28.539907 | debian-bookworm | skipping: Conditional result was False 2026-09-19 19:07:28.546988 | 2026-09-19 19:07:28.547073 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-19 19:07:28.958681 | debian-bookworm -> localhost | changed 2026-09-19 19:07:28.970192 | 2026-09-19 19:07:28.970418 | TASK [add-build-sshkey : Add back temp key] 2026-09-19 19:07:29.399617 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/be49e41f00274b90a20bb3c6fdeb864a/work/be49e41f00274b90a20bb3c6fdeb864a_id_rsa (zuul-build-sshkey) 2026-09-19 19:07:29.399824 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020538 2026-09-19 19:07:29.408543 | 2026-09-19 19:07:29.408645 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-19 19:07:30.020497 | debian-bookworm | ok 2026-09-19 19:07:30.030502 | 2026-09-19 19:07:30.030599 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-19 19:07:30.063679 | debian-bookworm | skipping: Conditional result was False 2026-09-19 19:07:30.080668 | 2026-09-19 19:07:30.080772 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-19 19:07:30.645443 | debian-bookworm | ok 2026-09-19 19:07:30.657255 | 2026-09-19 19:07:30.657346 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-19 19:07:30.695072 | debian-bookworm | ok 2026-09-19 19:07:30.701217 | 2026-09-19 19:07:30.701303 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-19 19:07:31.012903 | debian-bookworm -> localhost | ok 2026-09-19 19:07:31.019359 | 2026-09-19 19:07:31.019447 | TASK [validate-host : Collect information about the host] 2026-09-19 19:07:32.370325 | debian-bookworm | ok 2026-09-19 19:07:32.388600 | 2026-09-19 19:07:32.388703 | TASK [validate-host : Sanitize hostname] 2026-09-19 19:07:32.527940 | debian-bookworm | ok 2026-09-19 19:07:32.532377 | 2026-09-19 19:07:32.532464 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-19 19:07:33.225845 | debian-bookworm -> localhost | changed 2026-09-19 19:07:33.230367 | 2026-09-19 19:07:33.230448 | TASK [validate-host : Collect information about zuul worker] 2026-09-19 19:07:33.650898 | debian-bookworm | ok 2026-09-19 19:07:33.655662 | 2026-09-19 19:07:33.655740 | TASK [validate-host : Write out all zuul information for each host] 2026-09-19 19:07:34.449716 | debian-bookworm -> localhost | changed 2026-09-19 19:07:34.458127 | 2026-09-19 19:07:34.458234 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-19 19:07:34.802902 | debian-bookworm | ok 2026-09-19 19:07:34.811955 | 2026-09-19 19:07:34.812056 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-19 19:07:36.857059 | debian-bookworm | changed: 2026-09-19 19:07:36.857249 | debian-bookworm | cd+++++++++ src/ 2026-09-19 19:07:36.857285 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-19 19:07:36.857309 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-19 19:07:36.857330 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-09-19 19:07:36.857351 | debian-bookworm | Containerfile 2026-09-19 19:07:36.857483 | debian-bookworm | Containerfile 2026-09-19 19:07:36.876828 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/be49e41f00274b90a20bb3c6fdeb864a/work/logs" 2026-09-19 19:08:54.426202 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/be49e41f00274b90a20bb3c6fdeb864a/work/artifacts" 2026-09-19 19:08:54.710331 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/be49e41f00274b90a20bb3c6fdeb864a/work/docs" 2026-09-19 19:08:54.727320 | 2026-09-19 19:08:54.727463 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-19 19:08:55.543876 | debian-bookworm | changed: 2026-09-19 19:08:55.544274 | debian-bookworm | .d..t...... ./ 2026-09-19 19:08:55.544344 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-19 19:08:55.544388 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-19 19:08:55.544428 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-19 19:08:55.544467 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-19 19:08:55.544501 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-19 19:08:55.544561 | debian-bookworm | changed: All items complete 2026-09-19 19:08:55.544604 | 2026-09-19 19:08:56.111328 | debian-bookworm | changed: .d..t...... ./ 2026-09-19 19:08:56.691280 | debian-bookworm | changed: .d..t...... ./ 2026-09-19 19:08:56.712777 | 2026-09-19 19:08:56.712898 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-19 19:08:57.023488 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.008224 2026-09-19 19:08:57.325042 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008653 2026-09-19 19:08:57.347107 | 2026-09-19 19:08:57.347304 | PLAY RECAP 2026-09-19 19:08:57.347395 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-19 19:08:57.347437 | 2026-09-19 19:08:57.482388 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-19 19:08:57.484411 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-19 19:08:58.325897 | 2026-09-19 19:08:58.326063 | PLAY [Base post] 2026-09-19 19:08:58.339550 | 2026-09-19 19:08:58.339684 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-19 19:08:59.079945 | debian-bookworm | changed 2026-09-19 19:08:59.086471 | 2026-09-19 19:08:59.086582 | PLAY RECAP 2026-09-19 19:08:59.086643 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-19 19:08:59.086727 | 2026-09-19 19:08:59.311472 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-19 19:08:59.312321 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-19 19:09:00.123085 | 2026-09-19 19:09:00.123284 | PLAY [Base post-logs] 2026-09-19 19:09:00.133692 | 2026-09-19 19:09:00.133825 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-19 19:09:00.585024 | localhost | changed 2026-09-19 19:09:00.595049 | 2026-09-19 19:09:00.595218 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-19 19:09:00.630737 | localhost | ok 2026-09-19 19:09:00.634688 | 2026-09-19 19:09:00.634812 | TASK [Set zuul-log-path fact] 2026-09-19 19:09:00.660987 | localhost | ok 2026-09-19 19:09:00.672557 | 2026-09-19 19:09:00.672682 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-19 19:09:00.707590 | localhost | ok 2026-09-19 19:09:00.710915 | 2026-09-19 19:09:00.711028 | TASK [upload-logs : Create log directories] 2026-09-19 19:09:01.204873 | localhost | changed 2026-09-19 19:09:01.207853 | 2026-09-19 19:09:01.207961 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-19 19:09:01.667426 | localhost -> localhost | ok: Runtime: 0:00:00.004694 2026-09-19 19:09:01.672986 | 2026-09-19 19:09:01.673132 | TASK [upload-logs : Upload logs to log server] 2026-09-19 19:09:02.213893 | localhost | Output suppressed because no_log was given 2026-09-19 19:09:02.216731 | 2026-09-19 19:09:02.216883 | LOOP [upload-logs : Compress console log and json output] 2026-09-19 19:09:02.269794 | localhost | skipping: Conditional result was False 2026-09-19 19:09:02.275037 | localhost | skipping: Conditional result was False 2026-09-19 19:09:02.288188 | 2026-09-19 19:09:02.288423 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-19 19:09:02.335521 | localhost | skipping: Conditional result was False 2026-09-19 19:09:02.336174 | 2026-09-19 19:09:02.340455 | localhost | skipping: Conditional result was False 2026-09-19 19:09:02.352229 | 2026-09-19 19:09:02.352406 | LOOP [upload-logs : Upload console log and json output]