2025-06-12 17:37:30.104948 | Job console starting 2025-06-12 17:37:30.138621 | Updating git repos 2025-06-12 17:37:30.211871 | Cloning repos into workspace 2025-06-12 17:37:30.336581 | Restoring repo states 2025-06-12 17:37:30.351029 | Merging changes 2025-06-12 17:37:30.906137 | Checking out repos 2025-06-12 17:37:30.935131 | Preparing playbooks 2025-06-12 17:37:32.087455 | Running Ansible setup 2025-06-12 17:37:38.136129 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-12 17:37:39.534891 | 2025-06-12 17:37:39.535074 | PLAY [Base pre] 2025-06-12 17:37:39.589287 | 2025-06-12 17:37:39.589558 | TASK [Setup log path fact] 2025-06-12 17:37:39.637283 | debian-bookworm | ok 2025-06-12 17:37:39.653628 | 2025-06-12 17:37:39.653792 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-12 17:37:39.685550 | debian-bookworm | ok 2025-06-12 17:37:39.697399 | 2025-06-12 17:37:39.697565 | TASK [emit-job-header : Print job information] 2025-06-12 17:37:39.748325 | # Job Information 2025-06-12 17:37:39.748533 | Ansible Version: 2.16.14 2025-06-12 17:37:39.748569 | Job: mypy 2025-06-12 17:37:39.748603 | Pipeline: check 2025-06-12 17:37:39.748626 | Executor: 521e9411259a 2025-06-12 17:37:39.748647 | Triggered by: https://github.com/osism/python-osism/pull/1414 2025-06-12 17:37:39.748669 | Event ID: e422cf50-47b3-11f0-8143-3556dff7ab67 2025-06-12 17:37:39.753722 | 2025-06-12 17:37:39.753848 | LOOP [emit-job-header : Print node information] 2025-06-12 17:37:39.949698 | debian-bookworm | ok: 2025-06-12 17:37:39.949895 | debian-bookworm | # Node Information 2025-06-12 17:37:39.949929 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-12 17:37:39.949954 | debian-bookworm | Hostname: debian 2025-06-12 17:37:39.949976 | debian-bookworm | Username: zuul 2025-06-12 17:37:39.949997 | debian-bookworm | Distro: Debian 12.11 2025-06-12 17:37:39.950021 | debian-bookworm | Provider: regiocloud-a 2025-06-12 17:37:39.950043 | debian-bookworm | Region: 2025-06-12 17:37:39.950064 | debian-bookworm | Label: debian-bookworm 2025-06-12 17:37:39.950084 | debian-bookworm | Product Name: OpenStack Nova 2025-06-12 17:37:39.950104 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe43:804d 2025-06-12 17:37:39.961580 | 2025-06-12 17:37:39.961722 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-12 17:37:40.759402 | debian-bookworm -> localhost | changed 2025-06-12 17:37:40.767051 | 2025-06-12 17:37:40.767181 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-12 17:37:42.501519 | debian-bookworm -> localhost | changed 2025-06-12 17:37:42.512887 | 2025-06-12 17:37:42.513042 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-12 17:37:43.031318 | debian-bookworm -> localhost | ok 2025-06-12 17:37:43.047789 | 2025-06-12 17:37:43.047934 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-12 17:37:43.087914 | debian-bookworm | ok 2025-06-12 17:37:43.119556 | debian-bookworm | included: /var/lib/zuul/builds/85684e64034d409fbf5381a1e8a61083/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-12 17:37:43.125688 | 2025-06-12 17:37:43.125794 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-12 17:37:45.260890 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-12 17:37:45.261479 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/85684e64034d409fbf5381a1e8a61083/work/85684e64034d409fbf5381a1e8a61083_id_rsa 2025-06-12 17:37:45.261660 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/85684e64034d409fbf5381a1e8a61083/work/85684e64034d409fbf5381a1e8a61083_id_rsa.pub 2025-06-12 17:37:45.261738 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-12 17:37:45.261808 | debian-bookworm -> localhost | SHA256:VXT5OY8uavjcxReiWgsjE+FD+sQSRVjOYarj/bT3dgs zuul-build-sshkey 2025-06-12 17:37:45.261873 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-12 17:37:45.261959 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-12 17:37:45.262025 | debian-bookworm -> localhost | | +* .o .. | 2025-06-12 17:37:45.262087 | debian-bookworm -> localhost | | .* . . .. | 2025-06-12 17:37:45.262145 | debian-bookworm -> localhost | | o = . ..| 2025-06-12 17:37:45.262202 | debian-bookworm -> localhost | | . * .. o.| 2025-06-12 17:37:45.262259 | debian-bookworm -> localhost | | o o *S . oo| 2025-06-12 17:37:45.262332 | debian-bookworm -> localhost | | . o + o ..o o| 2025-06-12 17:37:45.262390 | debian-bookworm -> localhost | | . . = + E .o .| 2025-06-12 17:37:45.262447 | debian-bookworm -> localhost | | o =o*o+o.. | 2025-06-12 17:37:45.262524 | debian-bookworm -> localhost | | o.+*+oo. | 2025-06-12 17:37:45.262585 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-12 17:37:45.262725 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.176104 2025-06-12 17:37:45.274286 | 2025-06-12 17:37:45.274411 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-12 17:37:45.303534 | debian-bookworm | ok 2025-06-12 17:37:45.314173 | debian-bookworm | included: /var/lib/zuul/builds/85684e64034d409fbf5381a1e8a61083/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-12 17:37:45.323356 | 2025-06-12 17:37:45.323471 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-12 17:37:45.347900 | debian-bookworm | skipping: Conditional result was False 2025-06-12 17:37:45.353815 | 2025-06-12 17:37:45.353922 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-12 17:37:46.015110 | debian-bookworm | changed 2025-06-12 17:37:46.027727 | 2025-06-12 17:37:46.027905 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-12 17:37:46.296246 | debian-bookworm | ok 2025-06-12 17:37:46.302369 | 2025-06-12 17:37:46.302491 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-12 17:37:46.987910 | debian-bookworm | changed 2025-06-12 17:37:47.009246 | 2025-06-12 17:37:47.009404 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-12 17:37:47.795415 | debian-bookworm | changed 2025-06-12 17:37:47.807939 | 2025-06-12 17:37:47.808072 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-12 17:37:47.832260 | debian-bookworm | skipping: Conditional result was False 2025-06-12 17:37:47.838896 | 2025-06-12 17:37:47.839018 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-12 17:37:48.489320 | debian-bookworm -> localhost | changed 2025-06-12 17:37:48.502428 | 2025-06-12 17:37:48.502610 | TASK [add-build-sshkey : Add back temp key] 2025-06-12 17:37:48.881194 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/85684e64034d409fbf5381a1e8a61083/work/85684e64034d409fbf5381a1e8a61083_id_rsa (zuul-build-sshkey) 2025-06-12 17:37:48.881559 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012680 2025-06-12 17:37:48.890249 | 2025-06-12 17:37:48.890374 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-12 17:37:49.390762 | debian-bookworm | ok 2025-06-12 17:37:49.398703 | 2025-06-12 17:37:49.398976 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-12 17:37:49.453406 | debian-bookworm | skipping: Conditional result was False 2025-06-12 17:37:49.477992 | 2025-06-12 17:37:49.478903 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-12 17:37:49.976240 | debian-bookworm | ok 2025-06-12 17:37:49.997988 | 2025-06-12 17:37:49.998133 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-12 17:37:50.049347 | debian-bookworm | ok 2025-06-12 17:37:50.056654 | 2025-06-12 17:37:50.056782 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-12 17:37:50.385531 | debian-bookworm -> localhost | ok 2025-06-12 17:37:50.392340 | 2025-06-12 17:37:50.392459 | TASK [validate-host : Collect information about the host] 2025-06-12 17:37:51.549373 | debian-bookworm | ok 2025-06-12 17:37:51.567008 | 2025-06-12 17:37:51.567137 | TASK [validate-host : Sanitize hostname] 2025-06-12 17:37:51.711271 | debian-bookworm | ok 2025-06-12 17:37:51.781462 | 2025-06-12 17:37:51.781620 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-12 17:37:52.620336 | debian-bookworm -> localhost | changed 2025-06-12 17:37:52.630252 | 2025-06-12 17:37:52.630483 | TASK [validate-host : Collect information about zuul worker] 2025-06-12 17:37:53.263487 | debian-bookworm | ok 2025-06-12 17:37:53.269060 | 2025-06-12 17:37:53.269184 | TASK [validate-host : Write out all zuul information for each host] 2025-06-12 17:37:54.368294 | debian-bookworm -> localhost | changed 2025-06-12 17:37:54.380513 | 2025-06-12 17:37:54.380677 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-12 17:37:54.760123 | debian-bookworm | ok 2025-06-12 17:37:54.766034 | 2025-06-12 17:37:54.766163 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-12 17:37:56.455147 | debian-bookworm | changed: 2025-06-12 17:37:56.455486 | debian-bookworm | cd+++++++++ src/ 2025-06-12 17:37:56.455570 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-12 17:37:56.455598 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-12 17:37:56.455620 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-06-12 17:37:56.455641 | debian-bookworm | Containerfile 2025-06-12 17:37:56.455874 | debian-bookworm | =35.0.0 in /tmp/venv/lib/python3.11/site-packages (from types-pyOpenSSL) (45.0.4) 2025-06-12 17:39:17.311660 | debian-bookworm | Requirement already satisfied: urllib3>=2 in /tmp/venv/lib/python3.11/site-packages (from types-requests) (2.4.0) 2025-06-12 17:39:17.339579 | debian-bookworm | Requirement already satisfied: cffi>=1.14 in /tmp/venv/lib/python3.11/site-packages (from cryptography>=35.0.0->types-pyOpenSSL) (1.17.1) 2025-06-12 17:39:17.417921 | debian-bookworm | Collecting types-setuptools 2025-06-12 17:39:17.425396 | debian-bookworm | Downloading types_setuptools-80.9.0.20250529-py3-none-any.whl (63 kB) 2025-06-12 17:39:17.437435 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 63.3/63.3 kB 6.1 MB/s eta 0:00:00 2025-06-12 17:39:17.442226 | debian-bookworm | Requirement already satisfied: pycparser in /tmp/venv/lib/python3.11/site-packages (from cffi>=1.14->cryptography>=35.0.0->types-pyOpenSSL) (2.22) 2025-06-12 17:39:18.233883 | 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 2025-06-12 17:39:18.497445 | debian-bookworm | Successfully installed types-PyYAML-6.0.12.20250516 types-cffi-1.17.0.20250523 types-decorator-5.2.0.20250324 types-pyOpenSSL-24.1.0.20240722 types-python-dateutil-2.9.0.20250516 types-pytz-2025.2.0.20250516 types-requests-2.32.4.20250611 types-setuptools-80.9.0.20250529 types-simplejson-3.20.0.20250326 types-tabulate-0.9.0.20241207 types-ujson-5.10.0.20250326 2025-06-12 17:39:24.004266 | debian-bookworm | osism/services/listener.py:139: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2025-06-12 17:39:24.004342 | debian-bookworm | osism/services/listener.py:140: note: By default the bodies of untyped functions are not checked, consider using --check-untyped-defs [annotation-unchecked] 2025-06-12 17:39:24.004358 | debian-bookworm | Installing missing stub packages: 2025-06-12 17:39:24.004371 | debian-bookworm | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-pyOpenSSL types-python-dateutil types-pytz types-requests types-simplejson types-tabulate types-ujson 2025-06-12 17:39:24.004387 | debian-bookworm | 2025-06-12 17:39:24.004399 | debian-bookworm | 2025-06-12 17:39:24.004411 | debian-bookworm | Success: no issues found in 53 source files 2025-06-12 17:39:24.523438 | debian-bookworm | ok: Runtime: 0:00:22.769923 2025-06-12 17:39:24.541551 | 2025-06-12 17:39:24.541734 | PLAY RECAP 2025-06-12 17:39:24.541839 | debian-bookworm | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-06-12 17:39:24.541889 | 2025-06-12 17:39:24.687372 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-06-12 17:39:24.689913 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-06-12 17:39:25.442086 | 2025-06-12 17:39:25.442248 | PLAY [Base post] 2025-06-12 17:39:25.456274 | 2025-06-12 17:39:25.456419 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-06-12 17:39:26.012172 | debian-bookworm | changed 2025-06-12 17:39:26.020712 | 2025-06-12 17:39:26.020840 | PLAY RECAP 2025-06-12 17:39:26.020916 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-06-12 17:39:26.020992 | 2025-06-12 17:39:26.161564 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-06-12 17:39:26.163628 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-06-12 17:39:26.985122 | 2025-06-12 17:39:26.985300 | PLAY [Base post-logs] 2025-06-12 17:39:26.996520 | 2025-06-12 17:39:26.996702 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-06-12 17:39:27.503087 | localhost | changed 2025-06-12 17:39:27.514342 | 2025-06-12 17:39:27.514516 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-06-12 17:39:27.554956 | localhost | ok 2025-06-12 17:39:27.563187 | 2025-06-12 17:39:27.563390 | TASK [Set zuul-log-path fact] 2025-06-12 17:39:27.592629 | localhost | ok 2025-06-12 17:39:27.607614 | 2025-06-12 17:39:27.607852 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-12 17:39:27.646985 | localhost | ok 2025-06-12 17:39:27.654752 | 2025-06-12 17:39:27.655004 | TASK [upload-logs : Create log directories] 2025-06-12 17:39:28.163794 | localhost | changed 2025-06-12 17:39:28.168834 | 2025-06-12 17:39:28.169019 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-06-12 17:39:28.663128 | localhost -> localhost | ok: Runtime: 0:00:00.006869 2025-06-12 17:39:28.667384 | 2025-06-12 17:39:28.667505 | TASK [upload-logs : Upload logs to log server] 2025-06-12 17:39:29.265382 | localhost | Output suppressed because no_log was given 2025-06-12 17:39:29.269415 | 2025-06-12 17:39:29.269623 | LOOP [upload-logs : Compress console log and json output] 2025-06-12 17:39:29.350080 | localhost | skipping: Conditional result was False 2025-06-12 17:39:29.355049 | localhost | skipping: Conditional result was False 2025-06-12 17:39:29.363259 | 2025-06-12 17:39:29.363497 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-12 17:39:29.424325 | localhost | skipping: Conditional result was False 2025-06-12 17:39:29.425052 | 2025-06-12 17:39:29.428240 | localhost | skipping: Conditional result was False 2025-06-12 17:39:29.437816 | 2025-06-12 17:39:29.438072 | LOOP [upload-logs : Upload console log and json output]