2026-08-31 16:34:33.780216 | Job console starting 2026-08-31 16:34:33.792933 | Updating git repos 2026-08-31 16:34:33.875866 | Cloning repos into workspace 2026-08-31 16:34:34.012357 | Restoring repo states 2026-08-31 16:34:34.066549 | Merging changes 2026-08-31 16:34:35.097072 | Checking out repos 2026-08-31 16:34:35.167053 | Preparing playbooks 2026-08-31 16:34:36.366931 | Running Ansible setup 2026-08-31 16:34:41.479721 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-31 16:34:42.206293 | 2026-08-31 16:34:42.206413 | PLAY [Base pre] 2026-08-31 16:34:42.228593 | 2026-08-31 16:34:42.228708 | TASK [Setup log path fact] 2026-08-31 16:34:42.257422 | debian-bookworm | ok 2026-08-31 16:34:42.279024 | 2026-08-31 16:34:42.279157 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-31 16:34:42.307187 | debian-bookworm | ok 2026-08-31 16:34:42.318979 | 2026-08-31 16:34:42.319081 | TASK [emit-job-header : Print job information] 2026-08-31 16:34:42.357264 | # Job Information 2026-08-31 16:34:42.357406 | Ansible Version: 2.16.14 2026-08-31 16:34:42.357440 | Job: python-black 2026-08-31 16:34:42.357471 | Pipeline: check 2026-08-31 16:34:42.357494 | Executor: 521e9411259a 2026-08-31 16:34:42.357515 | Triggered by: https://github.com/osism/python-osism/pull/2666 2026-08-31 16:34:42.357537 | Event ID: c56837d0-a559-11f1-9b36-68b9c1ea2c1a 2026-08-31 16:34:42.362769 | 2026-08-31 16:34:42.362883 | LOOP [emit-job-header : Print node information] 2026-08-31 16:34:42.499943 | debian-bookworm | ok: 2026-08-31 16:34:42.500121 | debian-bookworm | # Node Information 2026-08-31 16:34:42.500154 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-31 16:34:42.500178 | debian-bookworm | Hostname: debian 2026-08-31 16:34:42.500217 | debian-bookworm | Username: zuul 2026-08-31 16:34:42.500238 | debian-bookworm | Distro: Debian 12.15 2026-08-31 16:34:42.500261 | debian-bookworm | Provider: regiocloud-a 2026-08-31 16:34:42.500282 | debian-bookworm | Region: 2026-08-31 16:34:42.500304 | debian-bookworm | Label: debian-bookworm 2026-08-31 16:34:42.500323 | debian-bookworm | Product Name: OpenStack Nova 2026-08-31 16:34:42.500343 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6d:d46a 2026-08-31 16:34:42.513665 | 2026-08-31 16:34:42.513779 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-31 16:34:43.023157 | debian-bookworm -> localhost | changed 2026-08-31 16:34:43.030456 | 2026-08-31 16:34:43.030556 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-31 16:34:44.013828 | debian-bookworm -> localhost | changed 2026-08-31 16:34:44.025385 | 2026-08-31 16:34:44.025481 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-31 16:34:44.250732 | debian-bookworm -> localhost | ok 2026-08-31 16:34:44.256558 | 2026-08-31 16:34:44.256678 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-31 16:34:44.285579 | debian-bookworm | ok 2026-08-31 16:34:44.313405 | debian-bookworm | included: /var/lib/zuul/builds/6a5d4548997a4516babf4d569041a3ee/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-31 16:34:44.319115 | 2026-08-31 16:34:44.319196 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-31 16:34:46.775019 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-31 16:34:46.775421 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6a5d4548997a4516babf4d569041a3ee/work/6a5d4548997a4516babf4d569041a3ee_id_rsa 2026-08-31 16:34:46.775527 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6a5d4548997a4516babf4d569041a3ee/work/6a5d4548997a4516babf4d569041a3ee_id_rsa.pub 2026-08-31 16:34:46.775606 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-31 16:34:46.775738 | debian-bookworm -> localhost | SHA256:UNT42TN2K1kbB9Q2HK7sX2Z0p9qJxPQW4Xzzn3ZxVfk zuul-build-sshkey 2026-08-31 16:34:46.775815 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-31 16:34:46.775906 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-31 16:34:46.775980 | debian-bookworm -> localhost | | .oo .ooo| 2026-08-31 16:34:46.776049 | debian-bookworm -> localhost | | .. . o++| 2026-08-31 16:34:46.776111 | debian-bookworm -> localhost | | . . o .++| 2026-08-31 16:34:46.776169 | debian-bookworm -> localhost | | . o *o=.E| 2026-08-31 16:34:46.776230 | debian-bookworm -> localhost | | S ..O+**| 2026-08-31 16:34:46.776307 | debian-bookworm -> localhost | | o+.o**| 2026-08-31 16:34:46.776370 | debian-bookworm -> localhost | | oo+ B| 2026-08-31 16:34:46.776431 | debian-bookworm -> localhost | | . =.==| 2026-08-31 16:34:46.776497 | debian-bookworm -> localhost | | o +oo| 2026-08-31 16:34:46.776561 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-31 16:34:46.776712 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.055037 2026-08-31 16:34:46.789219 | 2026-08-31 16:34:46.789408 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-31 16:34:46.819270 | debian-bookworm | ok 2026-08-31 16:34:46.829251 | debian-bookworm | included: /var/lib/zuul/builds/6a5d4548997a4516babf4d569041a3ee/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-31 16:34:46.836954 | 2026-08-31 16:34:46.837029 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-31 16:34:46.858759 | debian-bookworm | skipping: Conditional result was False 2026-08-31 16:34:46.866159 | 2026-08-31 16:34:46.866238 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-31 16:34:47.528894 | debian-bookworm | changed 2026-08-31 16:34:47.537137 | 2026-08-31 16:34:47.537255 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-31 16:34:47.788518 | debian-bookworm | ok 2026-08-31 16:34:47.795103 | 2026-08-31 16:34:47.795190 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-31 16:34:48.362331 | debian-bookworm | changed 2026-08-31 16:34:48.372906 | 2026-08-31 16:34:48.372996 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-31 16:34:48.963348 | debian-bookworm | changed 2026-08-31 16:34:48.974382 | 2026-08-31 16:34:48.974522 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-31 16:34:48.999087 | debian-bookworm | skipping: Conditional result was False 2026-08-31 16:34:49.004674 | 2026-08-31 16:34:49.004759 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-31 16:34:49.432349 | debian-bookworm -> localhost | changed 2026-08-31 16:34:49.445415 | 2026-08-31 16:34:49.446421 | TASK [add-build-sshkey : Add back temp key] 2026-08-31 16:34:50.003588 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6a5d4548997a4516babf4d569041a3ee/work/6a5d4548997a4516babf4d569041a3ee_id_rsa (zuul-build-sshkey) 2026-08-31 16:34:50.003801 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.042044 2026-08-31 16:34:50.011977 | 2026-08-31 16:34:50.012070 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-31 16:34:50.569160 | debian-bookworm | ok 2026-08-31 16:34:50.576315 | 2026-08-31 16:34:50.576420 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-31 16:34:50.600203 | debian-bookworm | skipping: Conditional result was False 2026-08-31 16:34:50.612912 | 2026-08-31 16:34:50.612996 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-31 16:34:51.033380 | debian-bookworm | ok 2026-08-31 16:34:51.057878 | 2026-08-31 16:34:51.058913 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-31 16:34:51.113973 | debian-bookworm | ok 2026-08-31 16:34:51.123020 | 2026-08-31 16:34:51.123111 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-31 16:34:51.435615 | debian-bookworm -> localhost | ok 2026-08-31 16:34:51.448103 | 2026-08-31 16:34:51.448324 | TASK [validate-host : Collect information about the host] 2026-08-31 16:34:52.713743 | debian-bookworm | ok 2026-08-31 16:34:52.729574 | 2026-08-31 16:34:52.729702 | TASK [validate-host : Sanitize hostname] 2026-08-31 16:34:52.843118 | debian-bookworm | ok 2026-08-31 16:34:52.847349 | 2026-08-31 16:34:52.847430 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-31 16:34:53.388610 | debian-bookworm -> localhost | changed 2026-08-31 16:34:53.394827 | 2026-08-31 16:34:53.395003 | TASK [validate-host : Collect information about zuul worker] 2026-08-31 16:34:53.823742 | debian-bookworm | ok 2026-08-31 16:34:53.831751 | 2026-08-31 16:34:53.831889 | TASK [validate-host : Write out all zuul information for each host] 2026-08-31 16:34:54.456131 | debian-bookworm -> localhost | changed 2026-08-31 16:34:54.476718 | 2026-08-31 16:34:54.476876 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-31 16:34:54.769974 | debian-bookworm | ok 2026-08-31 16:34:54.776983 | 2026-08-31 16:34:54.777120 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-31 16:34:57.997198 | debian-bookworm | changed: 2026-08-31 16:34:57.997421 | debian-bookworm | cd+++++++++ src/ 2026-08-31 16:34:57.997458 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-31 16:34:57.997482 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-31 16:34:57.997505 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-31 16:34:57.997526 | debian-bookworm | Containerfile 2026-08-31 16:34:57.997675 | debian-bookworm | Containerfile 2026-08-31 16:34:58.037377 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/6a5d4548997a4516babf4d569041a3ee/work/logs" 2026-08-31 16:36:11.536747 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6a5d4548997a4516babf4d569041a3ee/work/artifacts" 2026-08-31 16:36:11.913394 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6a5d4548997a4516babf4d569041a3ee/work/docs" 2026-08-31 16:36:11.927502 | 2026-08-31 16:36:11.927670 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-31 16:36:13.007855 | debian-bookworm | changed: 2026-08-31 16:36:13.008078 | debian-bookworm | .d..t...... ./ 2026-08-31 16:36:13.008124 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-31 16:36:13.008153 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-31 16:36:13.008181 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-31 16:36:13.008207 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-31 16:36:13.008234 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-31 16:36:13.008280 | debian-bookworm | changed: All items complete 2026-08-31 16:36:13.008313 | 2026-08-31 16:36:13.826318 | debian-bookworm | changed: .d..t...... ./ 2026-08-31 16:36:14.529402 | debian-bookworm | changed: .d..t...... ./ 2026-08-31 16:36:14.560059 | 2026-08-31 16:36:14.560422 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-31 16:36:14.875754 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009045 2026-08-31 16:36:15.155314 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.005692 2026-08-31 16:36:15.171596 | 2026-08-31 16:36:15.171680 | PLAY RECAP 2026-08-31 16:36:15.171732 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-31 16:36:15.171758 | 2026-08-31 16:36:15.282181 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-31 16:36:15.283531 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-31 16:36:16.160133 | 2026-08-31 16:36:16.160288 | PLAY [Base post] 2026-08-31 16:36:16.193228 | 2026-08-31 16:36:16.193365 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-31 16:36:16.809003 | debian-bookworm | changed 2026-08-31 16:36:16.815261 | 2026-08-31 16:36:16.815345 | PLAY RECAP 2026-08-31 16:36:16.815406 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-31 16:36:16.815476 | 2026-08-31 16:36:16.919418 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-31 16:36:16.923291 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-31 16:36:17.936887 | 2026-08-31 16:36:17.937033 | PLAY [Base post-logs] 2026-08-31 16:36:17.947107 | 2026-08-31 16:36:17.947213 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-31 16:36:18.723164 | localhost | changed 2026-08-31 16:36:18.738216 | 2026-08-31 16:36:18.738449 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-31 16:36:18.778636 | localhost | ok 2026-08-31 16:36:18.783089 | 2026-08-31 16:36:18.783197 | TASK [Set zuul-log-path fact] 2026-08-31 16:36:18.800597 | localhost | ok 2026-08-31 16:36:18.823749 | 2026-08-31 16:36:18.823880 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-31 16:36:18.894585 | localhost | ok 2026-08-31 16:36:18.900711 | 2026-08-31 16:36:18.900912 | TASK [upload-logs : Create log directories] 2026-08-31 16:36:19.547410 | localhost | changed 2026-08-31 16:36:19.550277 | 2026-08-31 16:36:19.550382 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-31 16:36:20.327553 | localhost -> localhost | ok: Runtime: 0:00:00.006315 2026-08-31 16:36:20.331362 | 2026-08-31 16:36:20.331466 | TASK [upload-logs : Upload logs to log server] 2026-08-31 16:36:20.927462 | localhost | Output suppressed because no_log was given 2026-08-31 16:36:20.929196 | 2026-08-31 16:36:20.929284 | LOOP [upload-logs : Compress console log and json output] 2026-08-31 16:36:20.972636 | localhost | skipping: Conditional result was False 2026-08-31 16:36:20.979900 | localhost | skipping: Conditional result was False 2026-08-31 16:36:20.986637 | 2026-08-31 16:36:20.986726 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-31 16:36:21.035682 | localhost | skipping: Conditional result was False 2026-08-31 16:36:21.035917 | 2026-08-31 16:36:21.048478 | localhost | skipping: Conditional result was False 2026-08-31 16:36:21.058934 | 2026-08-31 16:36:21.059034 | LOOP [upload-logs : Upload console log and json output]