2026-08-30 10:40:45.643095 | Job console starting 2026-08-30 10:40:45.654817 | Updating git repos 2026-08-30 10:40:45.716164 | Cloning repos into workspace 2026-08-30 10:40:45.809751 | Restoring repo states 2026-08-30 10:40:45.825680 | Merging changes 2026-08-30 10:40:46.593489 | Checking out repos 2026-08-30 10:40:46.628718 | Preparing playbooks 2026-08-30 10:40:47.233127 | Running Ansible setup 2026-08-30 10:40:51.948659 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-30 10:40:53.294474 | 2026-08-30 10:40:53.294673 | PLAY [Base pre] 2026-08-30 10:40:53.336363 | 2026-08-30 10:40:53.336543 | TASK [Setup log path fact] 2026-08-30 10:40:53.362324 | debian-bookworm | ok 2026-08-30 10:40:53.389589 | 2026-08-30 10:40:53.389781 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-30 10:40:53.492254 | debian-bookworm | ok 2026-08-30 10:40:53.522684 | 2026-08-30 10:40:53.525234 | TASK [emit-job-header : Print job information] 2026-08-30 10:40:53.636506 | # Job Information 2026-08-30 10:40:53.636781 | Ansible Version: 2.16.14 2026-08-30 10:40:53.636821 | Job: python-black 2026-08-30 10:40:53.636855 | Pipeline: check 2026-08-30 10:40:53.636879 | Executor: 521e9411259a 2026-08-30 10:40:53.636900 | Triggered by: https://github.com/osism/python-osism/pull/2648 2026-08-30 10:40:53.636939 | Event ID: 129a0c50-a45f-11f1-98b4-7b15f64c7004 2026-08-30 10:40:53.642233 | 2026-08-30 10:40:53.642363 | LOOP [emit-job-header : Print node information] 2026-08-30 10:40:54.035753 | debian-bookworm | ok: 2026-08-30 10:40:54.036060 | debian-bookworm | # Node Information 2026-08-30 10:40:54.036101 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-30 10:40:54.036127 | debian-bookworm | Hostname: debian 2026-08-30 10:40:54.036148 | debian-bookworm | Username: zuul 2026-08-30 10:40:54.036169 | debian-bookworm | Distro: Debian 12.15 2026-08-30 10:40:54.036194 | debian-bookworm | Provider: regiocloud-a 2026-08-30 10:40:54.036215 | debian-bookworm | Region: 2026-08-30 10:40:54.036238 | debian-bookworm | Label: debian-bookworm 2026-08-30 10:40:54.036258 | debian-bookworm | Product Name: OpenStack Nova 2026-08-30 10:40:54.036277 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe47:7aa5 2026-08-30 10:40:54.056718 | 2026-08-30 10:40:54.056885 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-30 10:40:54.815764 | debian-bookworm -> localhost | changed 2026-08-30 10:40:54.824567 | 2026-08-30 10:40:54.824713 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-30 10:40:57.299520 | debian-bookworm -> localhost | changed 2026-08-30 10:40:57.315318 | 2026-08-30 10:40:57.315490 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-30 10:40:57.928422 | debian-bookworm -> localhost | ok 2026-08-30 10:40:57.934463 | 2026-08-30 10:40:57.934570 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-30 10:40:57.964990 | debian-bookworm | ok 2026-08-30 10:40:58.002797 | debian-bookworm | included: /var/lib/zuul/builds/77c24d9b47a94b4ebf773e8923598b88/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-30 10:40:58.036903 | 2026-08-30 10:40:58.037049 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-30 10:40:59.458208 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-30 10:40:59.458401 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/77c24d9b47a94b4ebf773e8923598b88/work/77c24d9b47a94b4ebf773e8923598b88_id_rsa 2026-08-30 10:40:59.458433 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/77c24d9b47a94b4ebf773e8923598b88/work/77c24d9b47a94b4ebf773e8923598b88_id_rsa.pub 2026-08-30 10:40:59.458464 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-30 10:40:59.458486 | debian-bookworm -> localhost | SHA256:gVC+dXtjQ/ZAwORiOsqz99UDuZfgYfCyj8CxLeRLiSI zuul-build-sshkey 2026-08-30 10:40:59.458505 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-30 10:40:59.458532 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-30 10:40:59.458550 | debian-bookworm -> localhost | | ... oo.. | 2026-08-30 10:40:59.458568 | debian-bookworm -> localhost | | o . ... | 2026-08-30 10:40:59.458584 | debian-bookworm -> localhost | | o * o + | 2026-08-30 10:40:59.458601 | debian-bookworm -> localhost | | = * = o | 2026-08-30 10:40:59.458617 | debian-bookworm -> localhost | | * S O = . | 2026-08-30 10:40:59.458642 | debian-bookworm -> localhost | | . * * = O + | 2026-08-30 10:40:59.458659 | debian-bookworm -> localhost | |E . = O o + = | 2026-08-30 10:40:59.458676 | debian-bookworm -> localhost | | . . +.+ + . . | 2026-08-30 10:40:59.458692 | debian-bookworm -> localhost | | ....o . | 2026-08-30 10:40:59.458709 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-30 10:40:59.458755 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.644653 2026-08-30 10:40:59.476347 | 2026-08-30 10:40:59.476445 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-30 10:40:59.541543 | debian-bookworm | ok 2026-08-30 10:40:59.569607 | debian-bookworm | included: /var/lib/zuul/builds/77c24d9b47a94b4ebf773e8923598b88/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-30 10:40:59.587628 | 2026-08-30 10:40:59.587739 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-30 10:40:59.663632 | debian-bookworm | skipping: Conditional result was False 2026-08-30 10:40:59.668681 | 2026-08-30 10:40:59.668771 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-30 10:41:00.525738 | debian-bookworm | changed 2026-08-30 10:41:00.530294 | 2026-08-30 10:41:00.530375 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-30 10:41:00.889455 | debian-bookworm | ok 2026-08-30 10:41:00.895103 | 2026-08-30 10:41:00.895196 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-30 10:41:01.657549 | debian-bookworm | changed 2026-08-30 10:41:01.669031 | 2026-08-30 10:41:01.669148 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-30 10:41:02.495056 | debian-bookworm | changed 2026-08-30 10:41:02.504527 | 2026-08-30 10:41:02.504654 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-30 10:41:02.553058 | debian-bookworm | skipping: Conditional result was False 2026-08-30 10:41:02.560044 | 2026-08-30 10:41:02.560307 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-30 10:41:03.304972 | debian-bookworm -> localhost | changed 2026-08-30 10:41:03.320450 | 2026-08-30 10:41:03.320595 | TASK [add-build-sshkey : Add back temp key] 2026-08-30 10:41:03.828965 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/77c24d9b47a94b4ebf773e8923598b88/work/77c24d9b47a94b4ebf773e8923598b88_id_rsa (zuul-build-sshkey) 2026-08-30 10:41:03.829187 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014869 2026-08-30 10:41:03.836526 | 2026-08-30 10:41:03.836626 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-30 10:41:04.234768 | debian-bookworm | ok 2026-08-30 10:41:04.240210 | 2026-08-30 10:41:04.240307 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-30 10:41:04.263972 | debian-bookworm | skipping: Conditional result was False 2026-08-30 10:41:04.272721 | 2026-08-30 10:41:04.272801 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-30 10:41:04.762556 | debian-bookworm | ok 2026-08-30 10:41:04.773172 | 2026-08-30 10:41:04.773275 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-30 10:41:04.807765 | debian-bookworm | ok 2026-08-30 10:41:04.812862 | 2026-08-30 10:41:04.812983 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-30 10:41:05.219282 | debian-bookworm -> localhost | ok 2026-08-30 10:41:05.226004 | 2026-08-30 10:41:05.226104 | TASK [validate-host : Collect information about the host] 2026-08-30 10:41:06.463150 | debian-bookworm | ok 2026-08-30 10:41:06.482080 | 2026-08-30 10:41:06.482192 | TASK [validate-host : Sanitize hostname] 2026-08-30 10:41:06.615425 | debian-bookworm | ok 2026-08-30 10:41:06.622382 | 2026-08-30 10:41:06.622494 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-30 10:41:07.496439 | debian-bookworm -> localhost | changed 2026-08-30 10:41:07.502424 | 2026-08-30 10:41:07.502524 | TASK [validate-host : Collect information about zuul worker] 2026-08-30 10:41:08.082449 | debian-bookworm | ok 2026-08-30 10:41:08.093578 | 2026-08-30 10:41:08.093725 | TASK [validate-host : Write out all zuul information for each host] 2026-08-30 10:41:08.839526 | debian-bookworm -> localhost | changed 2026-08-30 10:41:08.853883 | 2026-08-30 10:41:08.854077 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-30 10:41:09.188894 | debian-bookworm | ok 2026-08-30 10:41:09.194035 | 2026-08-30 10:41:09.194135 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-30 10:41:11.530797 | debian-bookworm | changed: 2026-08-30 10:41:11.531087 | debian-bookworm | cd+++++++++ src/ 2026-08-30 10:41:11.531128 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-30 10:41:11.531153 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-30 10:41:11.531174 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-30 10:41:11.531194 | debian-bookworm | Containerfile 2026-08-30 10:41:11.531324 | debian-bookworm | Containerfile 2026-08-30 10:41:11.547136 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/77c24d9b47a94b4ebf773e8923598b88/work/logs" 2026-08-30 10:42:30.393481 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/77c24d9b47a94b4ebf773e8923598b88/work/artifacts" 2026-08-30 10:42:30.715190 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/77c24d9b47a94b4ebf773e8923598b88/work/docs" 2026-08-30 10:42:30.726576 | 2026-08-30 10:42:30.726718 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-30 10:42:31.512529 | debian-bookworm | changed: 2026-08-30 10:42:31.512804 | debian-bookworm | .d..t...... ./ 2026-08-30 10:42:31.512844 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-30 10:42:31.512870 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-30 10:42:31.512892 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-30 10:42:31.512913 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-30 10:42:31.512934 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-30 10:42:31.512976 | debian-bookworm | changed: All items complete 2026-08-30 10:42:31.513040 | 2026-08-30 10:42:32.068222 | debian-bookworm | changed: .d..t...... ./ 2026-08-30 10:42:32.687038 | debian-bookworm | changed: .d..t...... ./ 2026-08-30 10:42:32.711569 | 2026-08-30 10:42:32.711739 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-30 10:42:33.065972 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.008054 2026-08-30 10:42:33.455207 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.030553 2026-08-30 10:42:33.469952 | 2026-08-30 10:42:33.470193 | PLAY RECAP 2026-08-30 10:42:33.470253 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-30 10:42:33.470278 | 2026-08-30 10:42:33.880492 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-30 10:42:33.881414 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-30 10:42:34.989437 | 2026-08-30 10:42:34.989625 | PLAY [Base post] 2026-08-30 10:42:35.007395 | 2026-08-30 10:42:35.007550 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-30 10:42:35.746440 | debian-bookworm | changed 2026-08-30 10:42:35.756258 | 2026-08-30 10:42:35.756409 | PLAY RECAP 2026-08-30 10:42:35.756478 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-30 10:42:35.756540 | 2026-08-30 10:42:36.056713 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-30 10:42:36.057671 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-30 10:42:37.420551 | 2026-08-30 10:42:37.420694 | PLAY [Base post-logs] 2026-08-30 10:42:37.437457 | 2026-08-30 10:42:37.437592 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-30 10:42:37.970386 | localhost | changed 2026-08-30 10:42:37.986463 | 2026-08-30 10:42:37.986616 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-30 10:42:38.058681 | localhost | ok 2026-08-30 10:42:38.061808 | 2026-08-30 10:42:38.061891 | TASK [Set zuul-log-path fact] 2026-08-30 10:42:38.087519 | localhost | ok 2026-08-30 10:42:38.101597 | 2026-08-30 10:42:38.101712 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-30 10:42:38.158818 | localhost | ok 2026-08-30 10:42:38.161757 | 2026-08-30 10:42:38.161844 | TASK [upload-logs : Create log directories] 2026-08-30 10:42:39.404935 | localhost | changed 2026-08-30 10:42:39.407914 | 2026-08-30 10:42:39.408036 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-30 10:42:40.211721 | localhost -> localhost | ok: Runtime: 0:00:00.032535 2026-08-30 10:42:40.215506 | 2026-08-30 10:42:40.215597 | TASK [upload-logs : Upload logs to log server] 2026-08-30 10:42:41.772901 | localhost | Output suppressed because no_log was given 2026-08-30 10:42:41.774368 | 2026-08-30 10:42:41.774442 | LOOP [upload-logs : Compress console log and json output] 2026-08-30 10:42:41.921016 | localhost | skipping: Conditional result was False 2026-08-30 10:42:41.936145 | localhost | skipping: Conditional result was False 2026-08-30 10:42:41.950819 | 2026-08-30 10:42:41.950936 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-30 10:42:42.059411 | localhost | skipping: Conditional result was False 2026-08-30 10:42:42.059700 | 2026-08-30 10:42:42.066677 | localhost | skipping: Conditional result was False 2026-08-30 10:42:42.076501 | 2026-08-30 10:42:42.076598 | LOOP [upload-logs : Upload console log and json output]