2026-05-29 09:07:10.454784 | Job console starting 2026-05-29 09:07:10.485011 | Updating git repos 2026-05-29 09:07:10.595360 | Cloning repos into workspace 2026-05-29 09:07:10.696456 | Restoring repo states 2026-05-29 09:07:10.735050 | Merging changes 2026-05-29 09:07:11.487213 | Checking out repos 2026-05-29 09:07:11.560819 | Preparing playbooks 2026-05-29 09:07:13.059191 | Running Ansible setup 2026-05-29 09:07:20.283088 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-29 09:07:21.701146 | 2026-05-29 09:07:21.701263 | PLAY [Base pre] 2026-05-29 09:07:21.738895 | 2026-05-29 09:07:21.739016 | TASK [Setup log path fact] 2026-05-29 09:07:21.776661 | debian-bookworm | ok 2026-05-29 09:07:21.805354 | 2026-05-29 09:07:21.805479 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-29 09:07:21.842877 | debian-bookworm | ok 2026-05-29 09:07:21.851494 | 2026-05-29 09:07:21.851605 | TASK [emit-job-header : Print job information] 2026-05-29 09:07:21.903090 | # Job Information 2026-05-29 09:07:21.903275 | Ansible Version: 2.16.14 2026-05-29 09:07:21.903304 | Job: mypy 2026-05-29 09:07:21.903332 | Pipeline: check 2026-05-29 09:07:21.903350 | Executor: 521e9411259a 2026-05-29 09:07:21.903367 | Triggered by: https://github.com/osism/python-osism/pull/2297 2026-05-29 09:07:21.903386 | Event ID: bf647300-5b3d-11f1-9ce4-fc94fecdf03b 2026-05-29 09:07:21.907717 | 2026-05-29 09:07:21.907827 | LOOP [emit-job-header : Print node information] 2026-05-29 09:07:22.096340 | debian-bookworm | ok: 2026-05-29 09:07:22.096485 | debian-bookworm | # Node Information 2026-05-29 09:07:22.096533 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-29 09:07:22.096557 | debian-bookworm | Hostname: debian 2026-05-29 09:07:22.096575 | debian-bookworm | Username: zuul 2026-05-29 09:07:22.096592 | debian-bookworm | Distro: Debian 12.14 2026-05-29 09:07:22.096612 | debian-bookworm | Provider: regiocloud-a 2026-05-29 09:07:22.096629 | debian-bookworm | Region: 2026-05-29 09:07:22.096647 | debian-bookworm | Label: debian-bookworm 2026-05-29 09:07:22.096663 | debian-bookworm | Product Name: OpenStack Nova 2026-05-29 09:07:22.096680 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb3:bf20 2026-05-29 09:07:22.108168 | 2026-05-29 09:07:22.108312 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-29 09:07:23.108416 | debian-bookworm -> localhost | changed 2026-05-29 09:07:23.115305 | 2026-05-29 09:07:23.115419 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-29 09:07:25.111720 | debian-bookworm -> localhost | changed 2026-05-29 09:07:25.132370 | 2026-05-29 09:07:25.133091 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-29 09:07:25.726815 | debian-bookworm -> localhost | ok 2026-05-29 09:07:25.732820 | 2026-05-29 09:07:25.732923 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-29 09:07:25.762505 | debian-bookworm | ok 2026-05-29 09:07:25.785839 | debian-bookworm | included: /var/lib/zuul/builds/2c8432a9be5843cd985da1292c0e2784/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-29 09:07:25.800039 | 2026-05-29 09:07:25.800148 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-29 09:07:27.878412 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-29 09:07:27.878610 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2c8432a9be5843cd985da1292c0e2784/work/2c8432a9be5843cd985da1292c0e2784_id_rsa 2026-05-29 09:07:27.878644 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2c8432a9be5843cd985da1292c0e2784/work/2c8432a9be5843cd985da1292c0e2784_id_rsa.pub 2026-05-29 09:07:27.878666 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-29 09:07:27.878686 | debian-bookworm -> localhost | SHA256:Rm/zKN5n9gdyEDxtjVpuEX9rRnRKKodRVlg/gZ5MsuQ zuul-build-sshkey 2026-05-29 09:07:27.878704 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-29 09:07:27.878730 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-29 09:07:27.878748 | debian-bookworm -> localhost | | .oo=**.| 2026-05-29 09:07:27.878765 | debian-bookworm -> localhost | | *==B++| 2026-05-29 09:07:27.878782 | debian-bookworm -> localhost | | . = OBo++| 2026-05-29 09:07:27.878798 | debian-bookworm -> localhost | | . . Eo++ +| 2026-05-29 09:07:27.878814 | debian-bookworm -> localhost | | S + o + | 2026-05-29 09:07:27.878879 | debian-bookworm -> localhost | | . . +. = | 2026-05-29 09:07:27.878901 | debian-bookworm -> localhost | | . . .o . | 2026-05-29 09:07:27.878919 | debian-bookworm -> localhost | | . o + .| 2026-05-29 09:07:27.878936 | debian-bookworm -> localhost | | . .+ ... | 2026-05-29 09:07:27.878969 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-29 09:07:27.879014 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.214813 2026-05-29 09:07:27.884142 | 2026-05-29 09:07:27.884231 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-29 09:07:27.900879 | debian-bookworm | ok 2026-05-29 09:07:27.908061 | debian-bookworm | included: /var/lib/zuul/builds/2c8432a9be5843cd985da1292c0e2784/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-29 09:07:27.915434 | 2026-05-29 09:07:27.915515 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-29 09:07:27.928228 | debian-bookworm | skipping: Conditional result was False 2026-05-29 09:07:27.932883 | 2026-05-29 09:07:27.932961 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-29 09:07:28.663658 | debian-bookworm | changed 2026-05-29 09:07:28.684778 | 2026-05-29 09:07:28.684882 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-29 09:07:28.963556 | debian-bookworm | ok 2026-05-29 09:07:28.971468 | 2026-05-29 09:07:28.971604 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-29 09:07:29.678805 | debian-bookworm | changed 2026-05-29 09:07:29.686270 | 2026-05-29 09:07:29.686373 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-29 09:07:30.437588 | debian-bookworm | changed 2026-05-29 09:07:30.445480 | 2026-05-29 09:07:30.445579 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-29 09:07:30.472201 | debian-bookworm | skipping: Conditional result was False 2026-05-29 09:07:30.478023 | 2026-05-29 09:07:30.478119 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-29 09:07:31.171987 | debian-bookworm -> localhost | changed 2026-05-29 09:07:31.182287 | 2026-05-29 09:07:31.182396 | TASK [add-build-sshkey : Add back temp key] 2026-05-29 09:07:31.947825 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2c8432a9be5843cd985da1292c0e2784/work/2c8432a9be5843cd985da1292c0e2784_id_rsa (zuul-build-sshkey) 2026-05-29 09:07:31.948053 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025117 2026-05-29 09:07:31.955673 | 2026-05-29 09:07:31.955775 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-29 09:07:32.393782 | debian-bookworm | ok 2026-05-29 09:07:32.398610 | 2026-05-29 09:07:32.398719 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-29 09:07:32.414577 | debian-bookworm | skipping: Conditional result was False 2026-05-29 09:07:32.424567 | 2026-05-29 09:07:32.424677 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-29 09:07:32.936510 | debian-bookworm | ok 2026-05-29 09:07:32.948805 | 2026-05-29 09:07:32.948916 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-29 09:07:32.976408 | debian-bookworm | ok 2026-05-29 09:07:32.993186 | 2026-05-29 09:07:32.993292 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-29 09:07:33.303087 | debian-bookworm -> localhost | ok 2026-05-29 09:07:33.309249 | 2026-05-29 09:07:33.309339 | TASK [validate-host : Collect information about the host] 2026-05-29 09:07:35.650057 | debian-bookworm | ok 2026-05-29 09:07:35.662371 | 2026-05-29 09:07:35.662467 | TASK [validate-host : Sanitize hostname] 2026-05-29 09:07:35.843542 | debian-bookworm | ok 2026-05-29 09:07:35.885617 | 2026-05-29 09:07:35.885745 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-29 09:07:36.480604 | debian-bookworm -> localhost | changed 2026-05-29 09:07:36.486004 | 2026-05-29 09:07:36.486097 | TASK [validate-host : Collect information about zuul worker] 2026-05-29 09:07:36.942686 | debian-bookworm | ok 2026-05-29 09:07:36.956352 | 2026-05-29 09:07:36.956461 | TASK [validate-host : Write out all zuul information for each host] 2026-05-29 09:07:37.679836 | debian-bookworm -> localhost | changed 2026-05-29 09:07:37.692746 | 2026-05-29 09:07:37.692858 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-29 09:07:37.975804 | debian-bookworm | ok 2026-05-29 09:07:37.980942 | 2026-05-29 09:07:37.981033 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-29 09:07:38.976183 | debian-bookworm | changed: 2026-05-29 09:07:38.976362 | debian-bookworm | cd+++++++++ src/ 2026-05-29 09:07:38.976396 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-29 09:07:38.976420 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-29 09:07:38.976442 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-05-29 09:07:38.976462 | debian-bookworm | Containerfile 2026-05-29 09:07:38.976591 | debian-bookworm | Containerfile 2026-05-29 09:07:38.995204 | debian-bookworm | =37.0.0 in /tmp/venv/lib/python3.11/site-packages (from types-paramiko) (48.0.0) 2026-05-29 09:09:14.362802 | 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-29 09:09:14.367785 | 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-29 09:09:15.198841 | debian-bookworm | Installing collected packages: types-tabulate, types-simplejson, types-PyYAML, types-pytz, types-python-dateutil, types-PyMySQL, types-paramiko 2026-05-29 09:09:15.533626 | 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-29 09:09:21.215291 | 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-29 09:09:21.215381 | 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-29 09:09:21.215394 | 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-29 09:09:21.215415 | 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-29 09:09:21.215423 | 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-29 09:09:21.215431 | 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-29 09:09:21.215439 | 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-29 09:09:21.215458 | 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-29 09:09:21.215467 | 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-29 09:09:21.215475 | 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-29 09:09:21.215483 | 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-29 09:09:21.215510 | 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-29 09:09:21.215519 | 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-29 09:09:21.215527 | 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-29 09:09:21.215550 | debian-bookworm | Installing missing stub packages: 2026-05-29 09:09:21.215560 | 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-29 09:09:21.215568 | debian-bookworm | 2026-05-29 09:09:21.215577 | debian-bookworm | 2026-05-29 09:09:21.215585 | debian-bookworm | Success: no issues found in 126 source files 2026-05-29 09:09:21.706106 | debian-bookworm | ok: Runtime: 0:00:23.801325 2026-05-29 09:09:21.721686 | 2026-05-29 09:09:21.721815 | PLAY RECAP 2026-05-29 09:09:21.721888 | debian-bookworm | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2026-05-29 09:09:21.721923 | 2026-05-29 09:09:21.878948 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2026-05-29 09:09:21.880110 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-29 09:09:22.670118 | 2026-05-29 09:09:22.670293 | PLAY [Base post-fetch] 2026-05-29 09:09:22.685402 | 2026-05-29 09:09:22.685549 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-29 09:09:22.741165 | debian-bookworm | skipping: Conditional result was False 2026-05-29 09:09:22.753966 | 2026-05-29 09:09:22.754189 | TASK [fetch-output : Set log path for single node] 2026-05-29 09:09:22.821839 | debian-bookworm | ok 2026-05-29 09:09:22.829742 | 2026-05-29 09:09:22.829895 | LOOP [fetch-output : Ensure local output dirs] 2026-05-29 09:09:23.313236 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/2c8432a9be5843cd985da1292c0e2784/work/logs" 2026-05-29 09:09:23.597279 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2c8432a9be5843cd985da1292c0e2784/work/artifacts" 2026-05-29 09:09:23.880526 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2c8432a9be5843cd985da1292c0e2784/work/docs" 2026-05-29 09:09:23.893147 | 2026-05-29 09:09:23.893339 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-29 09:09:24.718647 | debian-bookworm | changed: 2026-05-29 09:09:24.719079 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-29 09:09:24.719155 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-29 09:09:24.719226 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-29 09:09:24.719321 | debian-bookworm | changed: All items complete 2026-05-29 09:09:24.719369 | 2026-05-29 09:09:25.315274 | debian-bookworm | changed: .d..t...... ./ 2026-05-29 09:09:25.905070 | debian-bookworm | changed: .d..t...... ./ 2026-05-29 09:09:25.931360 | 2026-05-29 09:09:25.931520 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-29 09:09:26.497842 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.010885 2026-05-29 09:09:26.803418 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010795 2026-05-29 09:09:26.822603 | 2026-05-29 09:09:26.822779 | PLAY RECAP 2026-05-29 09:09:26.822910 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-29 09:09:26.822965 | 2026-05-29 09:09:26.951986 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-29 09:09:26.953944 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-29 09:09:27.693072 | 2026-05-29 09:09:27.693250 | PLAY [Base post] 2026-05-29 09:09:27.707339 | 2026-05-29 09:09:27.707485 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-29 09:09:28.295956 | debian-bookworm | changed 2026-05-29 09:09:28.303526 | 2026-05-29 09:09:28.303690 | PLAY RECAP 2026-05-29 09:09:28.303769 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-29 09:09:28.303845 | 2026-05-29 09:09:28.431989 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-29 09:09:28.434092 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-29 09:09:29.225799 | 2026-05-29 09:09:29.225976 | PLAY [Base post-logs] 2026-05-29 09:09:29.236798 | 2026-05-29 09:09:29.236937 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-29 09:09:29.735917 | localhost | changed 2026-05-29 09:09:29.751918 | 2026-05-29 09:09:29.752147 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-29 09:09:29.780240 | localhost | ok 2026-05-29 09:09:29.786336 | 2026-05-29 09:09:29.786507 | TASK [Set zuul-log-path fact] 2026-05-29 09:09:29.815827 | localhost | ok 2026-05-29 09:09:29.831271 | 2026-05-29 09:09:29.831471 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-29 09:09:29.871477 | localhost | ok 2026-05-29 09:09:29.880961 | 2026-05-29 09:09:29.881196 | TASK [upload-logs : Create log directories] 2026-05-29 09:09:30.427051 | localhost | changed 2026-05-29 09:09:30.434047 | 2026-05-29 09:09:30.434267 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-29 09:09:30.938521 | localhost -> localhost | ok: Runtime: 0:00:00.005667 2026-05-29 09:09:30.944552 | 2026-05-29 09:09:30.944709 | TASK [upload-logs : Upload logs to log server] 2026-05-29 09:09:31.568985 | localhost | Output suppressed because no_log was given 2026-05-29 09:09:31.572531 | 2026-05-29 09:09:31.572720 | LOOP [upload-logs : Compress console log and json output] 2026-05-29 09:09:31.634132 | localhost | skipping: Conditional result was False 2026-05-29 09:09:31.652635 | localhost | skipping: Conditional result was False 2026-05-29 09:09:31.662566 | 2026-05-29 09:09:31.662745 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-29 09:09:31.715878 | localhost | skipping: Conditional result was False 2026-05-29 09:09:31.716199 | 2026-05-29 09:09:31.722967 | localhost | skipping: Conditional result was False 2026-05-29 09:09:31.733414 | 2026-05-29 09:09:31.733608 | LOOP [upload-logs : Upload console log and json output]