2025-03-02 21:08:27.260354 | Job console starting... 2025-03-02 21:08:27.293089 | Updating repositories 2025-03-02 21:08:27.359343 | Preparing job workspace 2025-03-02 21:08:29.691310 | Running Ansible setup... 2025-03-02 21:08:35.845673 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-02 21:08:37.011795 | 2025-03-02 21:08:37.011927 | PLAY [Base pre] 2025-03-02 21:08:37.048902 | 2025-03-02 21:08:37.049022 | TASK [Setup log path fact] 2025-03-02 21:08:37.069103 | ubuntu-noble | ok 2025-03-02 21:08:37.090718 | 2025-03-02 21:08:37.090840 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-02 21:08:37.130700 | ubuntu-noble | ok 2025-03-02 21:08:37.149110 | 2025-03-02 21:08:37.149214 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-02 21:08:37.213462 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 21:08:37.220728 | 2025-03-02 21:08:37.220844 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-02 21:08:37.286787 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 21:08:37.295018 | 2025-03-02 21:08:37.295159 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-02 21:08:37.320990 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 21:08:37.327821 | 2025-03-02 21:08:37.327921 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-02 21:08:37.371824 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 21:08:37.387739 | 2025-03-02 21:08:37.387890 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-02 21:08:37.444122 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 21:08:37.460894 | 2025-03-02 21:08:37.461018 | TASK [emit-job-header : Print job information] 2025-03-02 21:08:37.521900 | # Job Information 2025-03-02 21:08:37.522137 | Ansible Version: 2.15.3 2025-03-02 21:08:37.522173 | Job: mypy 2025-03-02 21:08:37.522201 | Pipeline: check 2025-03-02 21:08:37.522222 | Executor: 7d211f194f6a 2025-03-02 21:08:37.522241 | Triggered by: https://github.com/osism/python-osism/pull/1210 2025-03-02 21:08:37.522259 | Event ID: 77a4ba40-f7aa-11ef-943a-495338cc7b8f 2025-03-02 21:08:37.530494 | 2025-03-02 21:08:37.530609 | LOOP [emit-job-header : Print node information] 2025-03-02 21:08:37.699727 | ubuntu-noble | ok: 2025-03-02 21:08:37.699884 | ubuntu-noble | # Node Information 2025-03-02 21:08:37.699915 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-02 21:08:37.699938 | ubuntu-noble | Hostname: ubuntu 2025-03-02 21:08:37.699958 | ubuntu-noble | Username: zuul 2025-03-02 21:08:37.699978 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-02 21:08:37.699996 | ubuntu-noble | Provider: regiocloud-a 2025-03-02 21:08:37.700014 | ubuntu-noble | Label: ubuntu-noble 2025-03-02 21:08:37.700033 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-02 21:08:37.700053 | ubuntu-noble | Interface IP: 81.163.193.54 2025-03-02 21:08:37.716464 | 2025-03-02 21:08:37.716574 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-02 21:08:38.169409 | ubuntu-noble -> localhost | changed 2025-03-02 21:08:38.182307 | 2025-03-02 21:08:38.182417 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-02 21:08:39.398700 | ubuntu-noble -> localhost | changed 2025-03-02 21:08:39.416325 | 2025-03-02 21:08:39.416452 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-02 21:08:39.869211 | ubuntu-noble -> localhost | ok 2025-03-02 21:08:39.875887 | 2025-03-02 21:08:39.875968 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-02 21:08:39.935141 | ubuntu-noble | ok 2025-03-02 21:08:39.970120 | ubuntu-noble | included: /var/lib/zuul/builds/37215f3e210c469fbeb9f0b00ee16d27/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-02 21:08:39.984644 | 2025-03-02 21:08:39.984740 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-02 21:08:40.470829 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-02 21:08:40.470988 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/37215f3e210c469fbeb9f0b00ee16d27/work/37215f3e210c469fbeb9f0b00ee16d27_id_rsa 2025-03-02 21:08:40.471017 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/37215f3e210c469fbeb9f0b00ee16d27/work/37215f3e210c469fbeb9f0b00ee16d27_id_rsa.pub 2025-03-02 21:08:40.471038 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-02 21:08:40.471056 | ubuntu-noble -> localhost | SHA256:FFwgPkShOj31twRjZq9nZSjFe3PbAfgnBSKqgeYc2BQ zuul-build-sshkey 2025-03-02 21:08:40.471075 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-02 21:08:40.471095 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-02 21:08:40.471113 | ubuntu-noble -> localhost | | E..=oo+.. . | 2025-03-02 21:08:40.471130 | ubuntu-noble -> localhost | | + .+ .oo. o . | 2025-03-02 21:08:40.471146 | ubuntu-noble -> localhost | | . =..+.B o. . . | 2025-03-02 21:08:40.471162 | ubuntu-noble -> localhost | | +o..oB = o. o | 2025-03-02 21:08:40.471177 | ubuntu-noble -> localhost | | ooo. S * =o.o | 2025-03-02 21:08:40.471193 | ubuntu-noble -> localhost | | . . = = ooo.| 2025-03-02 21:08:40.471209 | ubuntu-noble -> localhost | | . + . .| 2025-03-02 21:08:40.471225 | ubuntu-noble -> localhost | | o | 2025-03-02 21:08:40.471241 | ubuntu-noble -> localhost | | | 2025-03-02 21:08:40.471257 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-02 21:08:40.471296 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.051451 2025-03-02 21:08:40.477478 | 2025-03-02 21:08:40.477557 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-02 21:08:40.505815 | ubuntu-noble | ok 2025-03-02 21:08:40.515542 | ubuntu-noble | included: /var/lib/zuul/builds/37215f3e210c469fbeb9f0b00ee16d27/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-02 21:08:40.523695 | 2025-03-02 21:08:40.523771 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-02 21:08:40.538197 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 21:08:40.545300 | 2025-03-02 21:08:40.545402 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-02 21:08:41.259326 | ubuntu-noble | changed 2025-03-02 21:08:41.266700 | 2025-03-02 21:08:41.266794 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-02 21:08:41.567962 | ubuntu-noble | ok 2025-03-02 21:08:41.576894 | 2025-03-02 21:08:41.577001 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-02 21:08:42.324233 | ubuntu-noble | changed 2025-03-02 21:08:42.341262 | 2025-03-02 21:08:42.341523 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-02 21:08:43.048568 | ubuntu-noble | changed 2025-03-02 21:08:43.056228 | 2025-03-02 21:08:43.056326 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-02 21:08:43.080312 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 21:08:43.087601 | 2025-03-02 21:08:43.087690 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-02 21:08:43.484041 | ubuntu-noble -> localhost | changed 2025-03-02 21:08:43.499262 | 2025-03-02 21:08:43.499368 | TASK [add-build-sshkey : Add back temp key] 2025-03-02 21:08:43.777579 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/37215f3e210c469fbeb9f0b00ee16d27/work/37215f3e210c469fbeb9f0b00ee16d27_id_rsa (zuul-build-sshkey) 2025-03-02 21:08:43.777792 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.008406 2025-03-02 21:08:43.785245 | 2025-03-02 21:08:43.785337 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-02 21:08:44.234840 | ubuntu-noble | ok 2025-03-02 21:08:44.239957 | 2025-03-02 21:08:44.240032 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-02 21:08:44.287612 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 21:08:44.298891 | 2025-03-02 21:08:44.298996 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-02 21:08:44.726765 | ubuntu-noble | ok 2025-03-02 21:08:44.740748 | 2025-03-02 21:08:44.740845 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-02 21:08:44.781706 | ubuntu-noble | ok 2025-03-02 21:08:44.787774 | 2025-03-02 21:08:44.787862 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-02 21:08:45.035641 | ubuntu-noble -> localhost | ok 2025-03-02 21:08:45.056147 | 2025-03-02 21:08:45.056241 | TASK [validate-host : Collect information about the host] 2025-03-02 21:08:46.256686 | ubuntu-noble | ok 2025-03-02 21:08:46.274222 | 2025-03-02 21:08:46.274328 | TASK [validate-host : Sanitize hostname] 2025-03-02 21:08:46.334093 | ubuntu-noble | ok 2025-03-02 21:08:46.340422 | 2025-03-02 21:08:46.340526 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-02 21:08:46.818036 | ubuntu-noble -> localhost | changed 2025-03-02 21:08:46.823566 | 2025-03-02 21:08:46.823656 | TASK [validate-host : Collect information about zuul worker] 2025-03-02 21:08:47.277149 | ubuntu-noble | ok 2025-03-02 21:08:47.282142 | 2025-03-02 21:08:47.282219 | TASK [validate-host : Write out all zuul information for each host] 2025-03-02 21:08:47.745925 | ubuntu-noble -> localhost | changed 2025-03-02 21:08:47.759216 | 2025-03-02 21:08:47.759324 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-02 21:08:48.083027 | ubuntu-noble | ok 2025-03-02 21:08:48.089557 | 2025-03-02 21:08:48.089674 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-02 21:08:49.274182 | ubuntu-noble | changed: 2025-03-02 21:08:49.274455 | ubuntu-noble | cd+++++++++ src/ 2025-03-02 21:08:49.274506 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-02 21:08:49.274543 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-02 21:08:49.274575 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-03-02 21:08:49.274627 | ubuntu-noble | Containerfile 2025-03-02 21:08:49.274796 | ubuntu-noble | =2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-03-02 21:10:22.765201 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-03-02 21:10:22.791884 | ubuntu-noble | Downloading types_decorator-5.2.0.20250224-py3-none-any.whl (8.1 kB) 2025-03-02 21:10:22.812660 | ubuntu-noble | Downloading types_python_dateutil-2.9.0.20241206-py3-none-any.whl (14 kB) 2025-03-02 21:10:22.833209 | ubuntu-noble | Downloading types_pytz-2025.1.0.20250204-py3-none-any.whl (10 kB) 2025-03-02 21:10:22.852947 | ubuntu-noble | Downloading types_requests-2.32.0.20250301-py3-none-any.whl (20 kB) 2025-03-02 21:10:22.874799 | ubuntu-noble | Downloading types_simplejson-3.20.0.20250218-py3-none-any.whl (10 kB) 2025-03-02 21:10:22.894914 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-03-02 21:10:22.913518 | ubuntu-noble | Downloading types_ujson-5.10.0.20240515-py3-none-any.whl (2.8 kB) 2025-03-02 21:10:23.565437 | ubuntu-noble | Installing collected packages: types-ujson, types-tabulate, types-simplejson, types-requests, types-PyYAML, types-pytz, types-python-dateutil, types-decorator 2025-03-02 21:10:23.785288 | ubuntu-noble | Successfully installed types-PyYAML-6.0.12.20241230 types-decorator-5.2.0.20250224 types-python-dateutil-2.9.0.20241206 types-pytz-2025.1.0.20250204 types-requests-2.32.0.20250301 types-simplejson-3.20.0.20250218 types-tabulate-0.9.0.20241207 types-ujson-5.10.0.20240515 2025-03-02 21:10:32.755882 | ubuntu-noble | Installing missing stub packages: 2025-03-02 21:10:32.773869 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-python-dateutil types-pytz types-requests types-simplejson types-tabulate types-ujson 2025-03-02 21:10:32.773931 | ubuntu-noble | 2025-03-02 21:10:32.773949 | ubuntu-noble | 2025-03-02 21:10:32.773963 | ubuntu-noble | Success: no issues found in 55 source files 2025-03-02 21:10:32.982442 | ubuntu-noble | ok 2025-03-02 21:10:33.027063 | 2025-03-02 21:10:33.027180 | PLAY RECAP 2025-03-02 21:10:33.027252 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-03-02 21:10:33.027288 | 2025-03-02 21:10:33.166837 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-03-02 21:10:33.173772 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-02 21:10:33.923911 | 2025-03-02 21:10:33.924090 | PLAY [Base post] 2025-03-02 21:10:33.952454 | 2025-03-02 21:10:33.952586 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-03-02 21:10:34.592689 | ubuntu-noble | changed 2025-03-02 21:10:34.627573 | 2025-03-02 21:10:34.627731 | PLAY RECAP 2025-03-02 21:10:34.627804 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-03-02 21:10:34.627868 | 2025-03-02 21:10:34.755128 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-02 21:10:34.759084 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-03-02 21:10:35.562791 | 2025-03-02 21:10:35.562953 | PLAY [Base post-logs] 2025-03-02 21:10:35.579651 | 2025-03-02 21:10:35.579782 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-03-02 21:10:36.049697 | localhost | changed 2025-03-02 21:10:36.054649 | 2025-03-02 21:10:36.054807 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-03-02 21:10:36.084195 | localhost | ok 2025-03-02 21:10:36.092514 | 2025-03-02 21:10:36.092683 | TASK [Set zuul-log-path fact] 2025-03-02 21:10:36.110494 | localhost | ok 2025-03-02 21:10:36.124980 | 2025-03-02 21:10:36.125091 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-02 21:10:36.162803 | localhost | ok 2025-03-02 21:10:36.166290 | 2025-03-02 21:10:36.166402 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-02 21:10:36.200977 | localhost | skipping: Conditional result was False 2025-03-02 21:10:36.209512 | 2025-03-02 21:10:36.209725 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-02 21:10:36.260304 | localhost | skipping: Conditional result was False 2025-03-02 21:10:36.267850 | 2025-03-02 21:10:36.268027 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-02 21:10:36.294289 | localhost | skipping: Conditional result was False 2025-03-02 21:10:36.302713 | 2025-03-02 21:10:36.302901 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-02 21:10:36.328895 | localhost | skipping: Conditional result was False 2025-03-02 21:10:36.334921 | 2025-03-02 21:10:36.335070 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-02 21:10:36.360700 | localhost | skipping: Conditional result was False 2025-03-02 21:10:36.369917 | 2025-03-02 21:10:36.370056 | TASK [upload-logs : Create log directories] 2025-03-02 21:10:36.948782 | localhost | changed 2025-03-02 21:10:36.953457 | 2025-03-02 21:10:36.953569 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-03-02 21:10:37.457432 | localhost -> localhost | ok: Runtime: 0:00:00.006081 2025-03-02 21:10:37.462829 | 2025-03-02 21:10:37.462937 | TASK [upload-logs : Upload logs to log server] 2025-03-02 21:10:38.060848 | localhost | Output suppressed because no_log was given 2025-03-02 21:10:38.068668 | 2025-03-02 21:10:38.068781 | LOOP [upload-logs : Compress console log and json output] 2025-03-02 21:10:38.137017 | localhost | skipping: Conditional result was False 2025-03-02 21:10:38.156407 | localhost | skipping: Conditional result was False 2025-03-02 21:10:38.175564 | 2025-03-02 21:10:38.175983 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-02 21:10:38.264868 | localhost | skipping: Conditional result was False 2025-03-02 21:10:38.265234 | 2025-03-02 21:10:38.280730 | localhost | skipping: Conditional result was False 2025-03-02 21:10:38.301909 | 2025-03-02 21:10:38.302116 | LOOP [upload-logs : Upload console log and json output]