2026-09-04 19:18:13.828915 | Job console starting 2026-09-04 19:18:13.840864 | Updating git repos 2026-09-04 19:18:13.895052 | Cloning repos into workspace 2026-09-04 19:18:13.950252 | Restoring repo states 2026-09-04 19:18:13.969834 | Merging changes 2026-09-04 19:18:14.532413 | Checking out repos 2026-09-04 19:18:14.556751 | Preparing playbooks 2026-09-04 19:18:15.242469 | Running Ansible setup 2026-09-04 19:18:19.664401 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-04 19:18:20.448709 | 2026-09-04 19:18:20.448886 | PLAY [Base pre] 2026-09-04 19:18:20.492963 | 2026-09-04 19:18:20.493122 | TASK [Setup log path fact] 2026-09-04 19:18:20.523133 | debian-bookworm | ok 2026-09-04 19:18:20.542415 | 2026-09-04 19:18:20.542672 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-04 19:18:20.571750 | debian-bookworm | ok 2026-09-04 19:18:20.582026 | 2026-09-04 19:18:20.582134 | TASK [emit-job-header : Print job information] 2026-09-04 19:18:20.622174 | # Job Information 2026-09-04 19:18:20.622357 | Ansible Version: 2.16.14 2026-09-04 19:18:20.622392 | Job: python-black 2026-09-04 19:18:20.622425 | Pipeline: check 2026-09-04 19:18:20.622449 | Executor: 521e9411259a 2026-09-04 19:18:20.622470 | Triggered by: https://github.com/osism/generics/pull/616 2026-09-04 19:18:20.622492 | Event ID: fa65fc90-a894-11f1-866e-d3bac1fe3c21 2026-09-04 19:18:20.627580 | 2026-09-04 19:18:20.627691 | LOOP [emit-job-header : Print node information] 2026-09-04 19:18:20.760144 | debian-bookworm | ok: 2026-09-04 19:18:20.760406 | debian-bookworm | # Node Information 2026-09-04 19:18:20.760443 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-04 19:18:20.760468 | debian-bookworm | Hostname: debian 2026-09-04 19:18:20.760491 | debian-bookworm | Username: zuul 2026-09-04 19:18:20.760512 | debian-bookworm | Distro: Debian 12.15 2026-09-04 19:18:20.760535 | debian-bookworm | Provider: regiocloud-a 2026-09-04 19:18:20.760556 | debian-bookworm | Region: 2026-09-04 19:18:20.760577 | debian-bookworm | Label: debian-bookworm 2026-09-04 19:18:20.760598 | debian-bookworm | Product Name: OpenStack Nova 2026-09-04 19:18:20.760617 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe88:6fff 2026-09-04 19:18:20.776902 | 2026-09-04 19:18:20.777049 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-04 19:18:21.285365 | debian-bookworm -> localhost | changed 2026-09-04 19:18:21.293827 | 2026-09-04 19:18:21.293949 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-04 19:18:22.415189 | debian-bookworm -> localhost | changed 2026-09-04 19:18:22.427184 | 2026-09-04 19:18:22.427302 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-04 19:18:22.737146 | debian-bookworm -> localhost | ok 2026-09-04 19:18:22.744183 | 2026-09-04 19:18:22.744307 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-04 19:18:22.776948 | debian-bookworm | ok 2026-09-04 19:18:22.802594 | debian-bookworm | included: /var/lib/zuul/builds/75ef524c2be74ed4a984f7064f99e81b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-04 19:18:22.810980 | 2026-09-04 19:18:22.811098 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-04 19:18:23.660529 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-04 19:18:23.660978 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/75ef524c2be74ed4a984f7064f99e81b/work/75ef524c2be74ed4a984f7064f99e81b_id_rsa 2026-09-04 19:18:23.661070 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/75ef524c2be74ed4a984f7064f99e81b/work/75ef524c2be74ed4a984f7064f99e81b_id_rsa.pub 2026-09-04 19:18:23.661132 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-04 19:18:23.661190 | debian-bookworm -> localhost | SHA256:LKjF/CBBAy5AhMWWA8FmXIsuNc3196Uy+Dx3J4yk8H0 zuul-build-sshkey 2026-09-04 19:18:23.661265 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-04 19:18:23.661354 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-04 19:18:23.661408 | debian-bookworm -> localhost | |@O=o . | 2026-09-04 19:18:23.661486 | debian-bookworm -> localhost | |+**+.. . | 2026-09-04 19:18:23.661558 | debian-bookworm -> localhost | |+++oo . . . | 2026-09-04 19:18:23.661632 | debian-bookworm -> localhost | |o. = . . o . o | 2026-09-04 19:18:23.661705 | debian-bookworm -> localhost | |... * . S o + | 2026-09-04 19:18:23.661764 | debian-bookworm -> localhost | |. + o . = * o | 2026-09-04 19:18:23.661838 | debian-bookworm -> localhost | | . . * + E .| 2026-09-04 19:18:23.661886 | debian-bookworm -> localhost | | o o o | 2026-09-04 19:18:23.661937 | debian-bookworm -> localhost | | | 2026-09-04 19:18:23.661984 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-04 19:18:23.662095 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.293299 2026-09-04 19:18:23.673883 | 2026-09-04 19:18:23.674015 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-04 19:18:23.706973 | debian-bookworm | ok 2026-09-04 19:18:23.720973 | debian-bookworm | included: /var/lib/zuul/builds/75ef524c2be74ed4a984f7064f99e81b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-04 19:18:23.729453 | 2026-09-04 19:18:23.730084 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-04 19:18:23.753478 | debian-bookworm | skipping: Conditional result was False 2026-09-04 19:18:23.760198 | 2026-09-04 19:18:23.760298 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-04 19:18:24.449016 | debian-bookworm | changed 2026-09-04 19:18:24.454884 | 2026-09-04 19:18:24.455000 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-04 19:18:24.716754 | debian-bookworm | ok 2026-09-04 19:18:24.724932 | 2026-09-04 19:18:24.725051 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-04 19:18:25.371766 | debian-bookworm | changed 2026-09-04 19:18:25.385597 | 2026-09-04 19:18:25.385746 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-04 19:18:26.060659 | debian-bookworm | changed 2026-09-04 19:18:26.070659 | 2026-09-04 19:18:26.070823 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-04 19:18:26.105436 | debian-bookworm | skipping: Conditional result was False 2026-09-04 19:18:26.112681 | 2026-09-04 19:18:26.112834 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-04 19:18:26.627889 | debian-bookworm -> localhost | changed 2026-09-04 19:18:26.643675 | 2026-09-04 19:18:26.643836 | TASK [add-build-sshkey : Add back temp key] 2026-09-04 19:18:27.005572 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/75ef524c2be74ed4a984f7064f99e81b/work/75ef524c2be74ed4a984f7064f99e81b_id_rsa (zuul-build-sshkey) 2026-09-04 19:18:27.005829 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018428 2026-09-04 19:18:27.014585 | 2026-09-04 19:18:27.014702 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-04 19:18:27.438467 | debian-bookworm | ok 2026-09-04 19:18:27.445308 | 2026-09-04 19:18:27.445430 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-04 19:18:27.469533 | debian-bookworm | skipping: Conditional result was False 2026-09-04 19:18:27.480043 | 2026-09-04 19:18:27.480146 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-04 19:18:27.952893 | debian-bookworm | ok 2026-09-04 19:18:27.969443 | 2026-09-04 19:18:27.969566 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-04 19:18:28.016412 | debian-bookworm | ok 2026-09-04 19:18:28.025234 | 2026-09-04 19:18:28.025354 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-04 19:18:28.333633 | debian-bookworm -> localhost | ok 2026-09-04 19:18:28.345546 | 2026-09-04 19:18:28.345682 | TASK [validate-host : Collect information about the host] 2026-09-04 19:18:29.456996 | debian-bookworm | ok 2026-09-04 19:18:29.475063 | 2026-09-04 19:18:29.475184 | TASK [validate-host : Sanitize hostname] 2026-09-04 19:18:29.648649 | debian-bookworm | ok 2026-09-04 19:18:29.655213 | 2026-09-04 19:18:29.655334 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-04 19:18:30.230894 | debian-bookworm -> localhost | changed 2026-09-04 19:18:30.243337 | 2026-09-04 19:18:30.243510 | TASK [validate-host : Collect information about zuul worker] 2026-09-04 19:18:30.657337 | debian-bookworm | ok 2026-09-04 19:18:30.665018 | 2026-09-04 19:18:30.665161 | TASK [validate-host : Write out all zuul information for each host] 2026-09-04 19:18:31.310632 | debian-bookworm -> localhost | changed 2026-09-04 19:18:31.338680 | 2026-09-04 19:18:31.338859 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-04 19:18:31.641621 | debian-bookworm | ok 2026-09-04 19:18:31.650672 | 2026-09-04 19:18:31.650873 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-04 19:18:32.556196 | debian-bookworm | changed: 2026-09-04 19:18:32.556411 | debian-bookworm | cd+++++++++ src/ 2026-09-04 19:18:32.556446 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-04 19:18:32.556471 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-04 19:18:32.556493 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-09-04 19:18:32.556514 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/75ef524c2be74ed4a984f7064f99e81b/work/logs" 2026-09-04 19:19:34.807609 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/75ef524c2be74ed4a984f7064f99e81b/work/artifacts" 2026-09-04 19:19:35.125260 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/75ef524c2be74ed4a984f7064f99e81b/work/docs" 2026-09-04 19:19:35.143699 | 2026-09-04 19:19:35.143918 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-04 19:19:35.908579 | debian-bookworm | changed: 2026-09-04 19:19:35.908946 | debian-bookworm | .d..t...... ./ 2026-09-04 19:19:35.909009 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-04 19:19:35.909050 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-04 19:19:35.909086 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-04 19:19:35.909121 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-04 19:19:35.909154 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-04 19:19:35.909220 | debian-bookworm | changed: All items complete 2026-09-04 19:19:35.909280 | 2026-09-04 19:19:36.455042 | debian-bookworm | changed: .d..t...... ./ 2026-09-04 19:19:37.059190 | debian-bookworm | changed: .d..t...... ./ 2026-09-04 19:19:37.075435 | 2026-09-04 19:19:37.075569 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-04 19:19:37.418942 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009212 2026-09-04 19:19:37.694604 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009248 2026-09-04 19:19:37.707263 | 2026-09-04 19:19:37.707355 | PLAY RECAP 2026-09-04 19:19:37.707412 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-04 19:19:37.707440 | 2026-09-04 19:19:37.860289 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-04 19:19:37.868895 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-04 19:19:38.569168 | 2026-09-04 19:19:38.569309 | PLAY [Base post] 2026-09-04 19:19:38.582583 | 2026-09-04 19:19:38.582714 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-04 19:19:39.177311 | debian-bookworm | changed 2026-09-04 19:19:39.185493 | 2026-09-04 19:19:39.185619 | PLAY RECAP 2026-09-04 19:19:39.185699 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-04 19:19:39.185826 | 2026-09-04 19:19:39.336894 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-04 19:19:39.337738 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-04 19:19:40.157476 | 2026-09-04 19:19:40.157638 | PLAY [Base post-logs] 2026-09-04 19:19:40.180387 | 2026-09-04 19:19:40.180541 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-04 19:19:40.621795 | localhost | changed 2026-09-04 19:19:40.633329 | 2026-09-04 19:19:40.633495 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-04 19:19:40.670137 | localhost | ok 2026-09-04 19:19:40.673882 | 2026-09-04 19:19:40.673998 | TASK [Set zuul-log-path fact] 2026-09-04 19:19:40.696213 | localhost | ok 2026-09-04 19:19:40.711474 | 2026-09-04 19:19:40.711600 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-04 19:19:40.749470 | localhost | ok 2026-09-04 19:19:40.757001 | 2026-09-04 19:19:40.757223 | TASK [upload-logs : Create log directories] 2026-09-04 19:19:41.313367 | localhost | changed 2026-09-04 19:19:41.316314 | 2026-09-04 19:19:41.316423 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-04 19:19:41.823405 | localhost -> localhost | ok: Runtime: 0:00:00.009323 2026-09-04 19:19:41.833568 | 2026-09-04 19:19:41.833796 | TASK [upload-logs : Upload logs to log server] 2026-09-04 19:19:42.417984 | localhost | Output suppressed because no_log was given 2026-09-04 19:19:42.423643 | 2026-09-04 19:19:42.423942 | LOOP [upload-logs : Compress console log and json output] 2026-09-04 19:19:42.472308 | localhost | skipping: Conditional result was False 2026-09-04 19:19:42.477966 | localhost | skipping: Conditional result was False 2026-09-04 19:19:42.482474 | 2026-09-04 19:19:42.482579 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-04 19:19:42.543895 | localhost | skipping: Conditional result was False 2026-09-04 19:19:42.544464 | 2026-09-04 19:19:42.548321 | localhost | skipping: Conditional result was False 2026-09-04 19:19:42.562188 | 2026-09-04 19:19:42.562424 | LOOP [upload-logs : Upload console log and json output]