2026-06-02 12:55:52.283248 | Job console starting 2026-06-02 12:55:52.312690 | Updating git repos 2026-06-02 12:55:52.395695 | Cloning repos into workspace 2026-06-02 12:55:52.480948 | Restoring repo states 2026-06-02 12:55:52.493665 | Merging changes 2026-06-02 12:55:53.113084 | Checking out repos 2026-06-02 12:55:53.224257 | Preparing playbooks 2026-06-02 12:55:54.811230 | Running Ansible setup 2026-06-02 12:55:59.783135 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-02 12:56:00.781088 | 2026-06-02 12:56:00.781198 | PLAY [Base pre] 2026-06-02 12:56:00.804753 | 2026-06-02 12:56:00.804866 | TASK [Setup log path fact] 2026-06-02 12:56:00.821495 | debian-bookworm | ok 2026-06-02 12:56:00.834424 | 2026-06-02 12:56:00.834538 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-02 12:56:00.860923 | debian-bookworm | ok 2026-06-02 12:56:00.869528 | 2026-06-02 12:56:00.869618 | TASK [emit-job-header : Print job information] 2026-06-02 12:56:00.919687 | # Job Information 2026-06-02 12:56:00.919825 | Ansible Version: 2.16.14 2026-06-02 12:56:00.919853 | Job: python-black 2026-06-02 12:56:00.919879 | Pipeline: check 2026-06-02 12:56:00.919899 | Executor: 521e9411259a 2026-06-02 12:56:00.919916 | Triggered by: https://github.com/osism/python-osism/pull/2322 2026-06-02 12:56:00.919935 | Event ID: 5cbe4990-5e82-11f1-9676-76106bb04b65 2026-06-02 12:56:00.924816 | 2026-06-02 12:56:00.924902 | LOOP [emit-job-header : Print node information] 2026-06-02 12:56:01.074690 | debian-bookworm | ok: 2026-06-02 12:56:01.074845 | debian-bookworm | # Node Information 2026-06-02 12:56:01.074877 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-02 12:56:01.074897 | debian-bookworm | Hostname: debian 2026-06-02 12:56:01.074915 | debian-bookworm | Username: zuul 2026-06-02 12:56:01.074932 | debian-bookworm | Distro: Debian 12.14 2026-06-02 12:56:01.074951 | debian-bookworm | Provider: regiocloud-a 2026-06-02 12:56:01.074968 | debian-bookworm | Region: 2026-06-02 12:56:01.074986 | debian-bookworm | Label: debian-bookworm 2026-06-02 12:56:01.075002 | debian-bookworm | Product Name: OpenStack Nova 2026-06-02 12:56:01.075019 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe24:c737 2026-06-02 12:56:01.088539 | 2026-06-02 12:56:01.088663 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-02 12:56:02.121687 | debian-bookworm -> localhost | changed 2026-06-02 12:56:02.127400 | 2026-06-02 12:56:02.127490 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-02 12:56:04.275484 | debian-bookworm -> localhost | changed 2026-06-02 12:56:04.284061 | 2026-06-02 12:56:04.284159 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-02 12:56:05.037682 | debian-bookworm -> localhost | ok 2026-06-02 12:56:05.042827 | 2026-06-02 12:56:05.042963 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-02 12:56:05.062076 | debian-bookworm | ok 2026-06-02 12:56:05.078715 | debian-bookworm | included: /var/lib/zuul/builds/4a12fc56f27b4de6a1ab258d2d52cd26/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-02 12:56:05.094955 | 2026-06-02 12:56:05.095055 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-02 12:56:06.649083 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-02 12:56:06.649243 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4a12fc56f27b4de6a1ab258d2d52cd26/work/4a12fc56f27b4de6a1ab258d2d52cd26_id_rsa 2026-06-02 12:56:06.649272 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4a12fc56f27b4de6a1ab258d2d52cd26/work/4a12fc56f27b4de6a1ab258d2d52cd26_id_rsa.pub 2026-06-02 12:56:06.649292 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-02 12:56:06.649312 | debian-bookworm -> localhost | SHA256:8H2QiyIWefa7GkfmYF9bicp3s0LISyIP8ZAdYHZNzUs zuul-build-sshkey 2026-06-02 12:56:06.649330 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-02 12:56:06.649356 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-02 12:56:06.649374 | debian-bookworm -> localhost | | +..o.o | 2026-06-02 12:56:06.649391 | debian-bookworm -> localhost | | o o. . E. | 2026-06-02 12:56:06.649408 | debian-bookworm -> localhost | | oo+. .o. | 2026-06-02 12:56:06.649424 | debian-bookworm -> localhost | | ++.+ o.+ . | 2026-06-02 12:56:06.649440 | debian-bookworm -> localhost | | o++.S.= + | 2026-06-02 12:56:06.649462 | debian-bookworm -> localhost | | .oooO++.+ | 2026-06-02 12:56:06.649478 | debian-bookworm -> localhost | | +.oBoo o | 2026-06-02 12:56:06.649494 | debian-bookworm -> localhost | | .o.o.. o | 2026-06-02 12:56:06.649511 | debian-bookworm -> localhost | | ... .. | 2026-06-02 12:56:06.649527 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-02 12:56:06.649568 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.865829 2026-06-02 12:56:06.654596 | 2026-06-02 12:56:06.654700 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-02 12:56:06.680904 | debian-bookworm | ok 2026-06-02 12:56:06.687989 | debian-bookworm | included: /var/lib/zuul/builds/4a12fc56f27b4de6a1ab258d2d52cd26/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-02 12:56:06.719986 | 2026-06-02 12:56:06.720113 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-02 12:56:06.743663 | debian-bookworm | skipping: Conditional result was False 2026-06-02 12:56:06.749205 | 2026-06-02 12:56:06.749289 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-02 12:56:07.479488 | debian-bookworm | changed 2026-06-02 12:56:07.483805 | 2026-06-02 12:56:07.483887 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-02 12:56:07.737338 | debian-bookworm | ok 2026-06-02 12:56:07.741849 | 2026-06-02 12:56:07.741926 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-02 12:56:08.465570 | debian-bookworm | changed 2026-06-02 12:56:08.484611 | 2026-06-02 12:56:08.484745 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-02 12:56:09.144500 | debian-bookworm | changed 2026-06-02 12:56:09.155878 | 2026-06-02 12:56:09.156017 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-02 12:56:09.179250 | debian-bookworm | skipping: Conditional result was False 2026-06-02 12:56:09.185824 | 2026-06-02 12:56:09.185918 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-02 12:56:09.694954 | debian-bookworm -> localhost | changed 2026-06-02 12:56:09.708446 | 2026-06-02 12:56:09.708555 | TASK [add-build-sshkey : Add back temp key] 2026-06-02 12:56:10.065429 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4a12fc56f27b4de6a1ab258d2d52cd26/work/4a12fc56f27b4de6a1ab258d2d52cd26_id_rsa (zuul-build-sshkey) 2026-06-02 12:56:10.065616 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016349 2026-06-02 12:56:10.080029 | 2026-06-02 12:56:10.080125 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-02 12:56:10.451972 | debian-bookworm | ok 2026-06-02 12:56:10.457140 | 2026-06-02 12:56:10.457232 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-02 12:56:10.511772 | debian-bookworm | skipping: Conditional result was False 2026-06-02 12:56:10.525357 | 2026-06-02 12:56:10.525468 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-02 12:56:11.000037 | debian-bookworm | ok 2026-06-02 12:56:11.017547 | 2026-06-02 12:56:11.017678 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-02 12:56:11.053430 | debian-bookworm | ok 2026-06-02 12:56:11.058387 | 2026-06-02 12:56:11.058483 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-02 12:56:11.377444 | debian-bookworm -> localhost | ok 2026-06-02 12:56:11.384030 | 2026-06-02 12:56:11.384338 | TASK [validate-host : Collect information about the host] 2026-06-02 12:56:12.560729 | debian-bookworm | ok 2026-06-02 12:56:12.577128 | 2026-06-02 12:56:12.577240 | TASK [validate-host : Sanitize hostname] 2026-06-02 12:56:12.670701 | debian-bookworm | ok 2026-06-02 12:56:12.705764 | 2026-06-02 12:56:12.705870 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-02 12:56:13.299243 | debian-bookworm -> localhost | changed 2026-06-02 12:56:13.304673 | 2026-06-02 12:56:13.304763 | TASK [validate-host : Collect information about zuul worker] 2026-06-02 12:56:13.702191 | debian-bookworm | ok 2026-06-02 12:56:13.706185 | 2026-06-02 12:56:13.706268 | TASK [validate-host : Write out all zuul information for each host] 2026-06-02 12:56:14.284938 | debian-bookworm -> localhost | changed 2026-06-02 12:56:14.292485 | 2026-06-02 12:56:14.292571 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-02 12:56:14.545501 | debian-bookworm | ok 2026-06-02 12:56:14.549878 | 2026-06-02 12:56:14.549957 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-02 12:56:15.772921 | debian-bookworm | changed: 2026-06-02 12:56:15.773070 | debian-bookworm | cd+++++++++ src/ 2026-06-02 12:56:15.773098 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-02 12:56:15.773118 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-02 12:56:15.773135 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-06-02 12:56:15.773152 | debian-bookworm | Containerfile 2026-06-02 12:56:15.773257 | debian-bookworm | Containerfile 2026-06-02 12:56:15.779641 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/4a12fc56f27b4de6a1ab258d2d52cd26/work/logs" 2026-06-02 12:56:48.581664 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/4a12fc56f27b4de6a1ab258d2d52cd26/work/artifacts" 2026-06-02 12:56:48.860931 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/4a12fc56f27b4de6a1ab258d2d52cd26/work/docs" 2026-06-02 12:56:48.879310 | 2026-06-02 12:56:48.879472 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-02 12:56:49.743050 | debian-bookworm | changed: 2026-06-02 12:56:49.743435 | debian-bookworm | .d..t...... ./ 2026-06-02 12:56:49.743513 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-02 12:56:49.743580 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-02 12:56:49.743651 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-02 12:56:49.743735 | debian-bookworm | changed: All items complete 2026-06-02 12:56:49.743793 | 2026-06-02 12:56:50.347555 | debian-bookworm | changed: .d..t...... ./ 2026-06-02 12:56:50.943032 | debian-bookworm | changed: .d..t...... ./ 2026-06-02 12:56:50.966176 | 2026-06-02 12:56:50.966317 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-02 12:56:51.527486 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.008193 2026-06-02 12:56:51.807551 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.007188 2026-06-02 12:56:51.832103 | 2026-06-02 12:56:51.832266 | PLAY RECAP 2026-06-02 12:56:51.832365 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-02 12:56:51.832418 | 2026-06-02 12:56:51.983166 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-02 12:56:51.984182 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-02 12:56:52.787288 | 2026-06-02 12:56:52.787462 | PLAY [Base post] 2026-06-02 12:56:52.801482 | 2026-06-02 12:56:52.801674 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-02 12:56:53.410505 | debian-bookworm | changed 2026-06-02 12:56:53.423036 | 2026-06-02 12:56:53.423242 | PLAY RECAP 2026-06-02 12:56:53.423312 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-02 12:56:53.423376 | 2026-06-02 12:56:53.578516 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-02 12:56:53.579559 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-02 12:56:54.421001 | 2026-06-02 12:56:54.421178 | PLAY [Base post-logs] 2026-06-02 12:56:54.431995 | 2026-06-02 12:56:54.432126 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-02 12:56:54.938231 | localhost | changed 2026-06-02 12:56:54.949027 | 2026-06-02 12:56:54.949197 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-02 12:56:54.976085 | localhost | ok 2026-06-02 12:56:54.979224 | 2026-06-02 12:56:54.979334 | TASK [Set zuul-log-path fact] 2026-06-02 12:56:54.994172 | localhost | ok 2026-06-02 12:56:55.002416 | 2026-06-02 12:56:55.002538 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-02 12:56:55.028045 | localhost | ok 2026-06-02 12:56:55.031510 | 2026-06-02 12:56:55.031653 | TASK [upload-logs : Create log directories] 2026-06-02 12:56:55.576706 | localhost | changed 2026-06-02 12:56:55.580172 | 2026-06-02 12:56:55.580326 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-02 12:56:56.085496 | localhost -> localhost | ok: Runtime: 0:00:00.005603 2026-06-02 12:56:56.089904 | 2026-06-02 12:56:56.090032 | TASK [upload-logs : Upload logs to log server] 2026-06-02 12:56:56.696444 | localhost | Output suppressed because no_log was given 2026-06-02 12:56:56.698347 | 2026-06-02 12:56:56.698451 | LOOP [upload-logs : Compress console log and json output] 2026-06-02 12:56:56.747887 | localhost | skipping: Conditional result was False 2026-06-02 12:56:56.753906 | localhost | skipping: Conditional result was False 2026-06-02 12:56:56.765355 | 2026-06-02 12:56:56.765478 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-02 12:56:56.811430 | localhost | skipping: Conditional result was False 2026-06-02 12:56:56.812051 | 2026-06-02 12:56:56.816322 | localhost | skipping: Conditional result was False 2026-06-02 12:56:56.824740 | 2026-06-02 12:56:56.824868 | LOOP [upload-logs : Upload console log and json output]