2026-09-07 21:06:54.755074 | Job console starting 2026-09-07 21:06:54.763472 | Updating git repos 2026-09-07 21:06:54.828528 | Cloning repos into workspace 2026-09-07 21:06:54.948633 | Restoring repo states 2026-09-07 21:06:54.957499 | Merging changes 2026-09-07 21:06:55.798040 | Checking out repos 2026-09-07 21:06:55.856218 | Preparing playbooks 2026-09-07 21:06:57.302449 | Running Ansible setup 2026-09-07 21:07:02.768319 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-07 21:07:03.786534 | 2026-09-07 21:07:03.786667 | PLAY [Base pre] 2026-09-07 21:07:03.843643 | 2026-09-07 21:07:03.843776 | TASK [Setup log path fact] 2026-09-07 21:07:03.876582 | debian-bookworm | ok 2026-09-07 21:07:03.900536 | 2026-09-07 21:07:03.900667 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-07 21:07:03.939393 | debian-bookworm | ok 2026-09-07 21:07:03.954932 | 2026-09-07 21:07:03.955036 | TASK [emit-job-header : Print job information] 2026-09-07 21:07:04.018642 | # Job Information 2026-09-07 21:07:04.018812 | Ansible Version: 2.16.14 2026-09-07 21:07:04.018847 | Job: mypy 2026-09-07 21:07:04.018880 | Pipeline: check 2026-09-07 21:07:04.018903 | Executor: 521e9411259a 2026-09-07 21:07:04.018923 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1274 2026-09-07 21:07:04.018944 | Event ID: 08d9b0b0-ab00-11f1-8e7e-4fd72ea4e30f 2026-09-07 21:07:04.023593 | 2026-09-07 21:07:04.023683 | LOOP [emit-job-header : Print node information] 2026-09-07 21:07:04.247586 | debian-bookworm | ok: 2026-09-07 21:07:04.247759 | debian-bookworm | # Node Information 2026-09-07 21:07:04.247794 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-07 21:07:04.247819 | debian-bookworm | Hostname: debian 2026-09-07 21:07:04.247841 | debian-bookworm | Username: zuul 2026-09-07 21:07:04.247862 | debian-bookworm | Distro: Debian 12.15 2026-09-07 21:07:04.247886 | debian-bookworm | Provider: regiocloud-a 2026-09-07 21:07:04.247907 | debian-bookworm | Region: 2026-09-07 21:07:04.247928 | debian-bookworm | Label: debian-bookworm 2026-09-07 21:07:04.247946 | debian-bookworm | Product Name: OpenStack Nova 2026-09-07 21:07:04.247965 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe23:7db6 2026-09-07 21:07:04.263656 | 2026-09-07 21:07:04.263772 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-07 21:07:05.466084 | debian-bookworm -> localhost | changed 2026-09-07 21:07:05.472556 | 2026-09-07 21:07:05.472647 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-07 21:07:07.105326 | debian-bookworm -> localhost | changed 2026-09-07 21:07:07.113944 | 2026-09-07 21:07:07.114035 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-07 21:07:07.752982 | debian-bookworm -> localhost | ok 2026-09-07 21:07:07.758066 | 2026-09-07 21:07:07.758162 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-07 21:07:07.787095 | debian-bookworm | ok 2026-09-07 21:07:07.803403 | debian-bookworm | included: /var/lib/zuul/builds/7c4bc2be390d40829c5bd05b9747e258/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-07 21:07:07.816807 | 2026-09-07 21:07:07.816893 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-07 21:07:10.275987 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-07 21:07:10.276142 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7c4bc2be390d40829c5bd05b9747e258/work/7c4bc2be390d40829c5bd05b9747e258_id_rsa 2026-09-07 21:07:10.276174 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7c4bc2be390d40829c5bd05b9747e258/work/7c4bc2be390d40829c5bd05b9747e258_id_rsa.pub 2026-09-07 21:07:10.276195 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-07 21:07:10.276215 | debian-bookworm -> localhost | SHA256:g7HbsnceEhW/0YYXLUNDJ0CnMiq/t+0ZvsY7gnvtxXc zuul-build-sshkey 2026-09-07 21:07:10.276232 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-07 21:07:10.276256 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-07 21:07:10.276274 | debian-bookworm -> localhost | | ..o+B..| 2026-09-07 21:07:10.276290 | debian-bookworm -> localhost | | o =o=.| 2026-09-07 21:07:10.276306 | debian-bookworm -> localhost | | . + = +o | 2026-09-07 21:07:10.276322 | debian-bookworm -> localhost | | + o o = | 2026-09-07 21:07:10.276338 | debian-bookworm -> localhost | | + S . | 2026-09-07 21:07:10.276357 | debian-bookworm -> localhost | | = o . | 2026-09-07 21:07:10.276373 | debian-bookworm -> localhost | | o +..o. o E| 2026-09-07 21:07:10.276389 | debian-bookworm -> localhost | | ooo=+=+ ..| 2026-09-07 21:07:10.276406 | debian-bookworm -> localhost | | ..o*o*O+ | 2026-09-07 21:07:10.276422 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-07 21:07:10.276468 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.815945 2026-09-07 21:07:10.281444 | 2026-09-07 21:07:10.281523 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-07 21:07:10.308700 | debian-bookworm | ok 2026-09-07 21:07:10.327808 | debian-bookworm | included: /var/lib/zuul/builds/7c4bc2be390d40829c5bd05b9747e258/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-07 21:07:10.350460 | 2026-09-07 21:07:10.350549 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-07 21:07:10.385866 | debian-bookworm | skipping: Conditional result was False 2026-09-07 21:07:10.390634 | 2026-09-07 21:07:10.390738 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-07 21:07:11.174430 | debian-bookworm | changed 2026-09-07 21:07:11.184413 | 2026-09-07 21:07:11.184496 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-07 21:07:11.447186 | debian-bookworm | ok 2026-09-07 21:07:11.453156 | 2026-09-07 21:07:11.453372 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-07 21:07:12.180164 | debian-bookworm | changed 2026-09-07 21:07:12.184545 | 2026-09-07 21:07:12.184622 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-07 21:07:12.878982 | debian-bookworm | changed 2026-09-07 21:07:12.894577 | 2026-09-07 21:07:12.894673 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-07 21:07:12.929438 | debian-bookworm | skipping: Conditional result was False 2026-09-07 21:07:12.935262 | 2026-09-07 21:07:12.935346 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-07 21:07:13.301717 | debian-bookworm -> localhost | changed 2026-09-07 21:07:13.321214 | 2026-09-07 21:07:13.321313 | TASK [add-build-sshkey : Add back temp key] 2026-09-07 21:07:13.629059 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7c4bc2be390d40829c5bd05b9747e258/work/7c4bc2be390d40829c5bd05b9747e258_id_rsa (zuul-build-sshkey) 2026-09-07 21:07:13.629293 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017747 2026-09-07 21:07:13.637329 | 2026-09-07 21:07:13.637424 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-07 21:07:14.025164 | debian-bookworm | ok 2026-09-07 21:07:14.030800 | 2026-09-07 21:07:14.030898 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-07 21:07:14.055746 | debian-bookworm | skipping: Conditional result was False 2026-09-07 21:07:14.065439 | 2026-09-07 21:07:14.065527 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-07 21:07:14.564218 | debian-bookworm | ok 2026-09-07 21:07:14.576940 | 2026-09-07 21:07:14.577033 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-07 21:07:14.598372 | debian-bookworm | ok 2026-09-07 21:07:14.605758 | 2026-09-07 21:07:14.605838 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-07 21:07:14.897533 | debian-bookworm -> localhost | ok 2026-09-07 21:07:14.903896 | 2026-09-07 21:07:14.904046 | TASK [validate-host : Collect information about the host] 2026-09-07 21:07:16.002523 | debian-bookworm | ok 2026-09-07 21:07:16.013716 | 2026-09-07 21:07:16.013808 | TASK [validate-host : Sanitize hostname] 2026-09-07 21:07:16.142657 | debian-bookworm | ok 2026-09-07 21:07:16.146926 | 2026-09-07 21:07:16.147007 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-07 21:07:16.633900 | debian-bookworm -> localhost | changed 2026-09-07 21:07:16.643396 | 2026-09-07 21:07:16.643496 | TASK [validate-host : Collect information about zuul worker] 2026-09-07 21:07:17.051765 | debian-bookworm | ok 2026-09-07 21:07:17.056374 | 2026-09-07 21:07:17.056465 | TASK [validate-host : Write out all zuul information for each host] 2026-09-07 21:07:17.515550 | debian-bookworm -> localhost | changed 2026-09-07 21:07:17.522922 | 2026-09-07 21:07:17.523000 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-07 21:07:17.800513 | debian-bookworm | ok 2026-09-07 21:07:17.805495 | 2026-09-07 21:07:17.805610 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-07 21:07:18.643434 | debian-bookworm | changed: 2026-09-07 21:07:18.643598 | debian-bookworm | cd+++++++++ src/ 2026-09-07 21:07:18.643634 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-07 21:07:18.643660 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-07 21:07:18.643693 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-09-07 21:07:18.643760 | debian-bookworm | =3.12\nERROR: Could not find a version that satisfies the requirement patool==4.1.0 (from versions: 1.7, 1.8, 1.9, 1.10, 1.11, 1.12, 1.13, 1.14.0, 1.14.1, 1.15.0, 2.0.0, 2.1.0, 2.1.1, 2.2.0, 2.3.0, 2.4.0, 3.0.0, 3.0.1, 3.0.2, 3.0.3, 3.1.0, 3.1.2, 3.1.3, 4.0.0, 4.0.1, 4.0.2, 4.0.3, 4.0.4, 4.0.5, 4.0.6, 4.0.7)\nERROR: No matching distribution found for patool==4.1.0\n" 2026-09-07 21:07:58.552845 | debian-bookworm | } failure 2026-09-07 21:07:58.555204 | 2026-09-07 21:07:58.555593 | PLAY RECAP 2026-09-07 21:07:58.555726 | debian-bookworm | ok: 9 changed: 6 unreachable: 0 failed: 1 skipped: 12 rescued: 0 ignored: 0 2026-09-07 21:07:58.555756 | 2026-09-07 21:07:58.948610 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2026-09-07 21:07:58.949287 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-07 21:07:59.987509 | 2026-09-07 21:07:59.987672 | PLAY [Base post-fetch] 2026-09-07 21:08:00.000372 | 2026-09-07 21:08:00.000469 | TASK [diagnose-network : Ensure log directory exists] 2026-09-07 21:08:00.427469 | debian-bookworm | ok 2026-09-07 21:08:00.436891 | 2026-09-07 21:08:00.437045 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-09-07 21:08:12.222589 | debian-bookworm | ok: Runtime: 0:00:06.036012 2026-09-07 21:08:12.228673 | 2026-09-07 21:08:12.228769 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-09-07 21:08:18.313923 | debian-bookworm | ok: Runtime: 0:00:00.009127 2026-09-07 21:08:18.329253 | 2026-09-07 21:08:18.329403 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-09-07 21:08:24.515885 | debian-bookworm | ok: Runtime: 0:00:00.008162 2026-09-07 21:08:24.530718 | 2026-09-07 21:08:24.530827 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-07 21:08:24.612688 | debian-bookworm | skipping: Conditional result was False 2026-09-07 21:08:24.619148 | 2026-09-07 21:08:24.619264 | TASK [fetch-output : Set log path for single node] 2026-09-07 21:08:24.660166 | debian-bookworm | ok 2026-09-07 21:08:24.667586 | 2026-09-07 21:08:24.667701 | LOOP [fetch-output : Ensure local output dirs] 2026-09-07 21:08:25.163454 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/7c4bc2be390d40829c5bd05b9747e258/work/logs" 2026-09-07 21:08:25.421744 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/7c4bc2be390d40829c5bd05b9747e258/work/artifacts" 2026-09-07 21:08:25.629470 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/7c4bc2be390d40829c5bd05b9747e258/work/docs" 2026-09-07 21:08:25.644749 | 2026-09-07 21:08:25.644840 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-07 21:08:26.572444 | debian-bookworm | changed: 2026-09-07 21:08:26.572669 | debian-bookworm | .d..t...... ./ 2026-09-07 21:08:26.572707 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-07 21:08:26.572732 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-07 21:08:26.572753 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-07 21:08:26.572776 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-07 21:08:26.572797 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-07 21:08:26.572840 | debian-bookworm | changed: All items complete 2026-09-07 21:08:26.572867 | 2026-09-07 21:08:27.034997 | debian-bookworm | changed: .d..t...... ./ 2026-09-07 21:08:27.560552 | debian-bookworm | changed: .d..t...... ./ 2026-09-07 21:08:27.572940 | 2026-09-07 21:08:27.573027 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-07 21:08:28.047742 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.003775 2026-09-07 21:08:28.560322 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.030484 2026-09-07 21:08:28.572519 | 2026-09-07 21:08:28.572592 | PLAY RECAP 2026-09-07 21:08:28.572635 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-07 21:08:28.572682 | 2026-09-07 21:08:28.764994 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-07 21:08:28.765633 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-07 21:08:29.912815 | 2026-09-07 21:08:29.912951 | PLAY [Base post] 2026-09-07 21:08:29.936964 | 2026-09-07 21:08:29.937088 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-07 21:08:30.530763 | debian-bookworm | changed 2026-09-07 21:08:30.537809 | 2026-09-07 21:08:30.537894 | PLAY RECAP 2026-09-07 21:08:30.537942 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-07 21:08:30.537992 | 2026-09-07 21:08:30.729251 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-07 21:08:30.729931 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-07 21:08:31.694173 | 2026-09-07 21:08:31.694292 | PLAY [Base post-logs] 2026-09-07 21:08:31.701965 | 2026-09-07 21:08:31.702061 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-07 21:08:32.099534 | localhost | changed 2026-09-07 21:08:32.106996 | 2026-09-07 21:08:32.107101 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-07 21:08:32.130921 | localhost | ok 2026-09-07 21:08:32.133176 | 2026-09-07 21:08:32.133242 | TASK [Set zuul-log-path fact] 2026-09-07 21:08:32.146695 | localhost | ok 2026-09-07 21:08:32.152531 | 2026-09-07 21:08:32.152605 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-07 21:08:32.175941 | localhost | ok 2026-09-07 21:08:32.178255 | 2026-09-07 21:08:32.178330 | TASK [upload-logs : Create log directories] 2026-09-07 21:08:32.895153 | localhost | changed 2026-09-07 21:08:32.897527 | 2026-09-07 21:08:32.897630 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-07 21:08:33.296769 | localhost -> localhost | ok: Runtime: 0:00:00.012237 2026-09-07 21:08:33.306840 | 2026-09-07 21:08:33.307012 | TASK [upload-logs : Upload logs to log server] 2026-09-07 21:08:34.055096 | localhost | Output suppressed because no_log was given 2026-09-07 21:08:34.056697 | 2026-09-07 21:08:34.056786 | LOOP [upload-logs : Compress console log and json output] 2026-09-07 21:08:34.111972 | localhost | skipping: Conditional result was False 2026-09-07 21:08:34.119904 | localhost | skipping: Conditional result was False 2026-09-07 21:08:34.122696 | 2026-09-07 21:08:34.122779 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-07 21:08:34.174928 | localhost | skipping: Conditional result was False 2026-09-07 21:08:34.175155 | 2026-09-07 21:08:34.182477 | localhost | skipping: Conditional result was False 2026-09-07 21:08:34.190496 | 2026-09-07 21:08:34.190590 | LOOP [upload-logs : Upload console log and json output]