2026-08-30 16:47:56.218323 | Job console starting 2026-08-30 16:47:56.231073 | Updating git repos 2026-08-30 16:47:56.282364 | Cloning repos into workspace 2026-08-30 16:47:56.338058 | Restoring repo states 2026-08-30 16:47:56.363227 | Merging changes 2026-08-30 16:47:57.272254 | Checking out repos 2026-08-30 16:47:57.392018 | Preparing playbooks 2026-08-30 16:47:58.694449 | Running Ansible setup 2026-08-30 16:48:05.013747 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-30 16:48:05.984930 | 2026-08-30 16:48:05.985092 | PLAY [Base pre] 2026-08-30 16:48:06.037239 | 2026-08-30 16:48:06.037381 | TASK [Setup log path fact] 2026-08-30 16:48:06.077386 | debian-bookworm | ok 2026-08-30 16:48:06.115561 | 2026-08-30 16:48:06.115729 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-30 16:48:06.189607 | debian-bookworm | ok 2026-08-30 16:48:06.199315 | 2026-08-30 16:48:06.199432 | TASK [emit-job-header : Print job information] 2026-08-30 16:48:06.240497 | # Job Information 2026-08-30 16:48:06.240702 | Ansible Version: 2.16.14 2026-08-30 16:48:06.240738 | Job: python-black 2026-08-30 16:48:06.240775 | Pipeline: check 2026-08-30 16:48:06.240804 | Executor: 521e9411259a 2026-08-30 16:48:06.240825 | Triggered by: https://github.com/osism/python-osism/pull/2640 2026-08-30 16:48:06.240847 | Event ID: 862d4410-a492-11f1-9022-b0377e70c450 2026-08-30 16:48:06.249247 | 2026-08-30 16:48:06.249358 | LOOP [emit-job-header : Print node information] 2026-08-30 16:48:06.389223 | debian-bookworm | ok: 2026-08-30 16:48:06.389453 | debian-bookworm | # Node Information 2026-08-30 16:48:06.389492 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-30 16:48:06.389518 | debian-bookworm | Hostname: debian 2026-08-30 16:48:06.389540 | debian-bookworm | Username: zuul 2026-08-30 16:48:06.389561 | debian-bookworm | Distro: Debian 12.15 2026-08-30 16:48:06.389584 | debian-bookworm | Provider: regiocloud-a 2026-08-30 16:48:06.389606 | debian-bookworm | Region: 2026-08-30 16:48:06.389627 | debian-bookworm | Label: debian-bookworm 2026-08-30 16:48:06.389647 | debian-bookworm | Product Name: OpenStack Nova 2026-08-30 16:48:06.389666 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3a:5c8f 2026-08-30 16:48:06.409224 | 2026-08-30 16:48:06.409336 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-30 16:48:07.703407 | debian-bookworm -> localhost | changed 2026-08-30 16:48:07.712378 | 2026-08-30 16:48:07.712529 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-30 16:48:10.135394 | debian-bookworm -> localhost | changed 2026-08-30 16:48:10.153971 | 2026-08-30 16:48:10.154081 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-30 16:48:10.800019 | debian-bookworm -> localhost | ok 2026-08-30 16:48:10.808019 | 2026-08-30 16:48:10.808117 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-30 16:48:10.850781 | debian-bookworm | ok 2026-08-30 16:48:10.892636 | debian-bookworm | included: /var/lib/zuul/builds/9d3dd7d895bb4108ab6190bd1dba2b4a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-30 16:48:10.909758 | 2026-08-30 16:48:10.909886 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-30 16:48:14.135414 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-30 16:48:14.135592 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9d3dd7d895bb4108ab6190bd1dba2b4a/work/9d3dd7d895bb4108ab6190bd1dba2b4a_id_rsa 2026-08-30 16:48:14.135623 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9d3dd7d895bb4108ab6190bd1dba2b4a/work/9d3dd7d895bb4108ab6190bd1dba2b4a_id_rsa.pub 2026-08-30 16:48:14.135645 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-30 16:48:14.135666 | debian-bookworm -> localhost | SHA256:kuN1jElzmPSX8bgHNaNHGUupCxR+1TVSvHFfAwqdYOM zuul-build-sshkey 2026-08-30 16:48:14.135684 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-30 16:48:14.135782 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-30 16:48:14.135802 | debian-bookworm -> localhost | | .=+.oo%Bo| 2026-08-30 16:48:14.135819 | debian-bookworm -> localhost | | .o=+o.@+B=| 2026-08-30 16:48:14.135836 | debian-bookworm -> localhost | | =E+.B.+ B| 2026-08-30 16:48:14.135853 | debian-bookworm -> localhost | | o *.o.+ ..| 2026-08-30 16:48:14.135869 | debian-bookworm -> localhost | | + S o.... | 2026-08-30 16:48:14.135916 | debian-bookworm -> localhost | | . + . .. | 2026-08-30 16:48:14.135938 | debian-bookworm -> localhost | | . | 2026-08-30 16:48:14.135955 | debian-bookworm -> localhost | | | 2026-08-30 16:48:14.135973 | debian-bookworm -> localhost | | | 2026-08-30 16:48:14.135990 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-30 16:48:14.136037 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.823771 2026-08-30 16:48:14.141827 | 2026-08-30 16:48:14.141940 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-30 16:48:14.170179 | debian-bookworm | ok 2026-08-30 16:48:14.183389 | debian-bookworm | included: /var/lib/zuul/builds/9d3dd7d895bb4108ab6190bd1dba2b4a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-30 16:48:14.193487 | 2026-08-30 16:48:14.193578 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-30 16:48:14.234591 | debian-bookworm | skipping: Conditional result was False 2026-08-30 16:48:14.240215 | 2026-08-30 16:48:14.240308 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-30 16:48:15.152313 | debian-bookworm | changed 2026-08-30 16:48:15.157220 | 2026-08-30 16:48:15.157298 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-30 16:48:15.451856 | debian-bookworm | ok 2026-08-30 16:48:15.457387 | 2026-08-30 16:48:15.457474 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-30 16:48:16.366769 | debian-bookworm | changed 2026-08-30 16:48:16.378546 | 2026-08-30 16:48:16.378654 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-30 16:48:17.252556 | debian-bookworm | changed 2026-08-30 16:48:17.257393 | 2026-08-30 16:48:17.257494 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-30 16:48:17.295551 | debian-bookworm | skipping: Conditional result was False 2026-08-30 16:48:17.300674 | 2026-08-30 16:48:17.300759 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-30 16:48:18.577540 | debian-bookworm -> localhost | changed 2026-08-30 16:48:18.586754 | 2026-08-30 16:48:18.586861 | TASK [add-build-sshkey : Add back temp key] 2026-08-30 16:48:19.935869 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9d3dd7d895bb4108ab6190bd1dba2b4a/work/9d3dd7d895bb4108ab6190bd1dba2b4a_id_rsa (zuul-build-sshkey) 2026-08-30 16:48:19.936092 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.043178 2026-08-30 16:48:19.943429 | 2026-08-30 16:48:19.943522 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-30 16:48:20.502013 | debian-bookworm | ok 2026-08-30 16:48:20.506483 | 2026-08-30 16:48:20.506566 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-30 16:48:20.552398 | debian-bookworm | skipping: Conditional result was False 2026-08-30 16:48:20.563212 | 2026-08-30 16:48:20.563327 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-30 16:48:21.353114 | debian-bookworm | ok 2026-08-30 16:48:21.366852 | 2026-08-30 16:48:21.366969 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-30 16:48:21.428607 | debian-bookworm | ok 2026-08-30 16:48:21.433039 | 2026-08-30 16:48:21.433117 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-30 16:48:22.192521 | debian-bookworm -> localhost | ok 2026-08-30 16:48:22.197855 | 2026-08-30 16:48:22.197952 | TASK [validate-host : Collect information about the host] 2026-08-30 16:48:23.595098 | debian-bookworm | ok 2026-08-30 16:48:23.627160 | 2026-08-30 16:48:23.627270 | TASK [validate-host : Sanitize hostname] 2026-08-30 16:48:23.914144 | debian-bookworm | ok 2026-08-30 16:48:23.917914 | 2026-08-30 16:48:23.917998 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-30 16:48:25.159915 | debian-bookworm -> localhost | changed 2026-08-30 16:48:25.166365 | 2026-08-30 16:48:25.166612 | TASK [validate-host : Collect information about zuul worker] 2026-08-30 16:48:25.721407 | debian-bookworm | ok 2026-08-30 16:48:25.730265 | 2026-08-30 16:48:25.730354 | TASK [validate-host : Write out all zuul information for each host] 2026-08-30 16:48:26.647696 | debian-bookworm -> localhost | changed 2026-08-30 16:48:26.659890 | 2026-08-30 16:48:26.659994 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-30 16:48:27.029178 | debian-bookworm | ok 2026-08-30 16:48:27.034463 | 2026-08-30 16:48:27.034556 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-30 16:48:28.948492 | debian-bookworm | changed: 2026-08-30 16:48:28.948708 | debian-bookworm | cd+++++++++ src/ 2026-08-30 16:48:28.948751 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-30 16:48:28.948782 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-30 16:48:28.948809 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-30 16:48:28.948834 | debian-bookworm | Containerfile 2026-08-30 16:48:28.949019 | debian-bookworm | Containerfile 2026-08-30 16:48:28.965025 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/9d3dd7d895bb4108ab6190bd1dba2b4a/work/logs" 2026-08-30 16:49:45.396113 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9d3dd7d895bb4108ab6190bd1dba2b4a/work/artifacts" 2026-08-30 16:49:45.682930 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9d3dd7d895bb4108ab6190bd1dba2b4a/work/docs" 2026-08-30 16:49:45.703896 | 2026-08-30 16:49:45.704114 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-30 16:49:46.516651 | debian-bookworm | changed: 2026-08-30 16:49:46.517001 | debian-bookworm | .d..t...... ./ 2026-08-30 16:49:46.517048 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-30 16:49:46.517074 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-30 16:49:46.517096 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-30 16:49:46.517119 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-30 16:49:46.517140 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-30 16:49:46.517188 | debian-bookworm | changed: All items complete 2026-08-30 16:49:46.517217 | 2026-08-30 16:49:47.097060 | debian-bookworm | changed: .d..t...... ./ 2026-08-30 16:49:47.722459 | debian-bookworm | changed: .d..t...... ./ 2026-08-30 16:49:47.748691 | 2026-08-30 16:49:47.748930 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-30 16:49:48.166725 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009825 2026-08-30 16:49:48.471990 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009977 2026-08-30 16:49:48.481957 | 2026-08-30 16:49:48.482094 | PLAY RECAP 2026-08-30 16:49:48.482154 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-30 16:49:48.482180 | 2026-08-30 16:49:48.630915 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-30 16:49:48.631872 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-30 16:49:49.527266 | 2026-08-30 16:49:49.527479 | PLAY [Base post] 2026-08-30 16:49:49.544518 | 2026-08-30 16:49:49.544688 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-30 16:49:50.222160 | debian-bookworm | changed 2026-08-30 16:49:50.242783 | 2026-08-30 16:49:50.243025 | PLAY RECAP 2026-08-30 16:49:50.243101 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-30 16:49:50.243190 | 2026-08-30 16:49:50.398619 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-30 16:49:50.399598 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-30 16:49:51.296479 | 2026-08-30 16:49:51.296674 | PLAY [Base post-logs] 2026-08-30 16:49:51.308090 | 2026-08-30 16:49:51.308257 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-30 16:49:51.823066 | localhost | changed 2026-08-30 16:49:51.838241 | 2026-08-30 16:49:51.838562 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-30 16:49:51.879629 | localhost | ok 2026-08-30 16:49:51.886795 | 2026-08-30 16:49:51.887038 | TASK [Set zuul-log-path fact] 2026-08-30 16:49:51.916594 | localhost | ok 2026-08-30 16:49:51.932329 | 2026-08-30 16:49:51.932492 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-30 16:49:51.971159 | localhost | ok 2026-08-30 16:49:51.977485 | 2026-08-30 16:49:51.977644 | TASK [upload-logs : Create log directories] 2026-08-30 16:49:52.536576 | localhost | changed 2026-08-30 16:49:52.540968 | 2026-08-30 16:49:52.541112 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-30 16:49:53.059736 | localhost -> localhost | ok: Runtime: 0:00:00.008166 2026-08-30 16:49:53.067973 | 2026-08-30 16:49:53.068151 | TASK [upload-logs : Upload logs to log server] 2026-08-30 16:49:53.680377 | localhost | Output suppressed because no_log was given 2026-08-30 16:49:53.684364 | 2026-08-30 16:49:53.684535 | LOOP [upload-logs : Compress console log and json output] 2026-08-30 16:49:53.748710 | localhost | skipping: Conditional result was False 2026-08-30 16:49:53.754738 | localhost | skipping: Conditional result was False 2026-08-30 16:49:53.763549 | 2026-08-30 16:49:53.763670 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-30 16:49:53.823280 | localhost | skipping: Conditional result was False 2026-08-30 16:49:53.823930 | 2026-08-30 16:49:53.827380 | localhost | skipping: Conditional result was False 2026-08-30 16:49:53.833409 | 2026-08-30 16:49:53.833593 | LOOP [upload-logs : Upload console log and json output]