2025-09-22 08:37:44.929759 | Job console starting 2025-09-22 08:37:44.954439 | Updating git repos 2025-09-22 08:37:45.032073 | Cloning repos into workspace 2025-09-22 08:37:45.122309 | Restoring repo states 2025-09-22 08:37:45.135274 | Merging changes 2025-09-22 08:37:45.784904 | Checking out repos 2025-09-22 08:37:45.867974 | Preparing playbooks 2025-09-22 08:37:47.033501 | Running Ansible setup 2025-09-22 08:37:53.723168 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-22 08:37:55.125620 | 2025-09-22 08:37:55.125737 | PLAY [Base pre] 2025-09-22 08:37:55.141426 | 2025-09-22 08:37:55.141533 | TASK [Setup log path fact] 2025-09-22 08:37:55.180462 | debian-bookworm | ok 2025-09-22 08:37:55.197180 | 2025-09-22 08:37:55.197331 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-22 08:37:55.247654 | debian-bookworm | ok 2025-09-22 08:37:55.267736 | 2025-09-22 08:37:55.267854 | TASK [emit-job-header : Print job information] 2025-09-22 08:37:55.339867 | # Job Information 2025-09-22 08:37:55.340017 | Ansible Version: 2.16.14 2025-09-22 08:37:55.340051 | Job: mypy 2025-09-22 08:37:55.340084 | Pipeline: check 2025-09-22 08:37:55.340106 | Executor: 521e9411259a 2025-09-22 08:37:55.340127 | Triggered by: https://github.com/osism/python-osism/pull/1703 2025-09-22 08:37:55.340149 | Event ID: 63767330-978f-11f0-8ded-58e5f4cb9869 2025-09-22 08:37:55.344823 | 2025-09-22 08:37:55.344917 | LOOP [emit-job-header : Print node information] 2025-09-22 08:37:55.492308 | debian-bookworm | ok: 2025-09-22 08:37:55.492464 | debian-bookworm | # Node Information 2025-09-22 08:37:55.492498 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-22 08:37:55.492523 | debian-bookworm | Hostname: debian 2025-09-22 08:37:55.492545 | debian-bookworm | Username: zuul 2025-09-22 08:37:55.492566 | debian-bookworm | Distro: Debian 12.12 2025-09-22 08:37:55.492589 | debian-bookworm | Provider: regiocloud-a 2025-09-22 08:37:55.492609 | debian-bookworm | Region: 2025-09-22 08:37:55.492630 | debian-bookworm | Label: debian-bookworm 2025-09-22 08:37:55.492649 | debian-bookworm | Product Name: OpenStack Nova 2025-09-22 08:37:55.492669 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed2:8487 2025-09-22 08:37:55.515834 | 2025-09-22 08:37:55.515945 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-22 08:37:56.164009 | debian-bookworm -> localhost | changed 2025-09-22 08:37:56.170077 | 2025-09-22 08:37:56.170173 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-22 08:37:57.634687 | debian-bookworm -> localhost | changed 2025-09-22 08:37:57.643241 | 2025-09-22 08:37:57.643332 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-22 08:37:58.018826 | debian-bookworm -> localhost | ok 2025-09-22 08:37:58.024626 | 2025-09-22 08:37:58.024724 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-22 08:37:58.052369 | debian-bookworm | ok 2025-09-22 08:37:58.091168 | debian-bookworm | included: /var/lib/zuul/builds/3194474fd3814118a1d202dd2c4004f6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-22 08:37:58.108057 | 2025-09-22 08:37:58.108155 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-22 08:37:59.823670 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-22 08:37:59.823860 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3194474fd3814118a1d202dd2c4004f6/work/3194474fd3814118a1d202dd2c4004f6_id_rsa 2025-09-22 08:37:59.823892 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3194474fd3814118a1d202dd2c4004f6/work/3194474fd3814118a1d202dd2c4004f6_id_rsa.pub 2025-09-22 08:37:59.823914 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-22 08:37:59.823934 | debian-bookworm -> localhost | SHA256:4V40a8ZrEYUWdPckG0aMBd1LAuxFK5w2D+f5sVKef5s zuul-build-sshkey 2025-09-22 08:37:59.823953 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-22 08:37:59.823979 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-22 08:37:59.823997 | debian-bookworm -> localhost | | .++*OB..| 2025-09-22 08:37:59.824014 | debian-bookworm -> localhost | | ++o=+B.| 2025-09-22 08:37:59.824032 | debian-bookworm -> localhost | | ..=B.o+ o| 2025-09-22 08:37:59.824048 | debian-bookworm -> localhost | | . +.=B .. | 2025-09-22 08:37:59.824065 | debian-bookworm -> localhost | | S B + o | 2025-09-22 08:37:59.824085 | debian-bookworm -> localhost | | . + o + +| 2025-09-22 08:37:59.824102 | debian-bookworm -> localhost | | . o . = | 2025-09-22 08:37:59.824119 | debian-bookworm -> localhost | | . . +| 2025-09-22 08:37:59.824135 | debian-bookworm -> localhost | | E+| 2025-09-22 08:37:59.824152 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-22 08:37:59.824200 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.969510 2025-09-22 08:37:59.829254 | 2025-09-22 08:37:59.829333 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-22 08:37:59.865728 | debian-bookworm | ok 2025-09-22 08:37:59.875590 | debian-bookworm | included: /var/lib/zuul/builds/3194474fd3814118a1d202dd2c4004f6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-22 08:37:59.891739 | 2025-09-22 08:37:59.891822 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-22 08:37:59.924763 | debian-bookworm | skipping: Conditional result was False 2025-09-22 08:37:59.929364 | 2025-09-22 08:37:59.929444 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-22 08:38:00.642699 | debian-bookworm | changed 2025-09-22 08:38:00.647955 | 2025-09-22 08:38:00.648037 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-22 08:38:00.949438 | debian-bookworm | ok 2025-09-22 08:38:00.956902 | 2025-09-22 08:38:00.957023 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-22 08:38:01.603011 | debian-bookworm | changed 2025-09-22 08:38:01.613310 | 2025-09-22 08:38:01.613430 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-22 08:38:02.242427 | debian-bookworm | changed 2025-09-22 08:38:02.249340 | 2025-09-22 08:38:02.249474 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-22 08:38:02.262996 | debian-bookworm | skipping: Conditional result was False 2025-09-22 08:38:02.269626 | 2025-09-22 08:38:02.269718 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-22 08:38:02.637209 | debian-bookworm -> localhost | changed 2025-09-22 08:38:02.651533 | 2025-09-22 08:38:02.651636 | TASK [add-build-sshkey : Add back temp key] 2025-09-22 08:38:02.993474 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3194474fd3814118a1d202dd2c4004f6/work/3194474fd3814118a1d202dd2c4004f6_id_rsa (zuul-build-sshkey) 2025-09-22 08:38:02.993694 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016103 2025-09-22 08:38:03.001956 | 2025-09-22 08:38:03.002062 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-22 08:38:03.400846 | debian-bookworm | ok 2025-09-22 08:38:03.405876 | 2025-09-22 08:38:03.406944 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-22 08:38:03.430364 | debian-bookworm | skipping: Conditional result was False 2025-09-22 08:38:03.440090 | 2025-09-22 08:38:03.440189 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-22 08:38:04.005898 | debian-bookworm | ok 2025-09-22 08:38:04.018218 | 2025-09-22 08:38:04.018320 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-22 08:38:04.066291 | debian-bookworm | ok 2025-09-22 08:38:04.071114 | 2025-09-22 08:38:04.071214 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-22 08:38:04.489813 | debian-bookworm -> localhost | ok 2025-09-22 08:38:04.496068 | 2025-09-22 08:38:04.496167 | TASK [validate-host : Collect information about the host] 2025-09-22 08:38:05.671786 | debian-bookworm | ok 2025-09-22 08:38:05.683255 | 2025-09-22 08:38:05.683387 | TASK [validate-host : Sanitize hostname] 2025-09-22 08:38:05.794301 | debian-bookworm | ok 2025-09-22 08:38:05.833673 | 2025-09-22 08:38:05.833807 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-22 08:38:06.630303 | debian-bookworm -> localhost | changed 2025-09-22 08:38:06.636006 | 2025-09-22 08:38:06.636104 | TASK [validate-host : Collect information about zuul worker] 2025-09-22 08:38:07.041059 | debian-bookworm | ok 2025-09-22 08:38:07.049263 | 2025-09-22 08:38:07.049356 | TASK [validate-host : Write out all zuul information for each host] 2025-09-22 08:38:07.735005 | debian-bookworm -> localhost | changed 2025-09-22 08:38:07.743842 | 2025-09-22 08:38:07.743936 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-22 08:38:08.006634 | debian-bookworm | ok 2025-09-22 08:38:08.011771 | 2025-09-22 08:38:08.011862 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-22 08:38:09.174596 | debian-bookworm | changed: 2025-09-22 08:38:09.175238 | debian-bookworm | cd+++++++++ src/ 2025-09-22 08:38:09.175295 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-22 08:38:09.175325 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-22 08:38:09.175352 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-09-22 08:38:09.175376 | debian-bookworm | Containerfile 2025-09-22 08:38:09.175516 | debian-bookworm | Containerfile 2025-09-22 08:38:09.206348 | debian-bookworm | =37.0.0 in /tmp/venv/lib/python3.11/site-packages (from types-paramiko) (46.0.1) 2025-09-22 08:39:29.466795 | debian-bookworm | Requirement already satisfied: urllib3>=2 in /tmp/venv/lib/python3.11/site-packages (from types-requests) (2.5.0) 2025-09-22 08:39:29.495702 | 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) 2025-09-22 08:39:29.508994 | 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) (2.23) 2025-09-22 08:39:30.329630 | debian-bookworm | Installing collected packages: types-ujson, types-tabulate, types-simplejson, types-requests, types-PyYAML, types-pytz, types-python-dateutil, types-decorator, types-paramiko 2025-09-22 08:39:30.599375 | debian-bookworm | Successfully installed types-PyYAML-6.0.12.20250915 types-decorator-5.2.0.20250324 types-paramiko-4.0.0.20250822 types-python-dateutil-2.9.0.20250822 types-pytz-2025.2.0.20250809 types-requests-2.32.4.20250913 types-simplejson-3.20.0.20250822 types-tabulate-0.9.0.20241207 types-ujson-5.10.0.20250822 2025-09-22 08:39:39.500768 | 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-09-22 08:39:39.500915 | 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-09-22 08:39:39.500945 | 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-09-22 08:39:39.500965 | 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-09-22 08:39:39.500983 | 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-09-22 08:39:39.501005 | 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-09-22 08:39:39.501027 | debian-bookworm | Installing missing stub packages: 2025-09-22 08:39:39.501051 | debian-bookworm | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-paramiko types-python-dateutil types-pytz types-requests types-simplejson types-tabulate types-ujson 2025-09-22 08:39:39.501103 | debian-bookworm | 2025-09-22 08:39:39.501129 | debian-bookworm | 2025-09-22 08:39:39.501142 | debian-bookworm | Success: no issues found in 68 source files 2025-09-22 08:39:39.846606 | debian-bookworm | ok: Runtime: 0:00:26.398333 2025-09-22 08:39:39.856656 | 2025-09-22 08:39:39.856767 | PLAY RECAP 2025-09-22 08:39:39.856842 | debian-bookworm | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-09-22 08:39:39.856879 | 2025-09-22 08:39:39.983328 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-09-22 08:39:39.985519 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-22 08:39:40.737528 | 2025-09-22 08:39:40.737686 | PLAY [Base post] 2025-09-22 08:39:40.751688 | 2025-09-22 08:39:40.751829 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-22 08:39:41.290890 | debian-bookworm | changed 2025-09-22 08:39:41.297137 | 2025-09-22 08:39:41.297259 | PLAY RECAP 2025-09-22 08:39:41.297323 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-22 08:39:41.297386 | 2025-09-22 08:39:41.418081 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-22 08:39:41.421045 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-22 08:39:42.295541 | 2025-09-22 08:39:42.295708 | PLAY [Base post-logs] 2025-09-22 08:39:42.306413 | 2025-09-22 08:39:42.306544 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-22 08:39:42.760808 | localhost | changed 2025-09-22 08:39:42.772185 | 2025-09-22 08:39:42.772352 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-22 08:39:42.807570 | localhost | ok 2025-09-22 08:39:42.810568 | 2025-09-22 08:39:42.810664 | TASK [Set zuul-log-path fact] 2025-09-22 08:39:42.836025 | localhost | ok 2025-09-22 08:39:42.844547 | 2025-09-22 08:39:42.844661 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-22 08:39:42.879641 | localhost | ok 2025-09-22 08:39:42.882890 | 2025-09-22 08:39:42.882994 | TASK [upload-logs : Create log directories] 2025-09-22 08:39:43.427647 | localhost | changed 2025-09-22 08:39:43.430435 | 2025-09-22 08:39:43.430545 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-22 08:39:43.932722 | localhost -> localhost | ok: Runtime: 0:00:00.008493 2025-09-22 08:39:43.936901 | 2025-09-22 08:39:43.937015 | TASK [upload-logs : Upload logs to log server] 2025-09-22 08:39:44.493509 | localhost | Output suppressed because no_log was given 2025-09-22 08:39:44.497704 | 2025-09-22 08:39:44.497926 | LOOP [upload-logs : Compress console log and json output] 2025-09-22 08:39:44.558964 | localhost | skipping: Conditional result was False 2025-09-22 08:39:44.564083 | localhost | skipping: Conditional result was False 2025-09-22 08:39:44.571776 | 2025-09-22 08:39:44.572005 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-22 08:39:44.619892 | localhost | skipping: Conditional result was False 2025-09-22 08:39:44.620468 | 2025-09-22 08:39:44.624101 | localhost | skipping: Conditional result was False 2025-09-22 08:39:44.636693 | 2025-09-22 08:39:44.636913 | LOOP [upload-logs : Upload console log and json output]