2026-09-24 23:54:27.165483 | Job console starting 2026-09-24 23:54:27.360696 | Updating git repos 2026-09-24 23:54:27.388306 | Cloning repos into workspace 2026-09-24 23:54:27.497888 | Restoring repo states 2026-09-24 23:54:27.518618 | Merging changes 2026-09-24 23:54:28.280046 | Checking out repos 2026-09-24 23:54:28.358479 | Preparing playbooks 2026-09-24 23:54:29.570035 | Running Ansible setup 2026-09-24 23:54:34.973642 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-24 23:54:35.986040 | 2026-09-24 23:54:35.986164 | PLAY [Base pre] 2026-09-24 23:54:36.001089 | 2026-09-24 23:54:36.001179 | TASK [Setup log path fact] 2026-09-24 23:54:36.027894 | debian-bookworm | ok 2026-09-24 23:54:36.073683 | 2026-09-24 23:54:36.073804 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-24 23:54:36.120640 | debian-bookworm | ok 2026-09-24 23:54:36.151808 | 2026-09-24 23:54:36.151905 | TASK [emit-job-header : Print job information] 2026-09-24 23:54:36.234708 | # Job Information 2026-09-24 23:54:36.234839 | Ansible Version: 2.16.14 2026-09-24 23:54:36.234868 | Job: mypy 2026-09-24 23:54:36.234895 | Pipeline: check 2026-09-24 23:54:36.234914 | Executor: 521e9411259a 2026-09-24 23:54:36.234931 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1274 2026-09-24 23:54:36.234949 | Event ID: 40e7d100-b873-11f1-9a21-491c1fca1764 2026-09-24 23:54:36.238954 | 2026-09-24 23:54:36.239027 | LOOP [emit-job-header : Print node information] 2026-09-24 23:54:36.435192 | debian-bookworm | ok: 2026-09-24 23:54:36.435410 | debian-bookworm | # Node Information 2026-09-24 23:54:36.435442 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-24 23:54:36.435463 | debian-bookworm | Hostname: debian 2026-09-24 23:54:36.435481 | debian-bookworm | Username: zuul 2026-09-24 23:54:36.435497 | debian-bookworm | Distro: Debian 12.15 2026-09-24 23:54:36.435517 | debian-bookworm | Provider: regiocloud-a 2026-09-24 23:54:36.435534 | debian-bookworm | Region: 2026-09-24 23:54:36.435552 | debian-bookworm | Label: debian-bookworm 2026-09-24 23:54:36.435568 | debian-bookworm | Product Name: OpenStack Nova 2026-09-24 23:54:36.435583 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef1:8c4d 2026-09-24 23:54:36.453009 | 2026-09-24 23:54:36.453101 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-24 23:54:37.426760 | debian-bookworm -> localhost | changed 2026-09-24 23:54:37.433648 | 2026-09-24 23:54:37.433747 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-24 23:54:39.252105 | debian-bookworm -> localhost | changed 2026-09-24 23:54:39.285953 | 2026-09-24 23:54:39.286058 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-24 23:54:39.870280 | debian-bookworm -> localhost | ok 2026-09-24 23:54:39.875486 | 2026-09-24 23:54:39.875579 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-24 23:54:39.893881 | debian-bookworm | ok 2026-09-24 23:54:39.907543 | debian-bookworm | included: /var/lib/zuul/builds/429deae166b847e6aef5adf6ed177919/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-24 23:54:39.913251 | 2026-09-24 23:54:39.913328 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-24 23:54:41.717173 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-24 23:54:41.717334 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/429deae166b847e6aef5adf6ed177919/work/429deae166b847e6aef5adf6ed177919_id_rsa 2026-09-24 23:54:41.717364 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/429deae166b847e6aef5adf6ed177919/work/429deae166b847e6aef5adf6ed177919_id_rsa.pub 2026-09-24 23:54:41.717385 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-24 23:54:41.717405 | debian-bookworm -> localhost | SHA256:vBS6KDD4oHKNj6NNq7AR/CevN6Zvyxw8XQI2CbsQA1c zuul-build-sshkey 2026-09-24 23:54:41.717423 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-24 23:54:41.717448 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-24 23:54:41.717466 | debian-bookworm -> localhost | |oo.oE | 2026-09-24 23:54:41.717483 | debian-bookworm -> localhost | | .o o . | 2026-09-24 23:54:41.717500 | debian-bookworm -> localhost | | . . = . | 2026-09-24 23:54:41.717516 | debian-bookworm -> localhost | |o . o oo . | 2026-09-24 23:54:41.717532 | debian-bookworm -> localhost | |*. . ..S. | 2026-09-24 23:54:41.717566 | debian-bookworm -> localhost | |.*.o...oo. | 2026-09-24 23:54:41.717586 | debian-bookworm -> localhost | |= *oo=... | 2026-09-24 23:54:41.717615 | debian-bookworm -> localhost | |o*.=*=o | 2026-09-24 23:54:41.717633 | debian-bookworm -> localhost | |+o++O*o | 2026-09-24 23:54:41.717649 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-24 23:54:41.717703 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.223272 2026-09-24 23:54:41.722877 | 2026-09-24 23:54:41.722947 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-24 23:54:41.759206 | debian-bookworm | ok 2026-09-24 23:54:41.767290 | debian-bookworm | included: /var/lib/zuul/builds/429deae166b847e6aef5adf6ed177919/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-24 23:54:41.799000 | 2026-09-24 23:54:41.799077 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-24 23:54:41.847810 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:54:41.852414 | 2026-09-24 23:54:41.852487 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-24 23:54:42.655845 | debian-bookworm | changed 2026-09-24 23:54:42.665884 | 2026-09-24 23:54:42.665969 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-24 23:54:42.947390 | debian-bookworm | ok 2026-09-24 23:54:42.964151 | 2026-09-24 23:54:42.964312 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-24 23:54:43.855665 | debian-bookworm | changed 2026-09-24 23:54:43.863202 | 2026-09-24 23:54:43.863294 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-24 23:54:44.545485 | debian-bookworm | changed 2026-09-24 23:54:44.550942 | 2026-09-24 23:54:44.551026 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-24 23:54:44.564977 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:54:44.571413 | 2026-09-24 23:54:44.571497 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-24 23:54:45.062213 | debian-bookworm -> localhost | changed 2026-09-24 23:54:45.085036 | 2026-09-24 23:54:45.085141 | TASK [add-build-sshkey : Add back temp key] 2026-09-24 23:54:45.374452 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/429deae166b847e6aef5adf6ed177919/work/429deae166b847e6aef5adf6ed177919_id_rsa (zuul-build-sshkey) 2026-09-24 23:54:45.374692 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015644 2026-09-24 23:54:45.381371 | 2026-09-24 23:54:45.382837 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-24 23:54:45.738344 | debian-bookworm | ok 2026-09-24 23:54:45.746243 | 2026-09-24 23:54:45.746321 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-24 23:54:45.769093 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:54:45.777886 | 2026-09-24 23:54:45.777958 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-24 23:54:46.208084 | debian-bookworm | ok 2026-09-24 23:54:46.219818 | 2026-09-24 23:54:46.219902 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-24 23:54:46.263684 | debian-bookworm | ok 2026-09-24 23:54:46.281099 | 2026-09-24 23:54:46.281219 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-24 23:54:46.636426 | debian-bookworm -> localhost | ok 2026-09-24 23:54:46.641527 | 2026-09-24 23:54:46.642332 | TASK [validate-host : Collect information about the host] 2026-09-24 23:54:47.695641 | debian-bookworm | ok 2026-09-24 23:54:47.718724 | 2026-09-24 23:54:47.718811 | TASK [validate-host : Sanitize hostname] 2026-09-24 23:54:47.868034 | debian-bookworm | ok 2026-09-24 23:54:47.872330 | 2026-09-24 23:54:47.872457 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-24 23:54:48.394191 | debian-bookworm -> localhost | changed 2026-09-24 23:54:48.400452 | 2026-09-24 23:54:48.400562 | TASK [validate-host : Collect information about zuul worker] 2026-09-24 23:54:48.781364 | debian-bookworm | ok 2026-09-24 23:54:48.786003 | 2026-09-24 23:54:48.786091 | TASK [validate-host : Write out all zuul information for each host] 2026-09-24 23:54:49.270688 | debian-bookworm -> localhost | changed 2026-09-24 23:54:49.280239 | 2026-09-24 23:54:49.280329 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-24 23:54:49.533690 | debian-bookworm | ok 2026-09-24 23:54:49.539373 | 2026-09-24 23:54:49.539464 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-24 23:54:50.450697 | debian-bookworm | changed: 2026-09-24 23:54:50.450881 | debian-bookworm | cd+++++++++ src/ 2026-09-24 23:54:50.450915 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-24 23:54:50.450939 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-24 23:54:50.450961 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-09-24 23:54:50.450981 | 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-24 23:55:32.638285 | debian-bookworm | } failure 2026-09-24 23:55:32.639621 | 2026-09-24 23:55:32.639675 | PLAY RECAP 2026-09-24 23:55:32.639717 | debian-bookworm | ok: 9 changed: 6 unreachable: 0 failed: 1 skipped: 12 rescued: 0 ignored: 0 2026-09-24 23:55:32.639737 | 2026-09-24 23:55:32.752192 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2026-09-24 23:55:32.753196 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-24 23:55:33.708942 | 2026-09-24 23:55:33.709054 | PLAY [Base post-fetch] 2026-09-24 23:55:33.747227 | 2026-09-24 23:55:33.748434 | TASK [diagnose-network : Ensure log directory exists] 2026-09-24 23:55:34.283763 | debian-bookworm | ok 2026-09-24 23:55:34.290121 | 2026-09-24 23:55:34.290237 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-09-24 23:55:46.092883 | debian-bookworm | ok: Runtime: 0:00:06.019605 2026-09-24 23:55:46.103906 | 2026-09-24 23:55:46.104066 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-09-24 23:55:52.138486 | debian-bookworm | ok: Runtime: 0:00:00.006899 2026-09-24 23:55:52.147678 | 2026-09-24 23:55:52.147836 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-09-24 23:55:58.368724 | debian-bookworm | ok: Runtime: 0:00:00.009093 2026-09-24 23:55:58.376720 | 2026-09-24 23:55:58.376864 | TASK [diagnose-network : Evaluate node isolation verdict (pre-run gate)] 2026-09-24 23:55:58.915886 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:55:58.920789 | 2026-09-24 23:55:58.920874 | TASK [diagnose-network : Abort the pre-run on a fully isolated node] 2026-09-24 23:55:58.974564 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:55:58.989734 | 2026-09-24 23:55:58.989894 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-24 23:55:59.035158 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:55:59.039697 | 2026-09-24 23:55:59.039784 | TASK [fetch-output : Set log path for single node] 2026-09-24 23:55:59.066901 | debian-bookworm | ok 2026-09-24 23:55:59.070997 | 2026-09-24 23:55:59.071075 | LOOP [fetch-output : Ensure local output dirs] 2026-09-24 23:55:59.421996 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/429deae166b847e6aef5adf6ed177919/work/logs" 2026-09-24 23:55:59.722871 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/429deae166b847e6aef5adf6ed177919/work/artifacts" 2026-09-24 23:55:59.997480 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/429deae166b847e6aef5adf6ed177919/work/docs" 2026-09-24 23:56:00.007515 | 2026-09-24 23:56:00.007603 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-24 23:56:00.805080 | debian-bookworm | changed: 2026-09-24 23:56:00.805239 | debian-bookworm | .d..t...... ./ 2026-09-24 23:56:00.805270 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-24 23:56:00.805290 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-24 23:56:00.805309 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-24 23:56:00.805326 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-24 23:56:00.805343 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-24 23:56:00.805371 | debian-bookworm | changed: All items complete 2026-09-24 23:56:00.805392 | 2026-09-24 23:56:01.521078 | debian-bookworm | changed: .d..t...... ./ 2026-09-24 23:56:02.286190 | debian-bookworm | changed: .d..t...... ./ 2026-09-24 23:56:02.313840 | 2026-09-24 23:56:02.313938 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-24 23:56:02.990672 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.029106 2026-09-24 23:56:03.820560 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.038667 2026-09-24 23:56:03.831947 | 2026-09-24 23:56:03.832011 | PLAY RECAP 2026-09-24 23:56:03.832049 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-24 23:56:03.832069 | 2026-09-24 23:56:04.166118 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-24 23:56:04.166826 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-24 23:56:05.180412 | 2026-09-24 23:56:05.180531 | PLAY [Base post] 2026-09-24 23:56:05.212638 | 2026-09-24 23:56:05.212761 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-24 23:56:05.854221 | debian-bookworm | changed 2026-09-24 23:56:05.859849 | 2026-09-24 23:56:05.859925 | PLAY RECAP 2026-09-24 23:56:05.859973 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-24 23:56:05.860024 | 2026-09-24 23:56:06.068041 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-24 23:56:06.068740 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-24 23:56:07.202897 | 2026-09-24 23:56:07.203045 | PLAY [Base post-logs] 2026-09-24 23:56:07.221744 | 2026-09-24 23:56:07.221874 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-24 23:56:07.695905 | localhost | changed 2026-09-24 23:56:07.705453 | 2026-09-24 23:56:07.705703 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-24 23:56:07.730968 | localhost | ok 2026-09-24 23:56:07.734055 | 2026-09-24 23:56:07.734145 | TASK [Set zuul-log-path fact] 2026-09-24 23:56:07.749064 | localhost | ok 2026-09-24 23:56:07.756679 | 2026-09-24 23:56:07.756776 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-24 23:56:07.781720 | localhost | ok 2026-09-24 23:56:07.784518 | 2026-09-24 23:56:07.784607 | TASK [upload-logs : Create log directories] 2026-09-24 23:56:08.206962 | localhost | changed 2026-09-24 23:56:08.209655 | 2026-09-24 23:56:08.209751 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-24 23:56:08.771126 | localhost -> localhost | ok: Runtime: 0:00:00.027858 2026-09-24 23:56:08.775938 | 2026-09-24 23:56:08.776027 | TASK [upload-logs : Upload logs to log server] 2026-09-24 23:56:09.341120 | localhost | Output suppressed because no_log was given 2026-09-24 23:56:09.343135 | 2026-09-24 23:56:09.343231 | LOOP [upload-logs : Compress console log and json output] 2026-09-24 23:56:09.388903 | localhost | skipping: Conditional result was False 2026-09-24 23:56:09.395158 | localhost | skipping: Conditional result was False 2026-09-24 23:56:09.402503 | 2026-09-24 23:56:09.402730 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-24 23:56:09.461084 | localhost | skipping: Conditional result was False 2026-09-24 23:56:09.461355 | 2026-09-24 23:56:09.471153 | localhost | skipping: Conditional result was False 2026-09-24 23:56:09.485451 | 2026-09-24 23:56:09.485580 | LOOP [upload-logs : Upload console log and json output]