2025-01-09 08:09:07.764218 | Job console starting... 2025-01-09 08:09:07.795170 | Updating repositories 2025-01-09 08:09:07.844172 | Preparing job workspace 2025-01-09 08:09:09.378233 | Running Ansible setup... 2025-01-09 08:09:14.842233 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-09 08:09:15.695316 | 2025-01-09 08:09:15.695482 | PLAY [Base pre] 2025-01-09 08:09:15.769273 | 2025-01-09 08:09:15.769441 | TASK [Setup log path fact] 2025-01-09 08:09:15.794841 | ubuntu-noble | ok 2025-01-09 08:09:15.822530 | 2025-01-09 08:09:15.822697 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-09 08:09:15.875079 | ubuntu-noble | ok 2025-01-09 08:09:15.881901 | 2025-01-09 08:09:15.882057 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-09 08:09:15.917478 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:09:15.925008 | 2025-01-09 08:09:15.925150 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-09 08:09:15.980913 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:09:15.989293 | 2025-01-09 08:09:15.989438 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-09 08:09:16.014800 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:09:16.025394 | 2025-01-09 08:09:16.025547 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-09 08:09:16.061783 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:09:16.069374 | 2025-01-09 08:09:16.069508 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-09 08:09:16.094487 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:09:16.111263 | 2025-01-09 08:09:16.111404 | TASK [emit-job-header : Print job information] 2025-01-09 08:09:16.174768 | # Job Information 2025-01-09 08:09:16.174981 | Ansible Version: 2.15.3 2025-01-09 08:09:16.175014 | Job: mypy 2025-01-09 08:09:16.175044 | Pipeline: check 2025-01-09 08:09:16.175066 | Executor: 7d211f194f6a 2025-01-09 08:09:16.175085 | Triggered by: https://github.com/osism/python-osism/pull/1173 2025-01-09 08:09:16.175104 | Event ID: fa5436a0-ce60-11ef-917a-746aed22eac7 2025-01-09 08:09:16.181676 | 2025-01-09 08:09:16.181793 | LOOP [emit-job-header : Print node information] 2025-01-09 08:09:16.349616 | ubuntu-noble | ok: 2025-01-09 08:09:16.350009 | ubuntu-noble | # Node Information 2025-01-09 08:09:16.350060 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-09 08:09:16.350084 | ubuntu-noble | Hostname: ubuntu 2025-01-09 08:09:16.350105 | ubuntu-noble | Username: zuul 2025-01-09 08:09:16.350125 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-09 08:09:16.350144 | ubuntu-noble | Provider: regiocloud-a 2025-01-09 08:09:16.350163 | ubuntu-noble | Label: ubuntu-noble 2025-01-09 08:09:16.350182 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-09 08:09:16.350202 | ubuntu-noble | Interface IP: 81.163.193.207 2025-01-09 08:09:16.378442 | 2025-01-09 08:09:16.378594 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-09 08:09:16.883920 | ubuntu-noble -> localhost | changed 2025-01-09 08:09:16.892949 | 2025-01-09 08:09:16.893087 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-09 08:09:17.748952 | ubuntu-noble -> localhost | changed 2025-01-09 08:09:17.772529 | 2025-01-09 08:09:17.772623 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-09 08:09:17.988446 | ubuntu-noble -> localhost | ok 2025-01-09 08:09:17.994422 | 2025-01-09 08:09:17.994510 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-09 08:09:18.014949 | ubuntu-noble | ok 2025-01-09 08:09:18.029302 | ubuntu-noble | included: /var/lib/zuul/builds/70194677f91d461391d40e2a26bc6565/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-09 08:09:18.035366 | 2025-01-09 08:09:18.035443 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-09 08:09:18.750502 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-09 08:09:18.750681 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/70194677f91d461391d40e2a26bc6565/work/70194677f91d461391d40e2a26bc6565_id_rsa 2025-01-09 08:09:18.750715 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/70194677f91d461391d40e2a26bc6565/work/70194677f91d461391d40e2a26bc6565_id_rsa.pub 2025-01-09 08:09:18.750740 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-09 08:09:18.750762 | ubuntu-noble -> localhost | SHA256:71+9jPXFVu72/Fv35A4db3OUDf54rv/o/QVHS9JpBd8 zuul-build-sshkey 2025-01-09 08:09:18.750786 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-09 08:09:18.750811 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-09 08:09:18.750849 | ubuntu-noble -> localhost | | ...| 2025-01-09 08:09:18.750870 | ubuntu-noble -> localhost | | ..+| 2025-01-09 08:09:18.750889 | ubuntu-noble -> localhost | | ..=E| 2025-01-09 08:09:18.750909 | ubuntu-noble -> localhost | | .+o+| 2025-01-09 08:09:18.750929 | ubuntu-noble -> localhost | | S o+=| 2025-01-09 08:09:18.750948 | ubuntu-noble -> localhost | | . @+| 2025-01-09 08:09:18.750967 | ubuntu-noble -> localhost | | . +o^| 2025-01-09 08:09:18.750986 | ubuntu-noble -> localhost | | . .+&%| 2025-01-09 08:09:18.751005 | ubuntu-noble -> localhost | | ...o+O^| 2025-01-09 08:09:18.751024 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-09 08:09:18.751073 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.247094 2025-01-09 08:09:18.762521 | 2025-01-09 08:09:18.762618 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-09 08:09:18.796335 | ubuntu-noble | ok 2025-01-09 08:09:18.807176 | ubuntu-noble | included: /var/lib/zuul/builds/70194677f91d461391d40e2a26bc6565/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-09 08:09:18.815817 | 2025-01-09 08:09:18.815913 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-09 08:09:18.839626 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:09:18.846640 | 2025-01-09 08:09:18.846732 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-09 08:09:19.599491 | ubuntu-noble | changed 2025-01-09 08:09:19.608600 | 2025-01-09 08:09:19.608707 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-09 08:09:19.935111 | ubuntu-noble | ok 2025-01-09 08:09:19.943220 | 2025-01-09 08:09:19.943324 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-09 08:09:20.682298 | ubuntu-noble | changed 2025-01-09 08:09:20.697372 | 2025-01-09 08:09:20.697565 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-09 08:09:21.407477 | ubuntu-noble | changed 2025-01-09 08:09:21.428740 | 2025-01-09 08:09:21.428933 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-09 08:09:21.475432 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:09:21.484979 | 2025-01-09 08:09:21.485081 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-09 08:09:21.896276 | ubuntu-noble -> localhost | changed 2025-01-09 08:09:21.916269 | 2025-01-09 08:09:21.916421 | TASK [add-build-sshkey : Add back temp key] 2025-01-09 08:09:22.227238 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/70194677f91d461391d40e2a26bc6565/work/70194677f91d461391d40e2a26bc6565_id_rsa (zuul-build-sshkey) 2025-01-09 08:09:22.227630 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.011989 2025-01-09 08:09:22.239732 | 2025-01-09 08:09:22.239856 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-09 08:09:22.654375 | ubuntu-noble | ok 2025-01-09 08:09:22.696613 | 2025-01-09 08:09:22.696714 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-09 08:09:22.740902 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:09:22.756719 | 2025-01-09 08:09:22.756818 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-09 08:09:23.183109 | ubuntu-noble | ok 2025-01-09 08:09:23.204210 | 2025-01-09 08:09:23.204314 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-09 08:09:23.235289 | ubuntu-noble | ok 2025-01-09 08:09:23.241786 | 2025-01-09 08:09:23.241889 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-09 08:09:23.498967 | ubuntu-noble -> localhost | ok 2025-01-09 08:09:23.506373 | 2025-01-09 08:09:23.506463 | TASK [validate-host : Collect information about the host] 2025-01-09 08:09:24.648796 | ubuntu-noble | ok 2025-01-09 08:09:24.665454 | 2025-01-09 08:09:24.665554 | TASK [validate-host : Sanitize hostname] 2025-01-09 08:09:24.726515 | ubuntu-noble | ok 2025-01-09 08:09:24.732428 | 2025-01-09 08:09:24.732519 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-09 08:09:25.203797 | ubuntu-noble -> localhost | changed 2025-01-09 08:09:25.210553 | 2025-01-09 08:09:25.210646 | TASK [validate-host : Collect information about zuul worker] 2025-01-09 08:09:25.669872 | ubuntu-noble | ok 2025-01-09 08:09:25.678018 | 2025-01-09 08:09:25.678124 | TASK [validate-host : Write out all zuul information for each host] 2025-01-09 08:09:26.306648 | ubuntu-noble -> localhost | changed 2025-01-09 08:09:26.329037 | 2025-01-09 08:09:26.329175 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-09 08:09:26.654565 | ubuntu-noble | ok 2025-01-09 08:09:26.666029 | 2025-01-09 08:09:26.666152 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-09 08:09:27.785553 | ubuntu-noble | changed: 2025-01-09 08:09:27.785764 | ubuntu-noble | cd+++++++++ src/ 2025-01-09 08:09:27.785797 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-09 08:09:27.785862 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-09 08:09:27.785887 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-01-09 08:09:27.785937 | ubuntu-noble | Containerfile 2025-01-09 08:09:27.786055 | ubuntu-noble | =35.0.0 in /tmp/venv/lib/python3.12/site-packages (from types-redis) (44.0.0) 2025-01-09 08:11:10.484987 | ubuntu-noble | Requirement already satisfied: urllib3>=2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-01-09 08:11:10.511296 | ubuntu-noble | Requirement already satisfied: cffi>=1.12 in /tmp/venv/lib/python3.12/site-packages (from cryptography>=35.0.0->types-redis) (1.17.1) 2025-01-09 08:11:10.556544 | ubuntu-noble | Collecting types-cffi (from types-pyOpenSSL->types-redis) 2025-01-09 08:11:10.570235 | ubuntu-noble | Downloading types_cffi-1.16.0.20241221-py3-none-any.whl.metadata (1.8 kB) 2025-01-09 08:11:10.590726 | ubuntu-noble | Requirement already satisfied: pycparser in /tmp/venv/lib/python3.12/site-packages (from cffi>=1.12->cryptography>=35.0.0->types-redis) (2.22) 2025-01-09 08:11:10.674370 | ubuntu-noble | Collecting types-setuptools (from types-cffi->types-pyOpenSSL->types-redis) 2025-01-09 08:11:10.688311 | ubuntu-noble | Downloading types_setuptools-75.6.0.20241223-py3-none-any.whl.metadata (2.0 kB) 2025-01-09 08:11:10.715301 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-01-09 08:11:10.737343 | ubuntu-noble | Downloading types_decorator-5.1.8.20240310-py3-none-any.whl (3.1 kB) 2025-01-09 08:11:10.757602 | ubuntu-noble | Downloading types_python_dateutil-2.9.0.20241206-py3-none-any.whl (14 kB) 2025-01-09 08:11:10.782058 | ubuntu-noble | Downloading types_pytz-2024.2.0.20241221-py3-none-any.whl (10 kB) 2025-01-09 08:11:10.814308 | ubuntu-noble | Downloading types_redis-4.6.0.20241004-py3-none-any.whl (58 kB) 2025-01-09 08:11:10.967569 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.7/58.7 kB 330.5 kB/s eta 0:00:00 2025-01-09 08:11:10.983036 | ubuntu-noble | Downloading types_requests-2.32.0.20241016-py3-none-any.whl (15 kB) 2025-01-09 08:11:11.006980 | ubuntu-noble | Downloading types_simplejson-3.19.0.20241221-py3-none-any.whl (10 kB) 2025-01-09 08:11:11.030330 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-01-09 08:11:11.053590 | ubuntu-noble | Downloading types_ujson-5.10.0.20240515-py3-none-any.whl (2.8 kB) 2025-01-09 08:11:11.080311 | ubuntu-noble | Downloading types_pyOpenSSL-24.1.0.20240722-py3-none-any.whl (7.5 kB) 2025-01-09 08:11:11.107348 | ubuntu-noble | Downloading types_cffi-1.16.0.20241221-py3-none-any.whl (19 kB) 2025-01-09 08:11:11.132666 | ubuntu-noble | Downloading types_setuptools-75.6.0.20241223-py3-none-any.whl (71 kB) 2025-01-09 08:11:11.152319 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 71.4/71.4 kB 5.3 MB/s eta 0:00:00 2025-01-09 08:11:11.900893 | ubuntu-noble | 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-redis 2025-01-09 08:11:12.410753 | ubuntu-noble | Successfully installed types-PyYAML-6.0.12.20241230 types-cffi-1.16.0.20241221 types-decorator-5.1.8.20240310 types-pyOpenSSL-24.1.0.20240722 types-python-dateutil-2.9.0.20241206 types-pytz-2024.2.0.20241221 types-redis-4.6.0.20241004 types-requests-2.32.0.20241016 types-setuptools-75.6.0.20241223 types-simplejson-3.19.0.20241221 types-tabulate-0.9.0.20241207 types-ujson-5.10.0.20240515 2025-01-09 08:11:22.629719 | ubuntu-noble | Installing missing stub packages: 2025-01-09 08:11:22.661309 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-python-dateutil types-pytz types-redis types-requests types-simplejson types-tabulate types-ujson 2025-01-09 08:11:22.661575 | ubuntu-noble | 2025-01-09 08:11:22.661605 | ubuntu-noble | 2025-01-09 08:11:22.661620 | ubuntu-noble | Success: no issues found in 55 source files 2025-01-09 08:11:23.122531 | ubuntu-noble | ok 2025-01-09 08:11:23.172903 | 2025-01-09 08:11:23.173020 | PLAY RECAP 2025-01-09 08:11:23.173081 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-01-09 08:11:23.173107 | 2025-01-09 08:11:23.300756 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-01-09 08:11:23.303655 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-09 08:11:23.978127 | 2025-01-09 08:11:23.978269 | PLAY [Base post] 2025-01-09 08:11:24.004001 | 2025-01-09 08:11:24.004123 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-01-09 08:11:24.643095 | ubuntu-noble | changed 2025-01-09 08:11:24.678806 | 2025-01-09 08:11:24.679149 | PLAY RECAP 2025-01-09 08:11:24.679324 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-01-09 08:11:24.679495 | 2025-01-09 08:11:24.803110 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-09 08:11:24.811971 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-01-09 08:11:25.561308 | 2025-01-09 08:11:25.561480 | PLAY [Base post-logs] 2025-01-09 08:11:25.582989 | 2025-01-09 08:11:25.583345 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-01-09 08:11:26.043618 | localhost | changed 2025-01-09 08:11:26.047485 | 2025-01-09 08:11:26.047619 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-01-09 08:11:26.075982 | localhost | ok 2025-01-09 08:11:26.081611 | 2025-01-09 08:11:26.081711 | TASK [Set zuul-log-path fact] 2025-01-09 08:11:26.110350 | localhost | ok 2025-01-09 08:11:26.124002 | 2025-01-09 08:11:26.124111 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-09 08:11:26.173890 | localhost | ok 2025-01-09 08:11:26.179900 | 2025-01-09 08:11:26.180086 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-09 08:11:26.216962 | localhost | skipping: Conditional result was False 2025-01-09 08:11:26.225383 | 2025-01-09 08:11:26.225546 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-09 08:11:26.276487 | localhost | skipping: Conditional result was False 2025-01-09 08:11:26.287180 | 2025-01-09 08:11:26.287346 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-09 08:11:26.305588 | localhost | skipping: Conditional result was False 2025-01-09 08:11:26.312222 | 2025-01-09 08:11:26.312401 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-09 08:11:26.338162 | localhost | skipping: Conditional result was False 2025-01-09 08:11:26.346594 | 2025-01-09 08:11:26.346764 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-09 08:11:26.372260 | localhost | skipping: Conditional result was False 2025-01-09 08:11:26.385496 | 2025-01-09 08:11:26.385651 | TASK [upload-logs : Create log directories] 2025-01-09 08:11:26.886486 | localhost | changed 2025-01-09 08:11:26.891001 | 2025-01-09 08:11:26.891110 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-01-09 08:11:27.427599 | localhost -> localhost | ok: Runtime: 0:00:00.008687 2025-01-09 08:11:27.433191 | 2025-01-09 08:11:27.433306 | TASK [upload-logs : Upload logs to log server] 2025-01-09 08:11:28.015693 | localhost | Output suppressed because no_log was given 2025-01-09 08:11:28.020100 | 2025-01-09 08:11:28.020235 | LOOP [upload-logs : Compress console log and json output] 2025-01-09 08:11:28.086930 | localhost | skipping: Conditional result was False 2025-01-09 08:11:28.104812 | localhost | skipping: Conditional result was False 2025-01-09 08:11:28.117945 | 2025-01-09 08:11:28.118127 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-09 08:11:28.181972 | localhost | skipping: Conditional result was False 2025-01-09 08:11:28.182587 | 2025-01-09 08:11:28.194562 | localhost | skipping: Conditional result was False 2025-01-09 08:11:28.206492 | 2025-01-09 08:11:28.206702 | LOOP [upload-logs : Upload console log and json output]