2026-08-05 05:50:49.667633 | Job console starting 2026-08-05 05:50:49.698932 | Updating git repos 2026-08-05 05:50:49.766236 | Cloning repos into workspace 2026-08-05 05:50:49.896449 | Restoring repo states 2026-08-05 05:50:49.915666 | Merging changes 2026-08-05 05:50:50.861697 | Checking out repos 2026-08-05 05:50:51.064205 | Preparing playbooks 2026-08-05 05:50:52.803254 | Running Ansible setup 2026-08-05 05:50:59.654464 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-05 05:51:01.408982 | 2026-08-05 05:51:01.409126 | PLAY [Base pre] 2026-08-05 05:51:01.437480 | 2026-08-05 05:51:01.437611 | TASK [Setup log path fact] 2026-08-05 05:51:01.488247 | debian-bookworm | ok 2026-08-05 05:51:01.521811 | 2026-08-05 05:51:01.521951 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-05 05:51:01.582654 | debian-bookworm | ok 2026-08-05 05:51:01.608991 | 2026-08-05 05:51:01.609108 | TASK [emit-job-header : Print job information] 2026-08-05 05:51:01.669768 | # Job Information 2026-08-05 05:51:01.669935 | Ansible Version: 2.16.14 2026-08-05 05:51:01.669972 | Job: python-black 2026-08-05 05:51:01.670005 | Pipeline: check 2026-08-05 05:51:01.670028 | Executor: 521e9411259a 2026-08-05 05:51:01.670049 | Triggered by: https://github.com/osism/python-osism/pull/2549 2026-08-05 05:51:01.670077 | Event ID: 95aa4e20-9091-11f1-8783-f01bf16adabb 2026-08-05 05:51:01.708880 | 2026-08-05 05:51:01.709008 | LOOP [emit-job-header : Print node information] 2026-08-05 05:51:01.870648 | debian-bookworm | ok: 2026-08-05 05:51:01.870937 | debian-bookworm | # Node Information 2026-08-05 05:51:01.870974 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-05 05:51:01.870996 | debian-bookworm | Hostname: debian 2026-08-05 05:51:01.871014 | debian-bookworm | Username: zuul 2026-08-05 05:51:01.871032 | debian-bookworm | Distro: Debian 12.15 2026-08-05 05:51:01.871051 | debian-bookworm | Provider: regiocloud-a 2026-08-05 05:51:01.871067 | debian-bookworm | Region: 2026-08-05 05:51:01.871084 | debian-bookworm | Label: debian-bookworm 2026-08-05 05:51:01.871101 | debian-bookworm | Product Name: OpenStack Nova 2026-08-05 05:51:01.871116 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:febf:2d03 2026-08-05 05:51:01.881533 | 2026-08-05 05:51:01.881648 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-05 05:51:02.783519 | debian-bookworm -> localhost | changed 2026-08-05 05:51:02.792024 | 2026-08-05 05:51:02.792144 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-05 05:51:05.535523 | debian-bookworm -> localhost | changed 2026-08-05 05:51:05.549898 | 2026-08-05 05:51:05.549999 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-05 05:51:06.099116 | debian-bookworm -> localhost | ok 2026-08-05 05:51:06.105420 | 2026-08-05 05:51:06.105538 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-05 05:51:06.134962 | debian-bookworm | ok 2026-08-05 05:51:06.170359 | debian-bookworm | included: /var/lib/zuul/builds/94f1df2f264f431a8b40b36658cc7e56/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-05 05:51:06.179580 | 2026-08-05 05:51:06.179683 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-05 05:51:08.084612 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-05 05:51:08.084813 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/94f1df2f264f431a8b40b36658cc7e56/work/94f1df2f264f431a8b40b36658cc7e56_id_rsa 2026-08-05 05:51:08.084851 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/94f1df2f264f431a8b40b36658cc7e56/work/94f1df2f264f431a8b40b36658cc7e56_id_rsa.pub 2026-08-05 05:51:08.084879 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-05 05:51:08.085148 | debian-bookworm -> localhost | SHA256:mKu3NUsEsHDH2jIxfuINDMu6WJB3DcKafy9UvCoNW38 zuul-build-sshkey 2026-08-05 05:51:08.085213 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-05 05:51:08.085250 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-05 05:51:08.085274 | debian-bookworm -> localhost | | .. o.. | 2026-08-05 05:51:08.085298 | debian-bookworm -> localhost | | +o++. | 2026-08-05 05:51:08.085319 | debian-bookworm -> localhost | | = *.O. | 2026-08-05 05:51:08.085340 | debian-bookworm -> localhost | |= + X *+ | 2026-08-05 05:51:08.085360 | debian-bookworm -> localhost | | = o Oo.S | 2026-08-05 05:51:08.085386 | debian-bookworm -> localhost | |. + = oo | 2026-08-05 05:51:08.085407 | debian-bookworm -> localhost | |.o B +. + | 2026-08-05 05:51:08.085426 | debian-bookworm -> localhost | |o o +.+oEo | 2026-08-05 05:51:08.085447 | debian-bookworm -> localhost | | ..o.o. | 2026-08-05 05:51:08.085479 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-05 05:51:08.085536 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.012640 2026-08-05 05:51:08.092193 | 2026-08-05 05:51:08.092285 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-05 05:51:08.120413 | debian-bookworm | ok 2026-08-05 05:51:08.132292 | debian-bookworm | included: /var/lib/zuul/builds/94f1df2f264f431a8b40b36658cc7e56/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-05 05:51:08.141993 | 2026-08-05 05:51:08.142080 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-05 05:51:08.173366 | debian-bookworm | skipping: Conditional result was False 2026-08-05 05:51:08.178942 | 2026-08-05 05:51:08.179030 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-05 05:51:08.896513 | debian-bookworm | changed 2026-08-05 05:51:08.902419 | 2026-08-05 05:51:08.902521 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-05 05:51:09.252869 | debian-bookworm | ok 2026-08-05 05:51:09.262807 | 2026-08-05 05:51:09.262966 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-05 05:51:09.915183 | debian-bookworm | changed 2026-08-05 05:51:09.920596 | 2026-08-05 05:51:09.920694 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-05 05:51:10.566052 | debian-bookworm | changed 2026-08-05 05:51:10.571816 | 2026-08-05 05:51:10.571913 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-05 05:51:10.615399 | debian-bookworm | skipping: Conditional result was False 2026-08-05 05:51:10.622238 | 2026-08-05 05:51:10.622342 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-05 05:51:11.460389 | debian-bookworm -> localhost | changed 2026-08-05 05:51:11.468924 | 2026-08-05 05:51:11.469004 | TASK [add-build-sshkey : Add back temp key] 2026-08-05 05:51:12.061476 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/94f1df2f264f431a8b40b36658cc7e56/work/94f1df2f264f431a8b40b36658cc7e56_id_rsa (zuul-build-sshkey) 2026-08-05 05:51:12.061675 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.040849 2026-08-05 05:51:12.067959 | 2026-08-05 05:51:12.068035 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-05 05:51:12.430657 | debian-bookworm | ok 2026-08-05 05:51:12.434969 | 2026-08-05 05:51:12.435048 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-05 05:51:12.468682 | debian-bookworm | skipping: Conditional result was False 2026-08-05 05:51:12.477358 | 2026-08-05 05:51:12.477444 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-05 05:51:13.002614 | debian-bookworm | ok 2026-08-05 05:51:13.016088 | 2026-08-05 05:51:13.016189 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-05 05:51:13.150245 | debian-bookworm | ok 2026-08-05 05:51:13.154576 | 2026-08-05 05:51:13.154653 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-05 05:51:13.831875 | debian-bookworm -> localhost | ok 2026-08-05 05:51:13.837199 | 2026-08-05 05:51:13.837281 | TASK [validate-host : Collect information about the host] 2026-08-05 05:51:15.150332 | debian-bookworm | ok 2026-08-05 05:51:15.184086 | 2026-08-05 05:51:15.184230 | TASK [validate-host : Sanitize hostname] 2026-08-05 05:51:15.326202 | debian-bookworm | ok 2026-08-05 05:51:15.330996 | 2026-08-05 05:51:15.331088 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-05 05:51:16.113777 | debian-bookworm -> localhost | changed 2026-08-05 05:51:16.118942 | 2026-08-05 05:51:16.119029 | TASK [validate-host : Collect information about zuul worker] 2026-08-05 05:51:16.530523 | debian-bookworm | ok 2026-08-05 05:51:16.534564 | 2026-08-05 05:51:16.534647 | TASK [validate-host : Write out all zuul information for each host] 2026-08-05 05:51:17.601420 | debian-bookworm -> localhost | changed 2026-08-05 05:51:17.609260 | 2026-08-05 05:51:17.609339 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-05 05:51:17.870260 | debian-bookworm | ok 2026-08-05 05:51:17.875865 | 2026-08-05 05:51:17.875976 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-05 05:51:18.855531 | debian-bookworm | changed: 2026-08-05 05:51:18.855721 | debian-bookworm | cd+++++++++ src/ 2026-08-05 05:51:18.855757 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-05 05:51:18.855782 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-05 05:51:18.855804 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-05 05:51:18.855824 | debian-bookworm | Containerfile 2026-08-05 05:51:18.855964 | debian-bookworm | Containerfile 2026-08-05 05:51:18.884515 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/94f1df2f264f431a8b40b36658cc7e56/work/logs" 2026-08-05 05:52:34.831490 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/94f1df2f264f431a8b40b36658cc7e56/work/artifacts" 2026-08-05 05:52:35.098004 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/94f1df2f264f431a8b40b36658cc7e56/work/docs" 2026-08-05 05:52:35.127179 | 2026-08-05 05:52:35.127357 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-05 05:52:36.016593 | debian-bookworm | changed: 2026-08-05 05:52:36.017024 | debian-bookworm | .d..t...... ./ 2026-08-05 05:52:36.017120 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-05 05:52:36.017171 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-05 05:52:36.017215 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-05 05:52:36.017260 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-05 05:52:36.017304 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-05 05:52:36.017384 | debian-bookworm | changed: All items complete 2026-08-05 05:52:36.017516 | 2026-08-05 05:52:36.672201 | debian-bookworm | changed: .d..t...... ./ 2026-08-05 05:52:37.286636 | debian-bookworm | changed: .d..t...... ./ 2026-08-05 05:52:37.316414 | 2026-08-05 05:52:37.316605 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-05 05:52:37.702625 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009620 2026-08-05 05:52:37.999325 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.011333 2026-08-05 05:52:38.014991 | 2026-08-05 05:52:38.015090 | PLAY RECAP 2026-08-05 05:52:38.015145 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-05 05:52:38.015170 | 2026-08-05 05:52:38.151814 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-05 05:52:38.152874 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-05 05:52:38.929665 | 2026-08-05 05:52:38.929847 | PLAY [Base post] 2026-08-05 05:52:38.944168 | 2026-08-05 05:52:38.944332 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-05 05:52:39.684803 | debian-bookworm | changed 2026-08-05 05:52:39.695150 | 2026-08-05 05:52:39.695292 | PLAY RECAP 2026-08-05 05:52:39.695375 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-05 05:52:39.695517 | 2026-08-05 05:52:39.841277 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-05 05:52:39.843571 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-05 05:52:40.715542 | 2026-08-05 05:52:40.715753 | PLAY [Base post-logs] 2026-08-05 05:52:40.727953 | 2026-08-05 05:52:40.728127 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-05 05:52:41.289163 | localhost | changed 2026-08-05 05:52:41.300058 | 2026-08-05 05:52:41.300217 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-05 05:52:41.339712 | localhost | ok 2026-08-05 05:52:41.347745 | 2026-08-05 05:52:41.347939 | TASK [Set zuul-log-path fact] 2026-08-05 05:52:41.367933 | localhost | ok 2026-08-05 05:52:41.386037 | 2026-08-05 05:52:41.386182 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-05 05:52:41.416310 | localhost | ok 2026-08-05 05:52:41.423282 | 2026-08-05 05:52:41.423476 | TASK [upload-logs : Create log directories] 2026-08-05 05:52:41.972777 | localhost | changed 2026-08-05 05:52:41.975871 | 2026-08-05 05:52:41.975984 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-05 05:52:42.512626 | localhost -> localhost | ok: Runtime: 0:00:00.008348 2026-08-05 05:52:42.521907 | 2026-08-05 05:52:42.522115 | TASK [upload-logs : Upload logs to log server] 2026-08-05 05:52:43.130965 | localhost | Output suppressed because no_log was given 2026-08-05 05:52:43.133195 | 2026-08-05 05:52:43.133322 | LOOP [upload-logs : Compress console log and json output] 2026-08-05 05:52:43.196541 | localhost | skipping: Conditional result was False 2026-08-05 05:52:43.201789 | localhost | skipping: Conditional result was False 2026-08-05 05:52:43.209992 | 2026-08-05 05:52:43.210234 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-05 05:52:43.269378 | localhost | skipping: Conditional result was False 2026-08-05 05:52:43.269978 | 2026-08-05 05:52:43.274051 | localhost | skipping: Conditional result was False 2026-08-05 05:52:43.288010 | 2026-08-05 05:52:43.288220 | LOOP [upload-logs : Upload console log and json output]