2026-08-30 21:03:03.793145 | Job console starting 2026-08-30 21:03:03.829314 | Updating git repos 2026-08-30 21:03:03.953362 | Cloning repos into workspace 2026-08-30 21:03:04.096643 | Restoring repo states 2026-08-30 21:03:04.159279 | Merging changes 2026-08-30 21:03:05.142160 | Checking out repos 2026-08-30 21:03:05.327831 | Preparing playbooks 2026-08-30 21:03:07.096921 | Running Ansible setup 2026-08-30 21:03:13.673352 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-30 21:03:14.616580 | 2026-08-30 21:03:14.616713 | PLAY [Base pre] 2026-08-30 21:03:14.658552 | 2026-08-30 21:03:14.658686 | TASK [Setup log path fact] 2026-08-30 21:03:14.682252 | debian-bookworm | ok 2026-08-30 21:03:14.702309 | 2026-08-30 21:03:14.702445 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-30 21:03:14.754380 | debian-bookworm | ok 2026-08-30 21:03:14.772096 | 2026-08-30 21:03:14.772199 | TASK [emit-job-header : Print job information] 2026-08-30 21:03:14.855122 | # Job Information 2026-08-30 21:03:14.855277 | Ansible Version: 2.16.14 2026-08-30 21:03:14.855307 | Job: python-black 2026-08-30 21:03:14.855334 | Pipeline: check 2026-08-30 21:03:14.855354 | Executor: 521e9411259a 2026-08-30 21:03:14.855371 | Triggered by: https://github.com/osism/python-osism/pull/2640 2026-08-30 21:03:14.855389 | Event ID: 2a137f40-a4b6-11f1-8fb9-7bc45650e800 2026-08-30 21:03:14.859355 | 2026-08-30 21:03:14.859433 | LOOP [emit-job-header : Print node information] 2026-08-30 21:03:14.969992 | debian-bookworm | ok: 2026-08-30 21:03:14.970193 | debian-bookworm | # Node Information 2026-08-30 21:03:14.970244 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-30 21:03:14.970270 | debian-bookworm | Hostname: debian 2026-08-30 21:03:14.970292 | debian-bookworm | Username: zuul 2026-08-30 21:03:14.970312 | debian-bookworm | Distro: Debian 12.15 2026-08-30 21:03:14.970335 | debian-bookworm | Provider: regiocloud-a 2026-08-30 21:03:14.970356 | debian-bookworm | Region: 2026-08-30 21:03:14.970377 | debian-bookworm | Label: debian-bookworm 2026-08-30 21:03:14.970397 | debian-bookworm | Product Name: OpenStack Nova 2026-08-30 21:03:14.970416 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7a:a925 2026-08-30 21:03:14.984841 | 2026-08-30 21:03:14.984958 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-30 21:03:15.837032 | debian-bookworm -> localhost | changed 2026-08-30 21:03:15.843040 | 2026-08-30 21:03:15.843140 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-30 21:03:18.159748 | debian-bookworm -> localhost | changed 2026-08-30 21:03:18.168598 | 2026-08-30 21:03:18.168698 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-30 21:03:18.624268 | debian-bookworm -> localhost | ok 2026-08-30 21:03:18.629298 | 2026-08-30 21:03:18.629397 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-30 21:03:18.669879 | debian-bookworm | ok 2026-08-30 21:03:18.707159 | debian-bookworm | included: /var/lib/zuul/builds/a56e1357e81b4b27ab5b7338c1b9b61c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-30 21:03:18.713609 | 2026-08-30 21:03:18.713713 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-30 21:03:20.919664 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-30 21:03:20.919844 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a56e1357e81b4b27ab5b7338c1b9b61c/work/a56e1357e81b4b27ab5b7338c1b9b61c_id_rsa 2026-08-30 21:03:20.919876 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a56e1357e81b4b27ab5b7338c1b9b61c/work/a56e1357e81b4b27ab5b7338c1b9b61c_id_rsa.pub 2026-08-30 21:03:20.919898 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-30 21:03:20.919919 | debian-bookworm -> localhost | SHA256:X3Bd9rwklS24JEKFQ6t78pYlaMg8iCYMrCcOvVGJgs0 zuul-build-sshkey 2026-08-30 21:03:20.919938 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-30 21:03:20.919964 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-30 21:03:20.919983 | debian-bookworm -> localhost | | ooo. . .=| 2026-08-30 21:03:20.920001 | debian-bookworm -> localhost | | +.. o.o=o| 2026-08-30 21:03:20.920018 | debian-bookworm -> localhost | |oo . . .o.o.o.oo| 2026-08-30 21:03:20.920035 | debian-bookworm -> localhost | |+.E o . o. o .| 2026-08-30 21:03:20.920051 | debian-bookworm -> localhost | |++ = ...S . . | 2026-08-30 21:03:20.920073 | debian-bookworm -> localhost | |*o= = o..... | 2026-08-30 21:03:20.920090 | debian-bookworm -> localhost | |=o o oo .+. | 2026-08-30 21:03:20.920107 | debian-bookworm -> localhost | | .. +o | 2026-08-30 21:03:20.920124 | debian-bookworm -> localhost | | .. | 2026-08-30 21:03:20.920141 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-30 21:03:20.920182 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.202561 2026-08-30 21:03:20.925569 | 2026-08-30 21:03:20.925656 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-30 21:03:20.972816 | debian-bookworm | ok 2026-08-30 21:03:20.981057 | debian-bookworm | included: /var/lib/zuul/builds/a56e1357e81b4b27ab5b7338c1b9b61c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-30 21:03:21.005218 | 2026-08-30 21:03:21.005402 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-30 21:03:21.035539 | debian-bookworm | skipping: Conditional result was False 2026-08-30 21:03:21.040648 | 2026-08-30 21:03:21.040748 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-30 21:03:21.919712 | debian-bookworm | changed 2026-08-30 21:03:21.926302 | 2026-08-30 21:03:21.926403 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-30 21:03:22.183877 | debian-bookworm | ok 2026-08-30 21:03:22.188482 | 2026-08-30 21:03:22.188555 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-30 21:03:22.918439 | debian-bookworm | changed 2026-08-30 21:03:22.930982 | 2026-08-30 21:03:22.931117 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-30 21:03:23.593019 | debian-bookworm | changed 2026-08-30 21:03:23.599838 | 2026-08-30 21:03:23.599935 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-30 21:03:23.618782 | debian-bookworm | skipping: Conditional result was False 2026-08-30 21:03:23.623680 | 2026-08-30 21:03:23.623761 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-30 21:03:24.124824 | debian-bookworm -> localhost | changed 2026-08-30 21:03:24.134010 | 2026-08-30 21:03:24.134103 | TASK [add-build-sshkey : Add back temp key] 2026-08-30 21:03:24.546355 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a56e1357e81b4b27ab5b7338c1b9b61c/work/a56e1357e81b4b27ab5b7338c1b9b61c_id_rsa (zuul-build-sshkey) 2026-08-30 21:03:24.546619 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009671 2026-08-30 21:03:24.553892 | 2026-08-30 21:03:24.553991 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-30 21:03:24.934973 | debian-bookworm | ok 2026-08-30 21:03:24.939295 | 2026-08-30 21:03:24.939380 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-30 21:03:24.972974 | debian-bookworm | skipping: Conditional result was False 2026-08-30 21:03:24.981818 | 2026-08-30 21:03:24.981924 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-30 21:03:25.399173 | debian-bookworm | ok 2026-08-30 21:03:25.417857 | 2026-08-30 21:03:25.417979 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-30 21:03:25.454788 | debian-bookworm | ok 2026-08-30 21:03:25.459691 | 2026-08-30 21:03:25.459779 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-30 21:03:25.973109 | debian-bookworm -> localhost | ok 2026-08-30 21:03:25.980267 | 2026-08-30 21:03:25.980377 | TASK [validate-host : Collect information about the host] 2026-08-30 21:03:27.321309 | debian-bookworm | ok 2026-08-30 21:03:27.333091 | 2026-08-30 21:03:27.333199 | TASK [validate-host : Sanitize hostname] 2026-08-30 21:03:27.454121 | debian-bookworm | ok 2026-08-30 21:03:27.459063 | 2026-08-30 21:03:27.459154 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-30 21:03:28.082614 | debian-bookworm -> localhost | changed 2026-08-30 21:03:28.088523 | 2026-08-30 21:03:28.088635 | TASK [validate-host : Collect information about zuul worker] 2026-08-30 21:03:28.632707 | debian-bookworm | ok 2026-08-30 21:03:28.637689 | 2026-08-30 21:03:28.637785 | TASK [validate-host : Write out all zuul information for each host] 2026-08-30 21:03:29.563949 | debian-bookworm -> localhost | changed 2026-08-30 21:03:29.573614 | 2026-08-30 21:03:29.574003 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-30 21:03:29.866683 | debian-bookworm | ok 2026-08-30 21:03:29.876039 | 2026-08-30 21:03:29.876218 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-30 21:03:31.853213 | debian-bookworm | changed: 2026-08-30 21:03:31.853484 | debian-bookworm | cd+++++++++ src/ 2026-08-30 21:03:31.853522 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-30 21:03:31.853547 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-30 21:03:31.853597 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-30 21:03:31.853620 | debian-bookworm | Containerfile 2026-08-30 21:03:31.853861 | debian-bookworm | Containerfile 2026-08-30 21:03:31.899725 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/a56e1357e81b4b27ab5b7338c1b9b61c/work/logs" 2026-08-30 21:04:44.396559 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a56e1357e81b4b27ab5b7338c1b9b61c/work/artifacts" 2026-08-30 21:04:44.696342 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a56e1357e81b4b27ab5b7338c1b9b61c/work/docs" 2026-08-30 21:04:44.718220 | 2026-08-30 21:04:44.718507 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-30 21:04:45.549768 | debian-bookworm | changed: 2026-08-30 21:04:45.550178 | debian-bookworm | .d..t...... ./ 2026-08-30 21:04:45.550372 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-30 21:04:45.550425 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-30 21:04:45.550470 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-30 21:04:45.550512 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-30 21:04:45.550555 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-30 21:04:45.550638 | debian-bookworm | changed: All items complete 2026-08-30 21:04:45.550692 | 2026-08-30 21:04:46.128436 | debian-bookworm | changed: .d..t...... ./ 2026-08-30 21:04:46.694766 | debian-bookworm | changed: .d..t...... ./ 2026-08-30 21:04:46.715111 | 2026-08-30 21:04:46.715285 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-30 21:04:47.111655 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009874 2026-08-30 21:04:47.471653 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.011466 2026-08-30 21:04:47.493836 | 2026-08-30 21:04:47.493965 | PLAY RECAP 2026-08-30 21:04:47.494047 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-30 21:04:47.494165 | 2026-08-30 21:04:47.646377 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-30 21:04:47.647686 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-30 21:04:48.431603 | 2026-08-30 21:04:48.431813 | PLAY [Base post] 2026-08-30 21:04:48.455202 | 2026-08-30 21:04:48.455399 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-30 21:04:49.068574 | debian-bookworm | changed 2026-08-30 21:04:49.078953 | 2026-08-30 21:04:49.079095 | PLAY RECAP 2026-08-30 21:04:49.079177 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-30 21:04:49.079256 | 2026-08-30 21:04:49.248466 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-30 21:04:49.250531 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-30 21:04:50.167889 | 2026-08-30 21:04:50.168096 | PLAY [Base post-logs] 2026-08-30 21:04:50.180042 | 2026-08-30 21:04:50.180207 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-30 21:04:50.694971 | localhost | changed 2026-08-30 21:04:50.706188 | 2026-08-30 21:04:50.706399 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-30 21:04:50.744262 | localhost | ok 2026-08-30 21:04:50.748549 | 2026-08-30 21:04:50.748676 | TASK [Set zuul-log-path fact] 2026-08-30 21:04:50.767003 | localhost | ok 2026-08-30 21:04:50.776531 | 2026-08-30 21:04:50.776691 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-30 21:04:50.825425 | localhost | ok 2026-08-30 21:04:50.828926 | 2026-08-30 21:04:50.829050 | TASK [upload-logs : Create log directories] 2026-08-30 21:04:51.377736 | localhost | changed 2026-08-30 21:04:51.381161 | 2026-08-30 21:04:51.381288 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-30 21:04:51.965398 | localhost -> localhost | ok: Runtime: 0:00:00.011109 2026-08-30 21:04:51.974194 | 2026-08-30 21:04:51.974419 | TASK [upload-logs : Upload logs to log server] 2026-08-30 21:04:52.589127 | localhost | Output suppressed because no_log was given 2026-08-30 21:04:52.593991 | 2026-08-30 21:04:52.594254 | LOOP [upload-logs : Compress console log and json output] 2026-08-30 21:04:52.653182 | localhost | skipping: Conditional result was False 2026-08-30 21:04:52.662249 | localhost | skipping: Conditional result was False 2026-08-30 21:04:52.673883 | 2026-08-30 21:04:52.674205 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-30 21:04:52.728489 | localhost | skipping: Conditional result was False 2026-08-30 21:04:52.728826 | 2026-08-30 21:04:52.735705 | localhost | skipping: Conditional result was False 2026-08-30 21:04:52.753101 | 2026-08-30 21:04:52.753355 | LOOP [upload-logs : Upload console log and json output]