2025-08-24 11:06:42.774562 | Job console starting 2025-08-24 11:06:42.800449 | Updating git repos 2025-08-24 11:06:42.871660 | Cloning repos into workspace 2025-08-24 11:06:42.968430 | Restoring repo states 2025-08-24 11:06:42.994318 | Merging changes 2025-08-24 11:06:43.641686 | Checking out repos 2025-08-24 11:06:43.734826 | Preparing playbooks 2025-08-24 11:06:44.862185 | Running Ansible setup 2025-08-24 11:06:50.401231 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-24 11:06:51.494251 | 2025-08-24 11:06:51.494420 | PLAY [Base pre] 2025-08-24 11:06:51.512296 | 2025-08-24 11:06:51.512451 | TASK [Setup log path fact] 2025-08-24 11:06:51.531350 | debian-bookworm | ok 2025-08-24 11:06:51.547083 | 2025-08-24 11:06:51.547255 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-24 11:06:51.587382 | debian-bookworm | ok 2025-08-24 11:06:51.597381 | 2025-08-24 11:06:51.597519 | TASK [emit-job-header : Print job information] 2025-08-24 11:06:51.636583 | # Job Information 2025-08-24 11:06:51.636761 | Ansible Version: 2.16.14 2025-08-24 11:06:51.636796 | Job: mypy 2025-08-24 11:06:51.636829 | Pipeline: check 2025-08-24 11:06:51.636851 | Executor: 521e9411259a 2025-08-24 11:06:51.636886 | Triggered by: https://github.com/osism/python-osism/pull/1668 2025-08-24 11:06:51.636909 | Event ID: 65fa1740-80da-11f0-975b-975592a57fa5 2025-08-24 11:06:51.644015 | 2025-08-24 11:06:51.644146 | LOOP [emit-job-header : Print node information] 2025-08-24 11:06:51.769550 | debian-bookworm | ok: 2025-08-24 11:06:51.769798 | debian-bookworm | # Node Information 2025-08-24 11:06:51.769834 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-24 11:06:51.769860 | debian-bookworm | Hostname: debian 2025-08-24 11:06:51.769909 | debian-bookworm | Username: zuul 2025-08-24 11:06:51.769930 | debian-bookworm | Distro: Debian 12.11 2025-08-24 11:06:51.769954 | debian-bookworm | Provider: regiocloud-a 2025-08-24 11:06:51.769975 | debian-bookworm | Region: 2025-08-24 11:06:51.769997 | debian-bookworm | Label: debian-bookworm 2025-08-24 11:06:51.770017 | debian-bookworm | Product Name: OpenStack Nova 2025-08-24 11:06:51.770036 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef5:ab09 2025-08-24 11:06:51.796327 | 2025-08-24 11:06:51.796482 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-24 11:06:52.383739 | debian-bookworm -> localhost | changed 2025-08-24 11:06:52.391293 | 2025-08-24 11:06:52.391428 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-24 11:06:53.715170 | debian-bookworm -> localhost | changed 2025-08-24 11:06:53.725297 | 2025-08-24 11:06:53.725395 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-24 11:06:54.132939 | debian-bookworm -> localhost | ok 2025-08-24 11:06:54.139103 | 2025-08-24 11:06:54.139216 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-24 11:06:54.176668 | debian-bookworm | ok 2025-08-24 11:06:54.203304 | debian-bookworm | included: /var/lib/zuul/builds/e40075a3357d48569e0b0782ec3490f7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-24 11:06:54.221110 | 2025-08-24 11:06:54.221213 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-24 11:06:55.685964 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-24 11:06:55.686154 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e40075a3357d48569e0b0782ec3490f7/work/e40075a3357d48569e0b0782ec3490f7_id_rsa 2025-08-24 11:06:55.686191 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e40075a3357d48569e0b0782ec3490f7/work/e40075a3357d48569e0b0782ec3490f7_id_rsa.pub 2025-08-24 11:06:55.686218 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-24 11:06:55.686243 | debian-bookworm -> localhost | SHA256:BI/FzBpr0jT+tVb5/bE0sqB0q+Y9bv7sx/85xtLTJMM zuul-build-sshkey 2025-08-24 11:06:55.686265 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-24 11:06:55.686296 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-24 11:06:55.686318 | debian-bookworm -> localhost | | .+. | 2025-08-24 11:06:55.686340 | debian-bookworm -> localhost | | +=+ | 2025-08-24 11:06:55.686360 | debian-bookworm -> localhost | | +.=o . | 2025-08-24 11:06:55.686380 | debian-bookworm -> localhost | | . *. . o | 2025-08-24 11:06:55.686400 | debian-bookworm -> localhost | | o .S. o o . | 2025-08-24 11:06:55.686425 | debian-bookworm -> localhost | | ..oo .E+o| 2025-08-24 11:06:55.686446 | debian-bookworm -> localhost | | ..o o B+*| 2025-08-24 11:06:55.686467 | debian-bookworm -> localhost | | o.+.o X+| 2025-08-24 11:06:55.686487 | debian-bookworm -> localhost | | oo=++++.B| 2025-08-24 11:06:55.686508 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-24 11:06:55.686557 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.806546 2025-08-24 11:06:55.692704 | 2025-08-24 11:06:55.692800 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-24 11:06:55.726077 | debian-bookworm | ok 2025-08-24 11:06:55.739138 | debian-bookworm | included: /var/lib/zuul/builds/e40075a3357d48569e0b0782ec3490f7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-24 11:06:55.762224 | 2025-08-24 11:06:55.762324 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-24 11:06:55.785217 | debian-bookworm | skipping: Conditional result was False 2025-08-24 11:06:55.790765 | 2025-08-24 11:06:55.790942 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-24 11:06:56.448336 | debian-bookworm | changed 2025-08-24 11:06:56.457835 | 2025-08-24 11:06:56.457984 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-24 11:06:56.708977 | debian-bookworm | ok 2025-08-24 11:06:56.714198 | 2025-08-24 11:06:56.714287 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-24 11:06:57.312350 | debian-bookworm | changed 2025-08-24 11:06:57.318680 | 2025-08-24 11:06:57.318765 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-24 11:06:57.972164 | debian-bookworm | changed 2025-08-24 11:06:57.977541 | 2025-08-24 11:06:57.977627 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-24 11:06:58.000851 | debian-bookworm | skipping: Conditional result was False 2025-08-24 11:06:58.006605 | 2025-08-24 11:06:58.006697 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-24 11:06:58.413471 | debian-bookworm -> localhost | changed 2025-08-24 11:06:58.422077 | 2025-08-24 11:06:58.422164 | TASK [add-build-sshkey : Add back temp key] 2025-08-24 11:06:58.707833 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e40075a3357d48569e0b0782ec3490f7/work/e40075a3357d48569e0b0782ec3490f7_id_rsa (zuul-build-sshkey) 2025-08-24 11:06:58.708313 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.007724 2025-08-24 11:06:58.722195 | 2025-08-24 11:06:58.722674 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-24 11:06:59.119468 | debian-bookworm | ok 2025-08-24 11:06:59.124322 | 2025-08-24 11:06:59.124410 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-24 11:06:59.147063 | debian-bookworm | skipping: Conditional result was False 2025-08-24 11:06:59.157611 | 2025-08-24 11:06:59.157716 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-24 11:06:59.568646 | debian-bookworm | ok 2025-08-24 11:06:59.578735 | 2025-08-24 11:06:59.578884 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-24 11:06:59.606736 | debian-bookworm | ok 2025-08-24 11:06:59.611614 | 2025-08-24 11:06:59.611709 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-24 11:06:59.895845 | debian-bookworm -> localhost | ok 2025-08-24 11:06:59.909343 | 2025-08-24 11:06:59.909474 | TASK [validate-host : Collect information about the host] 2025-08-24 11:07:00.963202 | debian-bookworm | ok 2025-08-24 11:07:00.973385 | 2025-08-24 11:07:00.973480 | TASK [validate-host : Sanitize hostname] 2025-08-24 11:07:01.066472 | debian-bookworm | ok 2025-08-24 11:07:01.108947 | 2025-08-24 11:07:01.109132 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-24 11:07:01.675633 | debian-bookworm -> localhost | changed 2025-08-24 11:07:01.680960 | 2025-08-24 11:07:01.681046 | TASK [validate-host : Collect information about zuul worker] 2025-08-24 11:07:02.072582 | debian-bookworm | ok 2025-08-24 11:07:02.077170 | 2025-08-24 11:07:02.077261 | TASK [validate-host : Write out all zuul information for each host] 2025-08-24 11:07:02.589261 | debian-bookworm -> localhost | changed 2025-08-24 11:07:02.598003 | 2025-08-24 11:07:02.598094 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-24 11:07:02.867907 | debian-bookworm | ok 2025-08-24 11:07:02.878592 | 2025-08-24 11:07:02.878709 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-24 11:07:03.895729 | debian-bookworm | changed: 2025-08-24 11:07:03.895936 | debian-bookworm | cd+++++++++ src/ 2025-08-24 11:07:03.895971 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-24 11:07:03.895995 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-24 11:07:03.896017 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-24 11:07:03.896037 | debian-bookworm | Containerfile 2025-08-24 11:07:03.896190 | debian-bookworm | Containerfile 2025-08-24 11:07:03.900309 | debian-bookworm | =37.0.0 in /tmp/venv/lib/python3.11/site-packages (from types-paramiko) (45.0.6) 2025-08-24 11:08:22.479423 | debian-bookworm | Collecting types-cffi 2025-08-24 11:08:22.490608 | debian-bookworm | Downloading types_cffi-1.17.0.20250822-py3-none-any.whl (20 kB) 2025-08-24 11:08:22.511172 | debian-bookworm | Requirement already satisfied: urllib3>=2 in /tmp/venv/lib/python3.11/site-packages (from types-requests) (2.5.0) 2025-08-24 11:08:22.543414 | debian-bookworm | Requirement already satisfied: cffi>=1.14 in /tmp/venv/lib/python3.11/site-packages (from cryptography>=37.0.0->types-paramiko) (1.17.1) 2025-08-24 11:08:22.622319 | debian-bookworm | Collecting types-setuptools 2025-08-24 11:08:22.631131 | debian-bookworm | Downloading types_setuptools-80.9.0.20250822-py3-none-any.whl (63 kB) 2025-08-24 11:08:22.657836 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 63.2/63.2 kB 2.7 MB/s eta 0:00:00 2025-08-24 11:08:22.668328 | debian-bookworm | Requirement already satisfied: pycparser in /tmp/venv/lib/python3.11/site-packages (from cffi>=1.14->cryptography>=37.0.0->types-paramiko) (2.22) 2025-08-24 11:08:23.457460 | debian-bookworm | Installing collected packages: types-ujson, types-tabulate, types-simplejson, types-setuptools, types-requests, types-PyYAML, types-pytz, types-python-dateutil, types-decorator, types-cffi, types-pyOpenSSL, types-paramiko 2025-08-24 11:08:23.935653 | debian-bookworm | Successfully installed types-PyYAML-6.0.12.20250822 types-cffi-1.17.0.20250822 types-decorator-5.2.0.20250324 types-paramiko-4.0.0.20250822 types-pyOpenSSL-24.1.0.20240722 types-python-dateutil-2.9.0.20250822 types-pytz-2025.2.0.20250809 types-requests-2.32.4.20250809 types-setuptools-80.9.0.20250822 types-simplejson-3.20.0.20250822 types-tabulate-0.9.0.20241207 types-ujson-5.10.0.20250822 2025-08-24 11:08:30.140512 | 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] 2025-08-24 11:08:30.140645 | 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] 2025-08-24 11:08:30.140668 | 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] 2025-08-24 11:08:30.140682 | 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] 2025-08-24 11:08:30.140721 | debian-bookworm | osism/services/listener.py:174: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2025-08-24 11:08:30.140736 | debian-bookworm | osism/services/listener.py:175: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2025-08-24 11:08:30.140747 | debian-bookworm | Installing missing stub packages: 2025-08-24 11:08:30.140760 | debian-bookworm | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-paramiko types-pyOpenSSL types-python-dateutil types-pytz types-requests types-simplejson types-tabulate types-ujson 2025-08-24 11:08:30.140773 | debian-bookworm | 2025-08-24 11:08:30.140784 | debian-bookworm | 2025-08-24 11:08:30.140795 | debian-bookworm | Success: no issues found in 67 source files 2025-08-24 11:08:30.449043 | debian-bookworm | ok: Runtime: 0:00:24.496451 2025-08-24 11:08:30.464594 | 2025-08-24 11:08:30.464746 | PLAY RECAP 2025-08-24 11:08:30.464875 | debian-bookworm | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-08-24 11:08:30.464924 | 2025-08-24 11:08:30.619146 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-08-24 11:08:30.621123 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-24 11:08:31.358552 | 2025-08-24 11:08:31.358713 | PLAY [Base post] 2025-08-24 11:08:31.372380 | 2025-08-24 11:08:31.372507 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-24 11:08:31.955673 | debian-bookworm | changed 2025-08-24 11:08:31.965864 | 2025-08-24 11:08:31.966011 | PLAY RECAP 2025-08-24 11:08:31.966097 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-24 11:08:31.966185 | 2025-08-24 11:08:32.091891 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-24 11:08:32.093865 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-24 11:08:32.882216 | 2025-08-24 11:08:32.882378 | PLAY [Base post-logs] 2025-08-24 11:08:32.893271 | 2025-08-24 11:08:32.893397 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-24 11:08:33.360507 | localhost | changed 2025-08-24 11:08:33.383224 | 2025-08-24 11:08:33.383398 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-24 11:08:33.423595 | localhost | ok 2025-08-24 11:08:33.430988 | 2025-08-24 11:08:33.431167 | TASK [Set zuul-log-path fact] 2025-08-24 11:08:33.450947 | localhost | ok 2025-08-24 11:08:33.462004 | 2025-08-24 11:08:33.462123 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-24 11:08:33.488768 | localhost | ok 2025-08-24 11:08:33.492497 | 2025-08-24 11:08:33.492611 | TASK [upload-logs : Create log directories] 2025-08-24 11:08:33.994246 | localhost | changed 2025-08-24 11:08:34.000033 | 2025-08-24 11:08:34.000190 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-24 11:08:34.516626 | localhost -> localhost | ok: Runtime: 0:00:00.009092 2025-08-24 11:08:34.525082 | 2025-08-24 11:08:34.525267 | TASK [upload-logs : Upload logs to log server] 2025-08-24 11:08:35.095173 | localhost | Output suppressed because no_log was given 2025-08-24 11:08:35.100310 | 2025-08-24 11:08:35.100509 | LOOP [upload-logs : Compress console log and json output] 2025-08-24 11:08:35.157251 | localhost | skipping: Conditional result was False 2025-08-24 11:08:35.162076 | localhost | skipping: Conditional result was False 2025-08-24 11:08:35.174662 | 2025-08-24 11:08:35.174951 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-24 11:08:35.222254 | localhost | skipping: Conditional result was False 2025-08-24 11:08:35.222826 | 2025-08-24 11:08:35.226328 | localhost | skipping: Conditional result was False 2025-08-24 11:08:35.240728 | 2025-08-24 11:08:35.241009 | LOOP [upload-logs : Upload console log and json output]