2026-05-19 14:16:48.779980 | Job console starting 2026-05-19 14:16:48.822639 | Updating git repos 2026-05-19 14:16:48.928444 | Cloning repos into workspace 2026-05-19 14:16:49.062417 | Restoring repo states 2026-05-19 14:16:49.103995 | Merging changes 2026-05-19 14:16:50.048860 | Checking out repos 2026-05-19 14:16:50.163487 | Preparing playbooks 2026-05-19 14:16:51.608197 | Running Ansible setup 2026-05-19 14:16:58.912169 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-19 14:17:00.444425 | 2026-05-19 14:17:00.444615 | PLAY [Base pre] 2026-05-19 14:17:00.497816 | 2026-05-19 14:17:00.497987 | TASK [Setup log path fact] 2026-05-19 14:17:00.543583 | debian-bookworm | ok 2026-05-19 14:17:00.576773 | 2026-05-19 14:17:00.576952 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-19 14:17:00.664356 | debian-bookworm | ok 2026-05-19 14:17:00.678290 | 2026-05-19 14:17:00.678428 | TASK [emit-job-header : Print job information] 2026-05-19 14:17:00.770215 | # Job Information 2026-05-19 14:17:00.770514 | Ansible Version: 2.16.14 2026-05-19 14:17:00.770551 | Job: mypy 2026-05-19 14:17:00.770589 | Pipeline: check 2026-05-19 14:17:00.770613 | Executor: 521e9411259a 2026-05-19 14:17:00.770634 | Triggered by: https://github.com/osism/python-osism/pull/2289 2026-05-19 14:17:00.770658 | Event ID: 5707d020-538d-11f1-8438-db11643e69fc 2026-05-19 14:17:00.775965 | 2026-05-19 14:17:00.776097 | LOOP [emit-job-header : Print node information] 2026-05-19 14:17:00.972027 | debian-bookworm | ok: 2026-05-19 14:17:00.972274 | debian-bookworm | # Node Information 2026-05-19 14:17:00.978919 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-19 14:17:00.979028 | debian-bookworm | Hostname: debian 2026-05-19 14:17:00.979058 | debian-bookworm | Username: zuul 2026-05-19 14:17:00.979082 | debian-bookworm | Distro: Debian 12.14 2026-05-19 14:17:00.979111 | debian-bookworm | Provider: regiocloud-a 2026-05-19 14:17:00.979133 | debian-bookworm | Region: 2026-05-19 14:17:00.979156 | debian-bookworm | Label: debian-bookworm 2026-05-19 14:17:00.979176 | debian-bookworm | Product Name: OpenStack Nova 2026-05-19 14:17:00.979195 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe27:46e4 2026-05-19 14:17:00.993583 | 2026-05-19 14:17:00.993724 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-19 14:17:01.950738 | debian-bookworm -> localhost | changed 2026-05-19 14:17:01.962925 | 2026-05-19 14:17:01.963032 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-19 14:17:03.783190 | debian-bookworm -> localhost | changed 2026-05-19 14:17:03.794092 | 2026-05-19 14:17:03.794202 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-19 14:17:04.291303 | debian-bookworm -> localhost | ok 2026-05-19 14:17:04.297291 | 2026-05-19 14:17:04.297408 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-19 14:17:04.337462 | debian-bookworm | ok 2026-05-19 14:17:04.353395 | debian-bookworm | included: /var/lib/zuul/builds/2348f4e3e8ce415c87c8375caeff37a2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-19 14:17:04.360271 | 2026-05-19 14:17:04.360375 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-19 14:17:06.589262 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-19 14:17:06.589464 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2348f4e3e8ce415c87c8375caeff37a2/work/2348f4e3e8ce415c87c8375caeff37a2_id_rsa 2026-05-19 14:17:06.589503 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2348f4e3e8ce415c87c8375caeff37a2/work/2348f4e3e8ce415c87c8375caeff37a2_id_rsa.pub 2026-05-19 14:17:06.589531 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-19 14:17:06.589556 | debian-bookworm -> localhost | SHA256:5B7AD/M24Q8W+Kn3rYynJFDVC87bDtEiezzk6PMA8zY zuul-build-sshkey 2026-05-19 14:17:06.589578 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-19 14:17:06.589610 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-19 14:17:06.589633 | debian-bookworm -> localhost | | .. | 2026-05-19 14:17:06.589655 | debian-bookworm -> localhost | | . o. . | 2026-05-19 14:17:06.589675 | debian-bookworm -> localhost | | Bo+o . | 2026-05-19 14:17:06.589695 | debian-bookworm -> localhost | | ..@*+o | 2026-05-19 14:17:06.589716 | debian-bookworm -> localhost | | + BS= | 2026-05-19 14:17:06.589744 | debian-bookworm -> localhost | | =o=B=. | 2026-05-19 14:17:06.589765 | debian-bookworm -> localhost | | .E.++. | 2026-05-19 14:17:06.589786 | debian-bookworm -> localhost | | .o* +o. | 2026-05-19 14:17:06.589807 | debian-bookworm -> localhost | | o+o+.. | 2026-05-19 14:17:06.589828 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-19 14:17:06.589877 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.234067 2026-05-19 14:17:06.606574 | 2026-05-19 14:17:06.606688 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-19 14:17:06.634678 | debian-bookworm | ok 2026-05-19 14:17:06.651675 | debian-bookworm | included: /var/lib/zuul/builds/2348f4e3e8ce415c87c8375caeff37a2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-19 14:17:06.661066 | 2026-05-19 14:17:06.661241 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-19 14:17:06.674285 | debian-bookworm | skipping: Conditional result was False 2026-05-19 14:17:06.680147 | 2026-05-19 14:17:06.680273 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-19 14:17:07.327427 | debian-bookworm | changed 2026-05-19 14:17:07.333060 | 2026-05-19 14:17:07.333149 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-19 14:17:07.601048 | debian-bookworm | ok 2026-05-19 14:17:07.613114 | 2026-05-19 14:17:07.613311 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-19 14:17:08.285754 | debian-bookworm | changed 2026-05-19 14:17:08.295792 | 2026-05-19 14:17:08.295895 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-19 14:17:09.028901 | debian-bookworm | changed 2026-05-19 14:17:09.034144 | 2026-05-19 14:17:09.034266 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-19 14:17:09.067646 | debian-bookworm | skipping: Conditional result was False 2026-05-19 14:17:09.073872 | 2026-05-19 14:17:09.073980 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-19 14:17:09.767249 | debian-bookworm -> localhost | changed 2026-05-19 14:17:09.780478 | 2026-05-19 14:17:09.780578 | TASK [add-build-sshkey : Add back temp key] 2026-05-19 14:17:10.434691 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2348f4e3e8ce415c87c8375caeff37a2/work/2348f4e3e8ce415c87c8375caeff37a2_id_rsa (zuul-build-sshkey) 2026-05-19 14:17:10.434925 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.023246 2026-05-19 14:17:10.442259 | 2026-05-19 14:17:10.442357 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-19 14:17:10.884147 | debian-bookworm | ok 2026-05-19 14:17:10.893352 | 2026-05-19 14:17:10.899154 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-19 14:17:10.932602 | debian-bookworm | skipping: Conditional result was False 2026-05-19 14:17:10.950683 | 2026-05-19 14:17:10.950802 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-19 14:17:11.454784 | debian-bookworm | ok 2026-05-19 14:17:11.490015 | 2026-05-19 14:17:11.490166 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-19 14:17:11.532489 | debian-bookworm | ok 2026-05-19 14:17:11.538152 | 2026-05-19 14:17:11.538329 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-19 14:17:12.118472 | debian-bookworm -> localhost | ok 2026-05-19 14:17:12.125416 | 2026-05-19 14:17:12.125542 | TASK [validate-host : Collect information about the host] 2026-05-19 14:17:13.362563 | debian-bookworm | ok 2026-05-19 14:17:13.387524 | 2026-05-19 14:17:13.387675 | TASK [validate-host : Sanitize hostname] 2026-05-19 14:17:13.735665 | debian-bookworm | ok 2026-05-19 14:17:13.878616 | 2026-05-19 14:17:13.878762 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-19 14:17:14.901570 | debian-bookworm -> localhost | changed 2026-05-19 14:17:14.908757 | 2026-05-19 14:17:14.908898 | TASK [validate-host : Collect information about zuul worker] 2026-05-19 14:17:15.443820 | debian-bookworm | ok 2026-05-19 14:17:15.448994 | 2026-05-19 14:17:15.449112 | TASK [validate-host : Write out all zuul information for each host] 2026-05-19 14:17:16.494967 | debian-bookworm -> localhost | changed 2026-05-19 14:17:16.505540 | 2026-05-19 14:17:16.505680 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-19 14:17:16.771150 | debian-bookworm | ok 2026-05-19 14:17:16.778502 | 2026-05-19 14:17:16.778641 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-19 14:17:18.005469 | debian-bookworm | changed: 2026-05-19 14:17:18.005689 | debian-bookworm | cd+++++++++ src/ 2026-05-19 14:17:18.005724 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-19 14:17:18.005748 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-19 14:17:18.005907 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-05-19 14:17:18.005932 | debian-bookworm | Containerfile 2026-05-19 14:17:18.006087 | debian-bookworm | Containerfile 2026-05-19 14:17:18.022628 | debian-bookworm | =37.0.0 in /tmp/venv/lib/python3.11/site-packages (from types-paramiko) (48.0.0) 2026-05-19 14:18:49.673152 | debian-bookworm | Requirement already satisfied: cffi>=2.0.0 in /tmp/venv/lib/python3.11/site-packages (from cryptography>=37.0.0->types-paramiko) (2.0.0) 2026-05-19 14:18:49.677335 | debian-bookworm | Requirement already satisfied: pycparser in /tmp/venv/lib/python3.11/site-packages (from cffi>=2.0.0->cryptography>=37.0.0->types-paramiko) (3.0) 2026-05-19 14:18:50.447756 | debian-bookworm | Installing collected packages: types-tabulate, types-simplejson, types-PyYAML, types-pytz, types-python-dateutil, types-PyMySQL, types-paramiko 2026-05-19 14:18:50.683302 | debian-bookworm | Successfully installed types-PyMySQL-1.1.0.20260518 types-PyYAML-6.0.12.20260518 types-paramiko-4.0.0.20260518 types-python-dateutil-2.9.0.20260518 types-pytz-2026.2.0.20260518 types-simplejson-3.20.0.20260518 types-tabulate-0.10.0.20260508 2026-05-19 14:18:55.607730 | debian-bookworm | tests/conftest.py:95: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-19 14:18:55.607853 | debian-bookworm | tests/unit/test_settings.py:45: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-19 14:18:55.607872 | debian-bookworm | osism/services/websocket_manager.py:87: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-19 14:18:55.607898 | debian-bookworm | osism/services/websocket_manager.py:89: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-19 14:18:55.607910 | debian-bookworm | osism/services/websocket_manager.py:91: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-19 14:18:55.607921 | debian-bookworm | osism/tasks/conductor/sonic/cache.py:16: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-19 14:18:55.607932 | debian-bookworm | osism/services/listener.py:181: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-19 14:18:55.607944 | debian-bookworm | osism/services/listener.py:182: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-19 14:18:55.607955 | debian-bookworm | osism/services/listener.py:184: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-19 14:18:55.607966 | debian-bookworm | osism/services/listener.py:185: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-19 14:18:55.607977 | debian-bookworm | osism/services/listener.py:488: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-19 14:18:55.608014 | debian-bookworm | tests/unit/tasks/conductor/sonic/test_cache.py:342: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-19 14:18:55.608026 | debian-bookworm | tests/unit/tasks/conductor/sonic/test_cache.py:397: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-19 14:18:55.608037 | debian-bookworm | tests/unit/tasks/conductor/sonic/test_cache.py:436: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2026-05-19 14:18:55.608053 | debian-bookworm | Installing missing stub packages: 2026-05-19 14:18:55.608066 | debian-bookworm | /tmp/venv/bin/python3 -m pip install types-PyMySQL types-PyYAML types-paramiko types-python-dateutil types-pytz types-simplejson types-tabulate 2026-05-19 14:18:55.608078 | debian-bookworm | 2026-05-19 14:18:55.608089 | debian-bookworm | 2026-05-19 14:18:55.608101 | debian-bookworm | Success: no issues found in 125 source files 2026-05-19 14:18:55.699414 | debian-bookworm | ok: Runtime: 0:00:21.747472 2026-05-19 14:18:55.709595 | 2026-05-19 14:18:55.709737 | PLAY RECAP 2026-05-19 14:18:55.709814 | debian-bookworm | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2026-05-19 14:18:55.709847 | 2026-05-19 14:18:55.891379 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2026-05-19 14:18:55.893303 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-19 14:18:56.660835 | 2026-05-19 14:18:56.661020 | PLAY [Base post-fetch] 2026-05-19 14:18:56.676576 | 2026-05-19 14:18:56.676745 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-19 14:18:56.742535 | debian-bookworm | skipping: Conditional result was False 2026-05-19 14:18:56.754276 | 2026-05-19 14:18:56.754505 | TASK [fetch-output : Set log path for single node] 2026-05-19 14:18:56.801214 | debian-bookworm | ok 2026-05-19 14:18:56.809872 | 2026-05-19 14:18:56.810040 | LOOP [fetch-output : Ensure local output dirs] 2026-05-19 14:18:57.318434 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/2348f4e3e8ce415c87c8375caeff37a2/work/logs" 2026-05-19 14:18:57.592483 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2348f4e3e8ce415c87c8375caeff37a2/work/artifacts" 2026-05-19 14:18:57.867480 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2348f4e3e8ce415c87c8375caeff37a2/work/docs" 2026-05-19 14:18:57.890282 | 2026-05-19 14:18:57.890466 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-19 14:18:58.709117 | debian-bookworm | changed: 2026-05-19 14:18:58.709555 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-19 14:18:58.709620 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-19 14:18:58.709671 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-19 14:18:58.709755 | debian-bookworm | changed: All items complete 2026-05-19 14:18:58.709802 | 2026-05-19 14:18:59.308610 | debian-bookworm | changed: .d..t...... ./ 2026-05-19 14:18:59.868298 | debian-bookworm | changed: .d..t...... ./ 2026-05-19 14:18:59.881670 | 2026-05-19 14:18:59.881803 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-19 14:19:00.440174 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.012078 2026-05-19 14:19:00.782265 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.011318 2026-05-19 14:19:00.809130 | 2026-05-19 14:19:00.809346 | PLAY RECAP 2026-05-19 14:19:00.809437 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-19 14:19:00.809479 | 2026-05-19 14:19:00.988508 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-19 14:19:00.990364 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-19 14:19:01.806808 | 2026-05-19 14:19:01.807018 | PLAY [Base post] 2026-05-19 14:19:01.821630 | 2026-05-19 14:19:01.821788 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-19 14:19:02.438797 | debian-bookworm | changed 2026-05-19 14:19:02.448480 | 2026-05-19 14:19:02.448647 | PLAY RECAP 2026-05-19 14:19:02.448729 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-19 14:19:02.448802 | 2026-05-19 14:19:02.592996 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-19 14:19:02.595110 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-19 14:19:03.412775 | 2026-05-19 14:19:03.412957 | PLAY [Base post-logs] 2026-05-19 14:19:03.424394 | 2026-05-19 14:19:03.424555 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-19 14:19:03.900975 | localhost | changed 2026-05-19 14:19:03.919190 | 2026-05-19 14:19:03.919483 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-19 14:19:03.957503 | localhost | ok 2026-05-19 14:19:03.962248 | 2026-05-19 14:19:03.962409 | TASK [Set zuul-log-path fact] 2026-05-19 14:19:03.979834 | localhost | ok 2026-05-19 14:19:03.989446 | 2026-05-19 14:19:03.989583 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-19 14:19:04.016817 | localhost | ok 2026-05-19 14:19:04.021571 | 2026-05-19 14:19:04.021710 | TASK [upload-logs : Create log directories] 2026-05-19 14:19:04.628602 | localhost | changed 2026-05-19 14:19:04.634824 | 2026-05-19 14:19:04.634995 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-19 14:19:05.079708 | localhost -> localhost | ok: Runtime: 0:00:00.006331 2026-05-19 14:19:05.084724 | 2026-05-19 14:19:05.085739 | TASK [upload-logs : Upload logs to log server] 2026-05-19 14:19:05.625295 | localhost | Output suppressed because no_log was given 2026-05-19 14:19:05.628422 | 2026-05-19 14:19:05.628562 | LOOP [upload-logs : Compress console log and json output] 2026-05-19 14:19:05.681243 | localhost | skipping: Conditional result was False 2026-05-19 14:19:05.686446 | localhost | skipping: Conditional result was False 2026-05-19 14:19:05.700043 | 2026-05-19 14:19:05.700322 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-19 14:19:05.745333 | localhost | skipping: Conditional result was False 2026-05-19 14:19:05.746740 | 2026-05-19 14:19:05.749806 | localhost | skipping: Conditional result was False 2026-05-19 14:19:05.763373 | 2026-05-19 14:19:05.763655 | LOOP [upload-logs : Upload console log and json output]