2025-03-02 01:09:42.969298 | Job console starting... 2025-03-02 01:09:42.988197 | Updating repositories 2025-03-02 01:09:43.022060 | Preparing job workspace 2025-03-02 01:09:45.953526 | Running Ansible setup... 2025-03-02 01:09:52.798838 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-02 01:09:53.484580 | 2025-03-02 01:09:53.484717 | PLAY [Base pre] 2025-03-02 01:09:53.511814 | 2025-03-02 01:09:53.511943 | TASK [Setup log path fact] 2025-03-02 01:09:53.553503 | ubuntu-noble | ok 2025-03-02 01:09:53.574390 | 2025-03-02 01:09:53.574524 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-02 01:09:53.674409 | ubuntu-noble | ok 2025-03-02 01:09:53.684845 | 2025-03-02 01:09:53.684944 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-02 01:09:53.759491 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 01:09:53.766549 | 2025-03-02 01:09:53.766644 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-02 01:09:53.865717 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 01:09:53.872937 | 2025-03-02 01:09:53.873044 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-02 01:09:53.924705 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 01:09:53.931696 | 2025-03-02 01:09:53.931795 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-02 01:09:53.985887 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 01:09:53.992785 | 2025-03-02 01:09:53.992877 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-02 01:09:54.036742 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 01:09:54.060685 | 2025-03-02 01:09:54.060802 | TASK [emit-job-header : Print job information] 2025-03-02 01:09:54.142522 | # Job Information 2025-03-02 01:09:54.142672 | Ansible Version: 2.15.3 2025-03-02 01:09:54.142702 | Job: mypy 2025-03-02 01:09:54.142730 | Pipeline: check 2025-03-02 01:09:54.142750 | Executor: 7d211f194f6a 2025-03-02 01:09:54.142769 | Triggered by: https://github.com/osism/openstack-simple-stress/pull/165 2025-03-02 01:09:54.142788 | Event ID: 007a43b0-f703-11ef-9464-1e9bf602beac 2025-03-02 01:09:54.160816 | 2025-03-02 01:09:54.160914 | LOOP [emit-job-header : Print node information] 2025-03-02 01:09:54.359787 | ubuntu-noble | ok: 2025-03-02 01:09:54.360004 | ubuntu-noble | # Node Information 2025-03-02 01:09:54.360041 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-02 01:09:54.360064 | ubuntu-noble | Hostname: ubuntu 2025-03-02 01:09:54.360085 | ubuntu-noble | Username: zuul 2025-03-02 01:09:54.360104 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-02 01:09:54.360123 | ubuntu-noble | Provider: regiocloud-a 2025-03-02 01:09:54.360153 | ubuntu-noble | Label: ubuntu-noble 2025-03-02 01:09:54.360172 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-02 01:09:54.360192 | ubuntu-noble | Interface IP: 81.163.193.91 2025-03-02 01:09:54.381117 | 2025-03-02 01:09:54.381240 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-02 01:09:55.022460 | ubuntu-noble -> localhost | changed 2025-03-02 01:09:55.029811 | 2025-03-02 01:09:55.029900 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-02 01:09:56.489287 | ubuntu-noble -> localhost | changed 2025-03-02 01:09:56.501995 | 2025-03-02 01:09:56.502074 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-02 01:09:56.829810 | ubuntu-noble -> localhost | ok 2025-03-02 01:09:56.835841 | 2025-03-02 01:09:56.835921 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-02 01:09:56.885346 | ubuntu-noble | ok 2025-03-02 01:09:56.928244 | ubuntu-noble | included: /var/lib/zuul/builds/e0561178851e46e7b9c34297d9171f6d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-02 01:09:56.945039 | 2025-03-02 01:09:56.945153 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-02 01:09:58.076851 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-02 01:09:58.077058 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/e0561178851e46e7b9c34297d9171f6d/work/e0561178851e46e7b9c34297d9171f6d_id_rsa 2025-03-02 01:09:58.077091 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/e0561178851e46e7b9c34297d9171f6d/work/e0561178851e46e7b9c34297d9171f6d_id_rsa.pub 2025-03-02 01:09:58.077112 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-02 01:09:58.077156 | ubuntu-noble -> localhost | SHA256:90ySh+VGrNx3E7pSZ8EvRc6Ptp3R7qJY4MzKItBIqFM zuul-build-sshkey 2025-03-02 01:09:58.077177 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-02 01:09:58.077197 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-02 01:09:58.077215 | ubuntu-noble -> localhost | | .| 2025-03-02 01:09:58.077232 | ubuntu-noble -> localhost | | . .+ | 2025-03-02 01:09:58.077248 | ubuntu-noble -> localhost | | . + ++| 2025-03-02 01:09:58.077263 | ubuntu-noble -> localhost | |. E . O .o*| 2025-03-02 01:09:58.077278 | ubuntu-noble -> localhost | |.o o S O *o===| 2025-03-02 01:09:58.077293 | ubuntu-noble -> localhost | |o o . = O.o+*+| 2025-03-02 01:09:58.077308 | ubuntu-noble -> localhost | | . . +.+...o| 2025-03-02 01:09:58.077324 | ubuntu-noble -> localhost | | . .. . o. .. | 2025-03-02 01:09:58.077340 | ubuntu-noble -> localhost | | . .o . .. ..| 2025-03-02 01:09:58.077355 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-02 01:09:58.077400 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.439345 2025-03-02 01:09:58.087766 | 2025-03-02 01:09:58.087858 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-02 01:09:58.129833 | ubuntu-noble | ok 2025-03-02 01:09:58.142746 | ubuntu-noble | included: /var/lib/zuul/builds/e0561178851e46e7b9c34297d9171f6d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-02 01:09:58.157838 | 2025-03-02 01:09:58.157912 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-02 01:09:58.179217 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 01:09:58.184977 | 2025-03-02 01:09:58.185050 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-02 01:09:58.996439 | ubuntu-noble | changed 2025-03-02 01:09:59.007813 | 2025-03-02 01:09:59.007919 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-02 01:09:59.299290 | ubuntu-noble | ok 2025-03-02 01:09:59.308234 | 2025-03-02 01:09:59.308346 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-02 01:10:00.094115 | ubuntu-noble | changed 2025-03-02 01:10:00.103077 | 2025-03-02 01:10:00.103217 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-02 01:10:00.818283 | ubuntu-noble | changed 2025-03-02 01:10:00.830328 | 2025-03-02 01:10:00.830466 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-02 01:10:00.856922 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 01:10:00.872488 | 2025-03-02 01:10:00.872638 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-02 01:10:01.325421 | ubuntu-noble -> localhost | changed 2025-03-02 01:10:01.337171 | 2025-03-02 01:10:01.337258 | TASK [add-build-sshkey : Add back temp key] 2025-03-02 01:10:01.699904 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/e0561178851e46e7b9c34297d9171f6d/work/e0561178851e46e7b9c34297d9171f6d_id_rsa (zuul-build-sshkey) 2025-03-02 01:10:01.700038 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009086 2025-03-02 01:10:01.705589 | 2025-03-02 01:10:01.705665 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-02 01:10:02.109555 | ubuntu-noble | ok 2025-03-02 01:10:02.121388 | 2025-03-02 01:10:02.121477 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-02 01:10:02.154396 | ubuntu-noble | skipping: Conditional result was False 2025-03-02 01:10:02.183821 | 2025-03-02 01:10:02.183937 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-02 01:10:02.592888 | ubuntu-noble | ok 2025-03-02 01:10:02.605006 | 2025-03-02 01:10:02.605101 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-02 01:10:02.635839 | ubuntu-noble | ok 2025-03-02 01:10:02.642137 | 2025-03-02 01:10:02.642231 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-02 01:10:02.902175 | ubuntu-noble -> localhost | ok 2025-03-02 01:10:02.909758 | 2025-03-02 01:10:02.909854 | TASK [validate-host : Collect information about the host] 2025-03-02 01:10:04.168002 | ubuntu-noble | ok 2025-03-02 01:10:04.184643 | 2025-03-02 01:10:04.184739 | TASK [validate-host : Sanitize hostname] 2025-03-02 01:10:04.256685 | ubuntu-noble | ok 2025-03-02 01:10:04.263446 | 2025-03-02 01:10:04.263538 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-02 01:10:04.876079 | ubuntu-noble -> localhost | changed 2025-03-02 01:10:04.882405 | 2025-03-02 01:10:04.882497 | TASK [validate-host : Collect information about zuul worker] 2025-03-02 01:10:05.337684 | ubuntu-noble | ok 2025-03-02 01:10:05.342898 | 2025-03-02 01:10:05.342979 | TASK [validate-host : Write out all zuul information for each host] 2025-03-02 01:10:05.844749 | ubuntu-noble -> localhost | changed 2025-03-02 01:10:05.858455 | 2025-03-02 01:10:05.858565 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-02 01:10:06.182965 | ubuntu-noble | ok 2025-03-02 01:10:06.200777 | 2025-03-02 01:10:06.200897 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-02 01:10:07.217040 | ubuntu-noble | changed: 2025-03-02 01:10:07.217212 | ubuntu-noble | cd+++++++++ src/ 2025-03-02 01:10:07.217245 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-02 01:10:07.217268 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-02 01:10:07.217290 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2025-03-02 01:10:07.217309 | ubuntu-noble | =2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-03-02 01:11:09.065969 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-03-02 01:11:09.088339 | ubuntu-noble | Downloading types_decorator-5.2.0.20250224-py3-none-any.whl (8.1 kB) 2025-03-02 01:11:09.110530 | ubuntu-noble | Downloading types_requests-2.32.0.20250301-py3-none-any.whl (20 kB) 2025-03-02 01:11:09.134363 | ubuntu-noble | Downloading types_simplejson-3.20.0.20250218-py3-none-any.whl (10 kB) 2025-03-02 01:11:09.420379 | ubuntu-noble | Installing collected packages: types-simplejson, types-requests, types-PyYAML, types-decorator 2025-03-02 01:11:09.508681 | ubuntu-noble | Successfully installed types-PyYAML-6.0.12.20241230 types-decorator-5.2.0.20250224 types-requests-2.32.0.20250301 types-simplejson-3.20.0.20250218 2025-03-02 01:11:14.450727 | ubuntu-noble | Installing missing stub packages: 2025-03-02 01:11:14.469629 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-requests types-simplejson 2025-03-02 01:11:14.469747 | ubuntu-noble | 2025-03-02 01:11:14.469767 | ubuntu-noble | 2025-03-02 01:11:14.469781 | ubuntu-noble | Success: no issues found in 5 source files 2025-03-02 01:11:14.852170 | ubuntu-noble | ok 2025-03-02 01:11:14.896572 | 2025-03-02 01:11:14.896711 | PLAY RECAP 2025-03-02 01:11:14.896773 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-03-02 01:11:14.896801 | 2025-03-02 01:11:15.045178 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-03-02 01:11:15.051607 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-02 01:11:15.760209 | 2025-03-02 01:11:15.760361 | PLAY [Base post] 2025-03-02 01:11:15.786797 | 2025-03-02 01:11:15.786921 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-03-02 01:11:16.442583 | ubuntu-noble | changed 2025-03-02 01:11:16.477056 | 2025-03-02 01:11:16.477183 | PLAY RECAP 2025-03-02 01:11:16.477250 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-03-02 01:11:16.477318 | 2025-03-02 01:11:16.596254 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-02 01:11:16.599459 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-03-02 01:11:17.371394 | 2025-03-02 01:11:17.371577 | PLAY [Base post-logs] 2025-03-02 01:11:17.389044 | 2025-03-02 01:11:17.389205 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-03-02 01:11:17.878074 | localhost | changed 2025-03-02 01:11:17.882099 | 2025-03-02 01:11:17.882276 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-03-02 01:11:17.923777 | localhost | ok 2025-03-02 01:11:17.934750 | 2025-03-02 01:11:17.934890 | TASK [Set zuul-log-path fact] 2025-03-02 01:11:17.964448 | localhost | ok 2025-03-02 01:11:17.979868 | 2025-03-02 01:11:17.979989 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-02 01:11:18.032431 | localhost | ok 2025-03-02 01:11:18.038053 | 2025-03-02 01:11:18.038215 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-02 01:11:18.084766 | localhost | skipping: Conditional result was False 2025-03-02 01:11:18.094694 | 2025-03-02 01:11:18.094877 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-02 01:11:18.154664 | localhost | skipping: Conditional result was False 2025-03-02 01:11:18.163102 | 2025-03-02 01:11:18.163295 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-02 01:11:18.189665 | localhost | skipping: Conditional result was False 2025-03-02 01:11:18.198589 | 2025-03-02 01:11:18.198702 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-02 01:11:18.233344 | localhost | skipping: Conditional result was False 2025-03-02 01:11:18.240153 | 2025-03-02 01:11:18.240302 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-02 01:11:18.266297 | localhost | skipping: Conditional result was False 2025-03-02 01:11:18.278459 | 2025-03-02 01:11:18.278611 | TASK [upload-logs : Create log directories] 2025-03-02 01:11:18.841226 | localhost | changed 2025-03-02 01:11:18.847408 | 2025-03-02 01:11:18.847535 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-03-02 01:11:19.373591 | localhost -> localhost | ok: Runtime: 0:00:00.007624 2025-03-02 01:11:19.386172 | 2025-03-02 01:11:19.386341 | TASK [upload-logs : Upload logs to log server] 2025-03-02 01:11:19.993749 | localhost | Output suppressed because no_log was given 2025-03-02 01:11:19.999663 | 2025-03-02 01:11:19.999815 | LOOP [upload-logs : Compress console log and json output] 2025-03-02 01:11:20.070906 | localhost | skipping: Conditional result was False 2025-03-02 01:11:20.088375 | localhost | skipping: Conditional result was False 2025-03-02 01:11:20.099039 | 2025-03-02 01:11:20.099312 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-02 01:11:20.181320 | localhost | skipping: Conditional result was False 2025-03-02 01:11:20.181959 | 2025-03-02 01:11:20.194193 | localhost | skipping: Conditional result was False 2025-03-02 01:11:20.215827 | 2025-03-02 01:11:20.216094 | LOOP [upload-logs : Upload console log and json output]