2026-10-01 20:56:32.786163 | Job console starting 2026-10-01 20:56:32.821931 | Updating git repos 2026-10-01 20:56:32.946071 | Cloning repos into workspace 2026-10-01 20:56:33.048202 | Restoring repo states 2026-10-01 20:56:33.068926 | Merging changes 2026-10-01 20:56:34.009968 | Checking out repos 2026-10-01 20:56:34.245390 | Preparing playbooks 2026-10-01 20:56:36.089653 | Running Ansible setup 2026-10-01 20:56:42.013059 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-10-01 20:56:42.746910 | 2026-10-01 20:56:42.747037 | PLAY [Base pre] 2026-10-01 20:56:42.780425 | 2026-10-01 20:56:42.780543 | TASK [Setup log path fact] 2026-10-01 20:56:42.799889 | debian-bookworm | ok 2026-10-01 20:56:42.845917 | 2026-10-01 20:56:42.846053 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-01 20:56:42.931675 | debian-bookworm | ok 2026-10-01 20:56:42.948065 | 2026-10-01 20:56:42.948175 | TASK [emit-job-header : Print job information] 2026-10-01 20:56:43.020800 | # Job Information 2026-10-01 20:56:43.021062 | Ansible Version: 2.16.14 2026-10-01 20:56:43.021099 | Job: python-black 2026-10-01 20:56:43.021132 | Pipeline: check 2026-10-01 20:56:43.021155 | Executor: 521e9411259a 2026-10-01 20:56:43.021177 | Triggered by: https://github.com/osism/python-osism/pull/2745 2026-10-01 20:56:43.021199 | Event ID: 8ebbf980-bdda-11f1-8004-9e86f0878109 2026-10-01 20:56:43.030125 | 2026-10-01 20:56:43.030226 | LOOP [emit-job-header : Print node information] 2026-10-01 20:56:43.262932 | debian-bookworm | ok: 2026-10-01 20:56:43.263133 | debian-bookworm | # Node Information 2026-10-01 20:56:43.263168 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-10-01 20:56:43.263192 | debian-bookworm | Hostname: debian 2026-10-01 20:56:43.263214 | debian-bookworm | Username: zuul 2026-10-01 20:56:43.263234 | debian-bookworm | Distro: Debian 12.15 2026-10-01 20:56:43.263258 | debian-bookworm | Provider: regiocloud-a 2026-10-01 20:56:43.263278 | debian-bookworm | Region: 2026-10-01 20:56:43.263298 | debian-bookworm | Label: debian-bookworm 2026-10-01 20:56:43.263318 | debian-bookworm | Product Name: OpenStack Nova 2026-10-01 20:56:43.263336 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed6:e836 2026-10-01 20:56:43.274902 | 2026-10-01 20:56:43.275000 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-10-01 20:56:44.391931 | debian-bookworm -> localhost | changed 2026-10-01 20:56:44.397581 | 2026-10-01 20:56:44.397686 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-10-01 20:56:46.041358 | debian-bookworm -> localhost | changed 2026-10-01 20:56:46.049950 | 2026-10-01 20:56:46.050036 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-10-01 20:56:46.583127 | debian-bookworm -> localhost | ok 2026-10-01 20:56:46.588531 | 2026-10-01 20:56:46.588638 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-10-01 20:56:46.607349 | debian-bookworm | ok 2026-10-01 20:56:46.629835 | debian-bookworm | included: /var/lib/zuul/builds/4a6b6632ca5744949389417eba1a83fe/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-10-01 20:56:46.644555 | 2026-10-01 20:56:46.644674 | TASK [add-build-sshkey : Create Temp SSH key] 2026-10-01 20:56:48.942639 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-10-01 20:56:48.942810 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4a6b6632ca5744949389417eba1a83fe/work/4a6b6632ca5744949389417eba1a83fe_id_rsa 2026-10-01 20:56:48.942842 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4a6b6632ca5744949389417eba1a83fe/work/4a6b6632ca5744949389417eba1a83fe_id_rsa.pub 2026-10-01 20:56:48.942864 | debian-bookworm -> localhost | The key fingerprint is: 2026-10-01 20:56:48.942885 | debian-bookworm -> localhost | SHA256:uUbS4U8OIhu4Md49OawxR8N847Ht7EnGNwQRhQvpVVM zuul-build-sshkey 2026-10-01 20:56:48.942904 | debian-bookworm -> localhost | The key's randomart image is: 2026-10-01 20:56:48.942931 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-10-01 20:56:48.942950 | debian-bookworm -> localhost | | .o=+.E | 2026-10-01 20:56:48.942967 | debian-bookworm -> localhost | | o o. . | 2026-10-01 20:56:48.942984 | debian-bookworm -> localhost | | ..o.. | 2026-10-01 20:56:48.943000 | debian-bookworm -> localhost | | . o o.o.. | 2026-10-01 20:56:48.943017 | debian-bookworm -> localhost | | + o B S . . | 2026-10-01 20:56:48.943040 | debian-bookworm -> localhost | | . = B O % . | 2026-10-01 20:56:48.943057 | debian-bookworm -> localhost | | o = B = B o | 2026-10-01 20:56:48.943074 | debian-bookworm -> localhost | | = + = o . | 2026-10-01 20:56:48.943092 | debian-bookworm -> localhost | | . .= | 2026-10-01 20:56:48.943109 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-10-01 20:56:48.943151 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.273407 2026-10-01 20:56:48.948175 | 2026-10-01 20:56:48.948250 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-10-01 20:56:48.974810 | debian-bookworm | ok 2026-10-01 20:56:48.984601 | debian-bookworm | included: /var/lib/zuul/builds/4a6b6632ca5744949389417eba1a83fe/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-10-01 20:56:49.002342 | 2026-10-01 20:56:49.002428 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-10-01 20:56:49.025389 | debian-bookworm | skipping: Conditional result was False 2026-10-01 20:56:49.030071 | 2026-10-01 20:56:49.030146 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-10-01 20:56:49.756259 | debian-bookworm | changed 2026-10-01 20:56:49.760524 | 2026-10-01 20:56:49.760608 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-10-01 20:56:50.068848 | debian-bookworm | ok 2026-10-01 20:56:50.074139 | 2026-10-01 20:56:50.074214 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-10-01 20:56:50.771245 | debian-bookworm | changed 2026-10-01 20:56:50.776259 | 2026-10-01 20:56:50.776344 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-10-01 20:56:51.405224 | debian-bookworm | changed 2026-10-01 20:56:51.412147 | 2026-10-01 20:56:51.412239 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-10-01 20:56:51.442678 | debian-bookworm | skipping: Conditional result was False 2026-10-01 20:56:51.454954 | 2026-10-01 20:56:51.455116 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-10-01 20:56:51.970186 | debian-bookworm -> localhost | changed 2026-10-01 20:56:51.981068 | 2026-10-01 20:56:51.981156 | TASK [add-build-sshkey : Add back temp key] 2026-10-01 20:56:52.300077 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4a6b6632ca5744949389417eba1a83fe/work/4a6b6632ca5744949389417eba1a83fe_id_rsa (zuul-build-sshkey) 2026-10-01 20:56:52.300434 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008548 2026-10-01 20:56:52.312499 | 2026-10-01 20:56:52.312665 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-10-01 20:56:52.746266 | debian-bookworm | ok 2026-10-01 20:56:52.751696 | 2026-10-01 20:56:52.751799 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-10-01 20:56:52.794934 | debian-bookworm | skipping: Conditional result was False 2026-10-01 20:56:52.807793 | 2026-10-01 20:56:52.812774 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-10-01 20:56:53.489018 | debian-bookworm | ok 2026-10-01 20:56:53.505000 | 2026-10-01 20:56:53.505100 | TASK [validate-host : Define zuul_info_dir fact] 2026-10-01 20:56:53.549123 | debian-bookworm | ok 2026-10-01 20:56:53.554252 | 2026-10-01 20:56:53.554339 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-10-01 20:56:54.041914 | debian-bookworm -> localhost | ok 2026-10-01 20:56:54.047970 | 2026-10-01 20:56:54.048053 | TASK [validate-host : Collect information about the host] 2026-10-01 20:56:55.289997 | debian-bookworm | ok 2026-10-01 20:56:55.317051 | 2026-10-01 20:56:55.317153 | TASK [validate-host : Sanitize hostname] 2026-10-01 20:56:55.490195 | debian-bookworm | ok 2026-10-01 20:56:55.494746 | 2026-10-01 20:56:55.494833 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-10-01 20:56:56.041751 | debian-bookworm -> localhost | changed 2026-10-01 20:56:56.047094 | 2026-10-01 20:56:56.047180 | TASK [validate-host : Collect information about zuul worker] 2026-10-01 20:56:56.467980 | debian-bookworm | ok 2026-10-01 20:56:56.471689 | 2026-10-01 20:56:56.471764 | TASK [validate-host : Write out all zuul information for each host] 2026-10-01 20:56:57.184026 | debian-bookworm -> localhost | changed 2026-10-01 20:56:57.191601 | 2026-10-01 20:56:57.191679 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-10-01 20:56:57.590035 | debian-bookworm | ok 2026-10-01 20:56:57.594766 | 2026-10-01 20:56:57.594845 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-10-01 20:56:59.813701 | debian-bookworm | changed: 2026-10-01 20:56:59.813869 | debian-bookworm | cd+++++++++ src/ 2026-10-01 20:56:59.813898 | debian-bookworm | cd+++++++++ src/github.com/ 2026-10-01 20:56:59.813919 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-10-01 20:56:59.813938 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-10-01 20:56:59.813955 | debian-bookworm | Containerfile 2026-10-01 20:56:59.814065 | debian-bookworm | Containerfile 2026-10-01 20:56:59.831610 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/4a6b6632ca5744949389417eba1a83fe/work/logs" 2026-10-01 20:58:17.508884 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/4a6b6632ca5744949389417eba1a83fe/work/artifacts" 2026-10-01 20:58:17.804572 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/4a6b6632ca5744949389417eba1a83fe/work/docs" 2026-10-01 20:58:17.829250 | 2026-10-01 20:58:17.829418 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-10-01 20:58:18.617016 | debian-bookworm | changed: 2026-10-01 20:58:18.617355 | debian-bookworm | .d..t...... ./ 2026-10-01 20:58:18.617416 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-10-01 20:58:18.617458 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-10-01 20:58:18.617495 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-10-01 20:58:18.617571 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-10-01 20:58:18.617610 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-10-01 20:58:18.617671 | debian-bookworm | changed: All items complete 2026-10-01 20:58:18.617715 | 2026-10-01 20:58:19.218090 | debian-bookworm | changed: .d..t...... ./ 2026-10-01 20:58:19.775284 | debian-bookworm | changed: .d..t...... ./ 2026-10-01 20:58:19.802037 | 2026-10-01 20:58:19.802217 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-10-01 20:58:20.131603 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009988 2026-10-01 20:58:20.406898 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009511 2026-10-01 20:58:20.423189 | 2026-10-01 20:58:20.423292 | PLAY RECAP 2026-10-01 20:58:20.423362 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-10-01 20:58:20.423398 | 2026-10-01 20:58:20.549468 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-10-01 20:58:20.551784 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-01 20:58:21.297041 | 2026-10-01 20:58:21.297193 | PLAY [Base post] 2026-10-01 20:58:21.311873 | 2026-10-01 20:58:21.311993 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-10-01 20:58:21.906818 | debian-bookworm | changed 2026-10-01 20:58:21.917136 | 2026-10-01 20:58:21.917267 | PLAY RECAP 2026-10-01 20:58:21.917346 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-01 20:58:21.917423 | 2026-10-01 20:58:22.033246 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-01 20:58:22.035201 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-10-01 20:58:22.892065 | 2026-10-01 20:58:22.892231 | PLAY [Base post-logs] 2026-10-01 20:58:22.903593 | 2026-10-01 20:58:22.903724 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-10-01 20:58:23.369311 | localhost | changed 2026-10-01 20:58:23.385688 | 2026-10-01 20:58:23.385859 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-10-01 20:58:23.425698 | localhost | ok 2026-10-01 20:58:23.431358 | 2026-10-01 20:58:23.431540 | TASK [Set zuul-log-path fact] 2026-10-01 20:58:23.459703 | localhost | ok 2026-10-01 20:58:23.471981 | 2026-10-01 20:58:23.472105 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-01 20:58:23.508624 | localhost | ok 2026-10-01 20:58:23.514688 | 2026-10-01 20:58:23.514848 | TASK [upload-logs : Create log directories] 2026-10-01 20:58:24.040162 | localhost | changed 2026-10-01 20:58:24.048076 | 2026-10-01 20:58:24.048210 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-10-01 20:58:24.552485 | localhost -> localhost | ok: Runtime: 0:00:00.008394 2026-10-01 20:58:24.559672 | 2026-10-01 20:58:24.559832 | TASK [upload-logs : Upload logs to log server] 2026-10-01 20:58:25.178905 | localhost | Output suppressed because no_log was given 2026-10-01 20:58:25.181087 | 2026-10-01 20:58:25.181211 | LOOP [upload-logs : Compress console log and json output] 2026-10-01 20:58:25.229180 | localhost | skipping: Conditional result was False 2026-10-01 20:58:25.234813 | localhost | skipping: Conditional result was False 2026-10-01 20:58:25.242118 | 2026-10-01 20:58:25.242321 | LOOP [upload-logs : Upload compressed console log and json output] 2026-10-01 20:58:25.286813 | localhost | skipping: Conditional result was False 2026-10-01 20:58:25.287129 | 2026-10-01 20:58:25.292400 | localhost | skipping: Conditional result was False 2026-10-01 20:58:25.304017 | 2026-10-01 20:58:25.304273 | LOOP [upload-logs : Upload console log and json output]