2025-02-27 15:58:09.969783 | Job console starting... 2025-02-27 15:58:09.998362 | Updating repositories 2025-02-27 15:58:10.039891 | Preparing job workspace 2025-02-27 15:58:12.193646 | Running Ansible setup... 2025-02-27 15:58:17.335993 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-27 15:58:18.145586 | 2025-02-27 15:58:18.145711 | PLAY [Base pre] 2025-02-27 15:58:18.173158 | 2025-02-27 15:58:18.173283 | TASK [Setup log path fact] 2025-02-27 15:58:18.224106 | ubuntu-noble | ok 2025-02-27 15:58:18.260377 | 2025-02-27 15:58:18.260549 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-27 15:58:18.300562 | ubuntu-noble | ok 2025-02-27 15:58:18.306989 | 2025-02-27 15:58:18.307111 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-27 15:58:18.370898 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 15:58:18.377869 | 2025-02-27 15:58:18.377980 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-27 15:58:18.473232 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 15:58:18.480327 | 2025-02-27 15:58:18.480488 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-27 15:58:18.535172 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 15:58:18.542109 | 2025-02-27 15:58:18.542207 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-27 15:58:18.583350 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 15:58:18.590481 | 2025-02-27 15:58:18.590585 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-27 15:58:18.644813 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 15:58:18.670876 | 2025-02-27 15:58:18.670991 | TASK [emit-job-header : Print job information] 2025-02-27 15:58:18.763865 | # Job Information 2025-02-27 15:58:18.764021 | Ansible Version: 2.15.3 2025-02-27 15:58:18.764051 | Job: mypy 2025-02-27 15:58:18.764080 | Pipeline: check 2025-02-27 15:58:18.764100 | Executor: 7d211f194f6a 2025-02-27 15:58:18.764119 | Triggered by: https://github.com/osism/python-osism/pull/1208 2025-02-27 15:58:18.764137 | Event ID: 9f850490-f523-11ef-81de-5e508f14265a 2025-02-27 15:58:18.779600 | 2025-02-27 15:58:18.779716 | LOOP [emit-job-header : Print node information] 2025-02-27 15:58:19.048348 | ubuntu-noble | ok: 2025-02-27 15:58:19.048588 | ubuntu-noble | # Node Information 2025-02-27 15:58:19.048626 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-27 15:58:19.048651 | ubuntu-noble | Hostname: ubuntu 2025-02-27 15:58:19.048673 | ubuntu-noble | Username: zuul 2025-02-27 15:58:19.048693 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-27 15:58:19.048712 | ubuntu-noble | Provider: regiocloud-a 2025-02-27 15:58:19.048731 | ubuntu-noble | Label: ubuntu-noble 2025-02-27 15:58:19.048749 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-27 15:58:19.048769 | ubuntu-noble | Interface IP: 81.163.192.223 2025-02-27 15:58:19.081560 | 2025-02-27 15:58:19.081672 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-27 15:58:19.653974 | ubuntu-noble -> localhost | changed 2025-02-27 15:58:19.660579 | 2025-02-27 15:58:19.660662 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-27 15:58:21.030883 | ubuntu-noble -> localhost | changed 2025-02-27 15:58:21.041541 | 2025-02-27 15:58:21.041627 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-27 15:58:21.460147 | ubuntu-noble -> localhost | ok 2025-02-27 15:58:21.467135 | 2025-02-27 15:58:21.467225 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-27 15:58:21.515490 | ubuntu-noble | ok 2025-02-27 15:58:21.533234 | ubuntu-noble | included: /var/lib/zuul/builds/e7ef9b01f5814468ac95bae32a5908ce/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-27 15:58:21.555706 | 2025-02-27 15:58:21.555796 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-27 15:58:22.554927 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-27 15:58:22.555090 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/e7ef9b01f5814468ac95bae32a5908ce/work/e7ef9b01f5814468ac95bae32a5908ce_id_rsa 2025-02-27 15:58:22.555120 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/e7ef9b01f5814468ac95bae32a5908ce/work/e7ef9b01f5814468ac95bae32a5908ce_id_rsa.pub 2025-02-27 15:58:22.555140 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-27 15:58:22.555158 | ubuntu-noble -> localhost | SHA256:9i7X3VjEdBI1Gtlq2k4jp0/7+yYYsURqv1oqh+R6r8w zuul-build-sshkey 2025-02-27 15:58:22.555176 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-27 15:58:22.555197 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-27 15:58:22.555214 | ubuntu-noble -> localhost | | .++.| 2025-02-27 15:58:22.555231 | ubuntu-noble -> localhost | | ..+.+| 2025-02-27 15:58:22.555246 | ubuntu-noble -> localhost | | o ..+.| 2025-02-27 15:58:22.555261 | ubuntu-noble -> localhost | | o oo o| 2025-02-27 15:58:22.555276 | ubuntu-noble -> localhost | | S. o+o . | 2025-02-27 15:58:22.555292 | ubuntu-noble -> localhost | | ... o+= .| 2025-02-27 15:58:22.555307 | ubuntu-noble -> localhost | | o ...B*.+ | 2025-02-27 15:58:22.555323 | ubuntu-noble -> localhost | | o*.o+=.= o| 2025-02-27 15:58:22.555338 | ubuntu-noble -> localhost | | .oEB=..o.=+| 2025-02-27 15:58:22.555354 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-27 15:58:22.555392 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.450596 2025-02-27 15:58:22.562351 | 2025-02-27 15:58:22.562436 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-27 15:58:22.611081 | ubuntu-noble | ok 2025-02-27 15:58:22.620064 | ubuntu-noble | included: /var/lib/zuul/builds/e7ef9b01f5814468ac95bae32a5908ce/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-27 15:58:22.638039 | 2025-02-27 15:58:22.638119 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-27 15:58:22.688649 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 15:58:22.694642 | 2025-02-27 15:58:22.694724 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-27 15:58:23.442474 | ubuntu-noble | changed 2025-02-27 15:58:23.447972 | 2025-02-27 15:58:23.448050 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-27 15:58:23.779775 | ubuntu-noble | ok 2025-02-27 15:58:23.789160 | 2025-02-27 15:58:23.789263 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-27 15:58:24.595527 | ubuntu-noble | changed 2025-02-27 15:58:24.604891 | 2025-02-27 15:58:24.605018 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-27 15:58:25.423279 | ubuntu-noble | changed 2025-02-27 15:58:25.435988 | 2025-02-27 15:58:25.436246 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-27 15:58:25.461203 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 15:58:25.468596 | 2025-02-27 15:58:25.468688 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-27 15:58:25.843485 | ubuntu-noble -> localhost | changed 2025-02-27 15:58:25.855659 | 2025-02-27 15:58:25.855744 | TASK [add-build-sshkey : Add back temp key] 2025-02-27 15:58:26.202949 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/e7ef9b01f5814468ac95bae32a5908ce/work/e7ef9b01f5814468ac95bae32a5908ce_id_rsa (zuul-build-sshkey) 2025-02-27 15:58:26.203101 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.006706 2025-02-27 15:58:26.209727 | 2025-02-27 15:58:26.209807 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-27 15:58:26.701540 | ubuntu-noble | ok 2025-02-27 15:58:26.707978 | 2025-02-27 15:58:26.708072 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-27 15:58:26.741944 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 15:58:26.765235 | 2025-02-27 15:58:26.765346 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-27 15:58:27.265874 | ubuntu-noble | ok 2025-02-27 15:58:27.288089 | 2025-02-27 15:58:27.288188 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-27 15:58:27.316330 | ubuntu-noble | ok 2025-02-27 15:58:27.321588 | 2025-02-27 15:58:27.321666 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-27 15:58:27.662882 | ubuntu-noble -> localhost | ok 2025-02-27 15:58:27.670278 | 2025-02-27 15:58:27.670370 | TASK [validate-host : Collect information about the host] 2025-02-27 15:58:28.955378 | ubuntu-noble | ok 2025-02-27 15:58:28.966943 | 2025-02-27 15:58:28.967035 | TASK [validate-host : Sanitize hostname] 2025-02-27 15:58:29.060554 | ubuntu-noble | ok 2025-02-27 15:58:29.066795 | 2025-02-27 15:58:29.066882 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-27 15:58:29.596273 | ubuntu-noble -> localhost | changed 2025-02-27 15:58:29.603803 | 2025-02-27 15:58:29.603894 | TASK [validate-host : Collect information about zuul worker] 2025-02-27 15:58:30.083829 | ubuntu-noble | ok 2025-02-27 15:58:30.089895 | 2025-02-27 15:58:30.089987 | TASK [validate-host : Write out all zuul information for each host] 2025-02-27 15:58:30.612841 | ubuntu-noble -> localhost | changed 2025-02-27 15:58:30.625644 | 2025-02-27 15:58:30.625744 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-27 15:58:30.941521 | ubuntu-noble | ok 2025-02-27 15:58:30.949083 | 2025-02-27 15:58:30.949194 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-27 15:58:32.328875 | ubuntu-noble | changed: 2025-02-27 15:58:32.329080 | ubuntu-noble | cd+++++++++ src/ 2025-02-27 15:58:32.329113 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-27 15:58:32.329137 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-27 15:58:32.329158 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-02-27 15:58:32.329179 | ubuntu-noble | Containerfile 2025-02-27 15:58:32.329291 | ubuntu-noble | =2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-02-27 16:00:29.341202 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-02-27 16:00:29.367319 | ubuntu-noble | Downloading types_decorator-5.2.0.20250224-py3-none-any.whl (8.1 kB) 2025-02-27 16:00:29.392219 | ubuntu-noble | Downloading types_python_dateutil-2.9.0.20241206-py3-none-any.whl (14 kB) 2025-02-27 16:00:29.417921 | ubuntu-noble | Downloading types_pytz-2025.1.0.20250204-py3-none-any.whl (10 kB) 2025-02-27 16:00:29.444776 | ubuntu-noble | Downloading types_requests-2.32.0.20241016-py3-none-any.whl (15 kB) 2025-02-27 16:00:29.475123 | ubuntu-noble | Downloading types_simplejson-3.20.0.20250218-py3-none-any.whl (10 kB) 2025-02-27 16:00:29.501957 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-02-27 16:00:29.525914 | ubuntu-noble | Downloading types_ujson-5.10.0.20240515-py3-none-any.whl (2.8 kB) 2025-02-27 16:00:30.426028 | ubuntu-noble | Installing collected packages: types-ujson, types-tabulate, types-simplejson, types-requests, types-PyYAML, types-pytz, types-python-dateutil, types-decorator 2025-02-27 16:00:30.823345 | 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.20241016 types-simplejson-3.20.0.20250218 types-tabulate-0.9.0.20241207 types-ujson-5.10.0.20240515 2025-02-27 16:00:43.999823 | ubuntu-noble | Installing missing stub packages: 2025-02-27 16:00:44.022924 | 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-02-27 16:00:44.022975 | ubuntu-noble | 2025-02-27 16:00:44.022984 | ubuntu-noble | 2025-02-27 16:00:44.022992 | ubuntu-noble | Success: no issues found in 55 source files 2025-02-27 16:00:44.147742 | ubuntu-noble | ok 2025-02-27 16:00:44.207832 | 2025-02-27 16:00:44.207970 | PLAY RECAP 2025-02-27 16:00:44.208057 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-02-27 16:00:44.208098 | 2025-02-27 16:00:44.335397 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-02-27 16:00:44.338480 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-02-27 16:00:45.068852 | 2025-02-27 16:00:45.069752 | PLAY [Base post] 2025-02-27 16:00:45.095707 | 2025-02-27 16:00:45.095833 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-02-27 16:00:45.778503 | ubuntu-noble | changed 2025-02-27 16:00:45.811514 | 2025-02-27 16:00:45.811630 | PLAY RECAP 2025-02-27 16:00:45.811696 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-02-27 16:00:45.811758 | 2025-02-27 16:00:45.918836 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-02-27 16:00:45.925374 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-02-27 16:00:46.686404 | 2025-02-27 16:00:46.686577 | PLAY [Base post-logs] 2025-02-27 16:00:46.702625 | 2025-02-27 16:00:46.702756 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-02-27 16:00:47.152834 | localhost | changed 2025-02-27 16:00:47.156635 | 2025-02-27 16:00:47.156764 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-02-27 16:00:47.196359 | localhost | ok 2025-02-27 16:00:47.206774 | 2025-02-27 16:00:47.206922 | TASK [Set zuul-log-path fact] 2025-02-27 16:00:47.237862 | localhost | ok 2025-02-27 16:00:47.257048 | 2025-02-27 16:00:47.257306 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-27 16:00:47.309243 | localhost | ok 2025-02-27 16:00:47.316221 | 2025-02-27 16:00:47.316385 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-27 16:00:47.352598 | localhost | skipping: Conditional result was False 2025-02-27 16:00:47.361914 | 2025-02-27 16:00:47.362117 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-27 16:00:47.411263 | localhost | skipping: Conditional result was False 2025-02-27 16:00:47.421226 | 2025-02-27 16:00:47.421528 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-27 16:00:47.448541 | localhost | skipping: Conditional result was False 2025-02-27 16:00:47.457542 | 2025-02-27 16:00:47.457734 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-27 16:00:47.484162 | localhost | skipping: Conditional result was False 2025-02-27 16:00:47.494000 | 2025-02-27 16:00:47.494175 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-27 16:00:47.520381 | localhost | skipping: Conditional result was False 2025-02-27 16:00:47.534694 | 2025-02-27 16:00:47.534851 | TASK [upload-logs : Create log directories] 2025-02-27 16:00:48.028132 | localhost | changed 2025-02-27 16:00:48.037351 | 2025-02-27 16:00:48.037523 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-02-27 16:00:48.565091 | localhost -> localhost | ok: Runtime: 0:00:00.007139 2025-02-27 16:00:48.573099 | 2025-02-27 16:00:48.573247 | TASK [upload-logs : Upload logs to log server] 2025-02-27 16:00:49.167379 | localhost | Output suppressed because no_log was given 2025-02-27 16:00:49.173018 | 2025-02-27 16:00:49.173167 | LOOP [upload-logs : Compress console log and json output] 2025-02-27 16:00:49.241613 | localhost | skipping: Conditional result was False 2025-02-27 16:00:49.260763 | localhost | skipping: Conditional result was False 2025-02-27 16:00:49.279669 | 2025-02-27 16:00:49.279891 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-27 16:00:49.355069 | localhost | skipping: Conditional result was False 2025-02-27 16:00:49.355765 | 2025-02-27 16:00:49.368898 | localhost | skipping: Conditional result was False 2025-02-27 16:00:49.386813 | 2025-02-27 16:00:49.387002 | LOOP [upload-logs : Upload console log and json output]