2026-05-28 10:43:20.776698 | Job console starting 2026-05-28 10:43:20.795585 | Updating git repos 2026-05-28 10:43:20.828879 | Cloning repos into workspace 2026-05-28 10:43:20.860059 | Restoring repo states 2026-05-28 10:43:20.865067 | Merging changes 2026-05-28 10:43:21.304624 | Checking out repos 2026-05-28 10:43:21.355801 | Preparing playbooks 2026-05-28 10:43:22.079677 | Running Ansible setup 2026-05-28 10:43:26.467000 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-28 10:43:27.229206 | 2026-05-28 10:43:27.229376 | PLAY [Base pre] 2026-05-28 10:43:27.247360 | 2026-05-28 10:43:27.247514 | TASK [Setup log path fact] 2026-05-28 10:43:27.277192 | debian-bookworm | ok 2026-05-28 10:43:27.293582 | 2026-05-28 10:43:27.293761 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 10:43:27.333652 | debian-bookworm | ok 2026-05-28 10:43:27.344317 | 2026-05-28 10:43:27.344450 | TASK [emit-job-header : Print job information] 2026-05-28 10:43:27.383913 | # Job Information 2026-05-28 10:43:27.384103 | Ansible Version: 2.16.14 2026-05-28 10:43:27.384138 | Job: python-black 2026-05-28 10:43:27.384169 | Pipeline: check 2026-05-28 10:43:27.384192 | Executor: 521e9411259a 2026-05-28 10:43:27.384213 | Triggered by: https://github.com/osism/openstack-sandbox-manager/pull/108 2026-05-28 10:43:27.384234 | Event ID: 0556f7f0-5a82-11f1-86bf-d1e76f348225 2026-05-28 10:43:27.389199 | 2026-05-28 10:43:27.389308 | LOOP [emit-job-header : Print node information] 2026-05-28 10:43:27.499900 | debian-bookworm | ok: 2026-05-28 10:43:27.500099 | debian-bookworm | # Node Information 2026-05-28 10:43:27.500132 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-28 10:43:27.500157 | debian-bookworm | Hostname: debian 2026-05-28 10:43:27.500178 | debian-bookworm | Username: zuul 2026-05-28 10:43:27.500199 | debian-bookworm | Distro: Debian 12.14 2026-05-28 10:43:27.500223 | debian-bookworm | Provider: regiocloud-a 2026-05-28 10:43:27.500243 | debian-bookworm | Region: 2026-05-28 10:43:27.500264 | debian-bookworm | Label: debian-bookworm 2026-05-28 10:43:27.500284 | debian-bookworm | Product Name: OpenStack Nova 2026-05-28 10:43:27.500303 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0f:6cdd 2026-05-28 10:43:27.511694 | 2026-05-28 10:43:27.511814 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-28 10:43:27.996226 | debian-bookworm -> localhost | changed 2026-05-28 10:43:28.010333 | 2026-05-28 10:43:28.010531 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-28 10:43:29.066979 | debian-bookworm -> localhost | changed 2026-05-28 10:43:29.078295 | 2026-05-28 10:43:29.078430 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-28 10:43:29.345633 | debian-bookworm -> localhost | ok 2026-05-28 10:43:29.352106 | 2026-05-28 10:43:29.352245 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-28 10:43:29.382780 | debian-bookworm | ok 2026-05-28 10:43:29.398102 | debian-bookworm | included: /var/lib/zuul/builds/7c5789a71ea2433faa095da7fc7087cb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-28 10:43:29.404398 | 2026-05-28 10:43:29.404510 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-28 10:43:31.659216 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-28 10:43:31.659782 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7c5789a71ea2433faa095da7fc7087cb/work/7c5789a71ea2433faa095da7fc7087cb_id_rsa 2026-05-28 10:43:31.659892 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7c5789a71ea2433faa095da7fc7087cb/work/7c5789a71ea2433faa095da7fc7087cb_id_rsa.pub 2026-05-28 10:43:31.659967 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-28 10:43:31.660036 | debian-bookworm -> localhost | SHA256:Z8sqawp0dxInTTMVFa2UibIHAbeRj2wzpkKeG9LO6GE zuul-build-sshkey 2026-05-28 10:43:31.660101 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-28 10:43:31.660185 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-28 10:43:31.660248 | debian-bookworm -> localhost | | ..B+o+o= | 2026-05-28 10:43:31.660308 | debian-bookworm -> localhost | | ++=. + . | 2026-05-28 10:43:31.660365 | debian-bookworm -> localhost | | o.+* . . | 2026-05-28 10:43:31.660420 | debian-bookworm -> localhost | | . +O o . | 2026-05-28 10:43:31.660474 | debian-bookworm -> localhost | | .+..o+S+o | 2026-05-28 10:43:31.660540 | debian-bookworm -> localhost | | ...*..o + . | 2026-05-28 10:43:31.660619 | debian-bookworm -> localhost | | E= + o | 2026-05-28 10:43:31.660684 | debian-bookworm -> localhost | | ..o+ o . | 2026-05-28 10:43:31.660743 | debian-bookworm -> localhost | | .. .o.o. | 2026-05-28 10:43:31.660800 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-28 10:43:31.660939 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.765707 2026-05-28 10:43:31.674317 | 2026-05-28 10:43:31.674491 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-28 10:43:31.706157 | debian-bookworm | ok 2026-05-28 10:43:31.716317 | debian-bookworm | included: /var/lib/zuul/builds/7c5789a71ea2433faa095da7fc7087cb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-28 10:43:31.725759 | 2026-05-28 10:43:31.725871 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-28 10:43:31.749640 | debian-bookworm | skipping: Conditional result was False 2026-05-28 10:43:31.755543 | 2026-05-28 10:43:31.755673 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-28 10:43:32.414132 | debian-bookworm | changed 2026-05-28 10:43:32.420209 | 2026-05-28 10:43:32.420321 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-28 10:43:32.676491 | debian-bookworm | ok 2026-05-28 10:43:32.684102 | 2026-05-28 10:43:32.684244 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-28 10:43:33.379491 | debian-bookworm | changed 2026-05-28 10:43:33.390561 | 2026-05-28 10:43:33.390743 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-28 10:43:34.033447 | debian-bookworm | changed 2026-05-28 10:43:34.042677 | 2026-05-28 10:43:34.042797 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-28 10:43:34.076631 | debian-bookworm | skipping: Conditional result was False 2026-05-28 10:43:34.091354 | 2026-05-28 10:43:34.091535 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-28 10:43:34.559117 | debian-bookworm -> localhost | changed 2026-05-28 10:43:34.576136 | 2026-05-28 10:43:34.576293 | TASK [add-build-sshkey : Add back temp key] 2026-05-28 10:43:34.911852 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7c5789a71ea2433faa095da7fc7087cb/work/7c5789a71ea2433faa095da7fc7087cb_id_rsa (zuul-build-sshkey) 2026-05-28 10:43:34.912252 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016036 2026-05-28 10:43:34.923819 | 2026-05-28 10:43:34.923947 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-28 10:43:35.379701 | debian-bookworm | ok 2026-05-28 10:43:35.392964 | 2026-05-28 10:43:35.393246 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-28 10:43:35.420272 | debian-bookworm | skipping: Conditional result was False 2026-05-28 10:43:35.440294 | 2026-05-28 10:43:35.440449 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-28 10:43:35.893726 | debian-bookworm | ok 2026-05-28 10:43:35.909576 | 2026-05-28 10:43:35.909768 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-28 10:43:35.959125 | debian-bookworm | ok 2026-05-28 10:43:35.968954 | 2026-05-28 10:43:35.969130 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-28 10:43:36.310237 | debian-bookworm -> localhost | ok 2026-05-28 10:43:36.317460 | 2026-05-28 10:43:36.317628 | TASK [validate-host : Collect information about the host] 2026-05-28 10:43:37.430773 | debian-bookworm | ok 2026-05-28 10:43:37.441939 | 2026-05-28 10:43:37.442065 | TASK [validate-host : Sanitize hostname] 2026-05-28 10:43:37.542458 | debian-bookworm | ok 2026-05-28 10:43:37.585546 | 2026-05-28 10:43:37.585711 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-28 10:43:38.146716 | debian-bookworm -> localhost | changed 2026-05-28 10:43:38.153027 | 2026-05-28 10:43:38.153157 | TASK [validate-host : Collect information about zuul worker] 2026-05-28 10:43:38.568168 | debian-bookworm | ok 2026-05-28 10:43:38.580550 | 2026-05-28 10:43:38.580755 | TASK [validate-host : Write out all zuul information for each host] 2026-05-28 10:43:39.172989 | debian-bookworm -> localhost | changed 2026-05-28 10:43:39.183111 | 2026-05-28 10:43:39.183238 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-28 10:43:39.457281 | debian-bookworm | ok 2026-05-28 10:43:39.463835 | 2026-05-28 10:43:39.463962 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-28 10:43:40.275227 | debian-bookworm | changed: 2026-05-28 10:43:40.275436 | debian-bookworm | cd+++++++++ src/ 2026-05-28 10:43:40.275471 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-28 10:43:40.275497 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-28 10:43:40.275519 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2026-05-28 10:43:40.275539 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/7c5789a71ea2433faa095da7fc7087cb/work/logs" 2026-05-28 10:44:04.456282 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/7c5789a71ea2433faa095da7fc7087cb/work/artifacts" 2026-05-28 10:44:04.740768 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/7c5789a71ea2433faa095da7fc7087cb/work/docs" 2026-05-28 10:44:04.770772 | 2026-05-28 10:44:04.771006 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-28 10:44:05.584965 | debian-bookworm | changed: 2026-05-28 10:44:05.585275 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-28 10:44:05.585330 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-28 10:44:05.585374 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-28 10:44:05.585432 | debian-bookworm | changed: All items complete 2026-05-28 10:44:05.585465 | 2026-05-28 10:44:06.141841 | debian-bookworm | changed: .d..t...... ./ 2026-05-28 10:44:06.712174 | debian-bookworm | changed: .d..t...... ./ 2026-05-28 10:44:06.730146 | 2026-05-28 10:44:06.730299 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-28 10:44:07.256052 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006085 2026-05-28 10:44:07.560815 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010374 2026-05-28 10:44:07.573110 | 2026-05-28 10:44:07.573230 | PLAY RECAP 2026-05-28 10:44:07.573291 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-28 10:44:07.573323 | 2026-05-28 10:44:07.744185 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-28 10:44:07.745087 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 10:44:08.506857 | 2026-05-28 10:44:08.507036 | PLAY [Base post] 2026-05-28 10:44:08.521079 | 2026-05-28 10:44:08.521237 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-28 10:44:09.080165 | debian-bookworm | changed 2026-05-28 10:44:09.086934 | 2026-05-28 10:44:09.087065 | PLAY RECAP 2026-05-28 10:44:09.087134 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-28 10:44:09.087198 | 2026-05-28 10:44:09.241525 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 10:44:09.242395 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-28 10:44:10.060696 | 2026-05-28 10:44:10.060893 | PLAY [Base post-logs] 2026-05-28 10:44:10.072456 | 2026-05-28 10:44:10.072680 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-28 10:44:10.539674 | localhost | changed 2026-05-28 10:44:10.550174 | 2026-05-28 10:44:10.550362 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-28 10:44:10.575967 | localhost | ok 2026-05-28 10:44:10.579287 | 2026-05-28 10:44:10.579389 | TASK [Set zuul-log-path fact] 2026-05-28 10:44:10.594209 | localhost | ok 2026-05-28 10:44:10.602339 | 2026-05-28 10:44:10.602460 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 10:44:10.631492 | localhost | ok 2026-05-28 10:44:10.637649 | 2026-05-28 10:44:10.637823 | TASK [upload-logs : Create log directories] 2026-05-28 10:44:11.189731 | localhost | changed 2026-05-28 10:44:11.202400 | 2026-05-28 10:44:11.202570 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-28 10:44:11.723567 | localhost -> localhost | ok: Runtime: 0:00:00.008919 2026-05-28 10:44:11.727804 | 2026-05-28 10:44:11.727926 | TASK [upload-logs : Upload logs to log server] 2026-05-28 10:44:12.344275 | localhost | Output suppressed because no_log was given 2026-05-28 10:44:12.348180 | 2026-05-28 10:44:12.348319 | LOOP [upload-logs : Compress console log and json output] 2026-05-28 10:44:12.403285 | localhost | skipping: Conditional result was False 2026-05-28 10:44:12.413894 | localhost | skipping: Conditional result was False 2026-05-28 10:44:12.428949 | 2026-05-28 10:44:12.429135 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-28 10:44:12.491656 | localhost | skipping: Conditional result was False 2026-05-28 10:44:12.492335 | 2026-05-28 10:44:12.494531 | localhost | skipping: Conditional result was False 2026-05-28 10:44:12.505115 | 2026-05-28 10:44:12.505240 | LOOP [upload-logs : Upload console log and json output]