2025-02-18 23:32:33.332172 | Job console starting... 2025-02-18 23:32:33.347120 | Updating repositories 2025-02-18 23:32:33.399255 | Preparing job workspace 2025-02-18 23:32:35.476803 | Running Ansible setup... 2025-02-18 23:32:41.284588 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-18 23:32:42.142009 | 2025-02-18 23:32:42.142150 | PLAY [Base pre] 2025-02-18 23:32:42.170274 | 2025-02-18 23:32:42.170402 | TASK [Setup log path fact] 2025-02-18 23:32:42.202150 | ubuntu-noble | ok 2025-02-18 23:32:42.235620 | 2025-02-18 23:32:42.235750 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-18 23:32:42.286109 | ubuntu-noble | ok 2025-02-18 23:32:42.293231 | 2025-02-18 23:32:42.293346 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-18 23:32:42.340861 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:42.347841 | 2025-02-18 23:32:42.347962 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-18 23:32:42.417654 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:42.424866 | 2025-02-18 23:32:42.424972 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-18 23:32:42.458879 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:42.465848 | 2025-02-18 23:32:42.465950 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-18 23:32:42.510134 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:42.517118 | 2025-02-18 23:32:42.517226 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-18 23:32:42.541022 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:42.562845 | 2025-02-18 23:32:42.562961 | TASK [emit-job-header : Print job information] 2025-02-18 23:32:42.688107 | # Job Information 2025-02-18 23:32:42.688285 | Ansible Version: 2.15.3 2025-02-18 23:32:42.688333 | Job: mypy 2025-02-18 23:32:42.688373 | Pipeline: check 2025-02-18 23:32:42.688450 | Executor: 7d211f194f6a 2025-02-18 23:32:42.688479 | Triggered by: https://github.com/osism/python-osism/pull/1200 2025-02-18 23:32:42.688505 | Event ID: 9bd4bea0-ee50-11ef-9c9c-0aabb8a8fae2 2025-02-18 23:32:42.696005 | 2025-02-18 23:32:42.696124 | LOOP [emit-job-header : Print node information] 2025-02-18 23:32:42.856175 | ubuntu-noble | ok: 2025-02-18 23:32:42.856336 | ubuntu-noble | # Node Information 2025-02-18 23:32:42.856369 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-18 23:32:42.856424 | ubuntu-noble | Hostname: ubuntu 2025-02-18 23:32:42.856447 | ubuntu-noble | Username: zuul 2025-02-18 23:32:42.856467 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-18 23:32:42.856487 | ubuntu-noble | Provider: regiocloud-a 2025-02-18 23:32:42.856507 | ubuntu-noble | Label: ubuntu-noble 2025-02-18 23:32:42.856526 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-18 23:32:42.856546 | ubuntu-noble | Interface IP: 81.163.193.244 2025-02-18 23:32:42.887658 | 2025-02-18 23:32:42.887771 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-18 23:32:43.710016 | ubuntu-noble -> localhost | changed 2025-02-18 23:32:43.718165 | 2025-02-18 23:32:43.718268 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-18 23:32:45.047912 | ubuntu-noble -> localhost | changed 2025-02-18 23:32:45.065635 | 2025-02-18 23:32:45.065740 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-18 23:32:45.489306 | ubuntu-noble -> localhost | ok 2025-02-18 23:32:45.496579 | 2025-02-18 23:32:45.496676 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-18 23:32:45.536485 | ubuntu-noble | ok 2025-02-18 23:32:45.553521 | ubuntu-noble | included: /var/lib/zuul/builds/72316abc7edf4d87aaba3d091d5f6789/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-18 23:32:45.561659 | 2025-02-18 23:32:45.561742 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-18 23:32:46.402982 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-18 23:32:46.403187 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/72316abc7edf4d87aaba3d091d5f6789/work/72316abc7edf4d87aaba3d091d5f6789_id_rsa 2025-02-18 23:32:46.403225 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/72316abc7edf4d87aaba3d091d5f6789/work/72316abc7edf4d87aaba3d091d5f6789_id_rsa.pub 2025-02-18 23:32:46.403250 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-18 23:32:46.403272 | ubuntu-noble -> localhost | SHA256:MBgNktU68xEQbNScOVfGy0PF+URQ120cOmlP1eKiQJw zuul-build-sshkey 2025-02-18 23:32:46.403294 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-18 23:32:46.403318 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-18 23:32:46.403340 | ubuntu-noble -> localhost | | .=BO + +ooo=ooB| 2025-02-18 23:32:46.403361 | ubuntu-noble -> localhost | | ..ooX E.o o =.B| 2025-02-18 23:32:46.403381 | ubuntu-noble -> localhost | | ...o= o . O + | 2025-02-18 23:32:46.403400 | ubuntu-noble -> localhost | | + .o. + o * | 2025-02-18 23:32:46.403420 | ubuntu-noble -> localhost | | + .S. o . . | 2025-02-18 23:32:46.403439 | ubuntu-noble -> localhost | | . . | 2025-02-18 23:32:46.403458 | ubuntu-noble -> localhost | | | 2025-02-18 23:32:46.403478 | ubuntu-noble -> localhost | | | 2025-02-18 23:32:46.403497 | ubuntu-noble -> localhost | | | 2025-02-18 23:32:46.403516 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-18 23:32:46.403560 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.092743 2025-02-18 23:32:46.411634 | 2025-02-18 23:32:46.411730 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-18 23:32:46.445663 | ubuntu-noble | ok 2025-02-18 23:32:46.457456 | ubuntu-noble | included: /var/lib/zuul/builds/72316abc7edf4d87aaba3d091d5f6789/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-18 23:32:46.466824 | 2025-02-18 23:32:46.466960 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-18 23:32:46.480529 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:46.490923 | 2025-02-18 23:32:46.491018 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-18 23:32:47.145561 | ubuntu-noble | changed 2025-02-18 23:32:47.162784 | 2025-02-18 23:32:47.163059 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-18 23:32:47.461401 | ubuntu-noble | ok 2025-02-18 23:32:47.471011 | 2025-02-18 23:32:47.471141 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-18 23:32:48.139832 | ubuntu-noble | changed 2025-02-18 23:32:48.146644 | 2025-02-18 23:32:48.146737 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-18 23:32:48.855202 | ubuntu-noble | changed 2025-02-18 23:32:48.876282 | 2025-02-18 23:32:48.876405 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-18 23:32:48.900013 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:48.907712 | 2025-02-18 23:32:48.907812 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-18 23:32:49.317718 | ubuntu-noble -> localhost | changed 2025-02-18 23:32:49.333554 | 2025-02-18 23:32:49.333668 | TASK [add-build-sshkey : Add back temp key] 2025-02-18 23:32:49.664712 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/72316abc7edf4d87aaba3d091d5f6789/work/72316abc7edf4d87aaba3d091d5f6789_id_rsa (zuul-build-sshkey) 2025-02-18 23:32:49.664911 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.008450 2025-02-18 23:32:49.697236 | 2025-02-18 23:32:49.697339 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-18 23:32:50.072871 | ubuntu-noble | ok 2025-02-18 23:32:50.088659 | 2025-02-18 23:32:50.088759 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-18 23:32:50.132987 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:50.145787 | 2025-02-18 23:32:50.145891 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-18 23:32:50.622179 | ubuntu-noble | ok 2025-02-18 23:32:50.638863 | 2025-02-18 23:32:50.638971 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-18 23:32:50.708656 | ubuntu-noble | ok 2025-02-18 23:32:50.714099 | 2025-02-18 23:32:50.714193 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-18 23:32:51.042216 | ubuntu-noble -> localhost | ok 2025-02-18 23:32:51.048475 | 2025-02-18 23:32:51.048561 | TASK [validate-host : Collect information about the host] 2025-02-18 23:32:52.219376 | ubuntu-noble | ok 2025-02-18 23:32:52.230421 | 2025-02-18 23:32:52.230506 | TASK [validate-host : Sanitize hostname] 2025-02-18 23:32:52.293737 | ubuntu-noble | ok 2025-02-18 23:32:52.309735 | 2025-02-18 23:32:52.309862 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-18 23:32:52.771854 | ubuntu-noble -> localhost | changed 2025-02-18 23:32:52.777516 | 2025-02-18 23:32:52.777601 | TASK [validate-host : Collect information about zuul worker] 2025-02-18 23:32:53.194749 | ubuntu-noble | ok 2025-02-18 23:32:53.199548 | 2025-02-18 23:32:53.199624 | TASK [validate-host : Write out all zuul information for each host] 2025-02-18 23:32:53.848800 | ubuntu-noble -> localhost | changed 2025-02-18 23:32:53.858598 | 2025-02-18 23:32:53.858682 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-18 23:32:54.203027 | ubuntu-noble | ok 2025-02-18 23:32:54.209687 | 2025-02-18 23:32:54.209784 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-18 23:32:55.399404 | ubuntu-noble | changed: 2025-02-18 23:32:55.399548 | ubuntu-noble | cd+++++++++ src/ 2025-02-18 23:32:55.399575 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-18 23:32:55.399595 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-18 23:32:55.399612 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-02-18 23:32:55.399628 | ubuntu-noble | Containerfile 2025-02-18 23:32:55.399718 | ubuntu-noble | =2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-02-18 23:34:30.939514 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-02-18 23:34:30.962703 | ubuntu-noble | Downloading types_decorator-5.1.8.20250215-py3-none-any.whl (8.1 kB) 2025-02-18 23:34:30.984517 | ubuntu-noble | Downloading types_python_dateutil-2.9.0.20241206-py3-none-any.whl (14 kB) 2025-02-18 23:34:31.007480 | ubuntu-noble | Downloading types_pytz-2025.1.0.20250204-py3-none-any.whl (10 kB) 2025-02-18 23:34:31.030202 | ubuntu-noble | Downloading types_requests-2.32.0.20241016-py3-none-any.whl (15 kB) 2025-02-18 23:34:31.053309 | ubuntu-noble | Downloading types_simplejson-3.20.0.20250218-py3-none-any.whl (10 kB) 2025-02-18 23:34:31.080239 | ubuntu-noble | Downloading types_tabulate-0.9.0.20241207-py3-none-any.whl (8.3 kB) 2025-02-18 23:34:31.105032 | ubuntu-noble | Downloading types_ujson-5.10.0.20240515-py3-none-any.whl (2.8 kB) 2025-02-18 23:34:31.786805 | ubuntu-noble | Installing collected packages: types-ujson, types-tabulate, types-simplejson, types-requests, types-PyYAML, types-pytz, types-python-dateutil, types-decorator 2025-02-18 23:34:32.047736 | ubuntu-noble | Successfully installed types-PyYAML-6.0.12.20241230 types-decorator-5.1.8.20250215 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-18 23:34:37.897616 | ubuntu-noble | Installing missing stub packages: 2025-02-18 23:34:37.914150 | 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-18 23:34:37.914178 | ubuntu-noble | 2025-02-18 23:34:37.914183 | ubuntu-noble | 2025-02-18 23:34:37.914187 | ubuntu-noble | Success: no issues found in 55 source files 2025-02-18 23:34:38.379418 | ubuntu-noble | ok 2025-02-18 23:34:38.423221 | 2025-02-18 23:34:38.423334 | PLAY RECAP 2025-02-18 23:34:38.423399 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-02-18 23:34:38.423427 | 2025-02-18 23:34:38.544654 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-02-18 23:34:38.552112 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-02-18 23:34:39.297532 | 2025-02-18 23:34:39.297686 | PLAY [Base post] 2025-02-18 23:34:39.323304 | 2025-02-18 23:34:39.323430 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-02-18 23:34:39.867474 | ubuntu-noble | changed 2025-02-18 23:34:39.902094 | 2025-02-18 23:34:39.902235 | PLAY RECAP 2025-02-18 23:34:39.902304 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-02-18 23:34:39.902366 | 2025-02-18 23:34:40.013557 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-02-18 23:34:40.019807 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-02-18 23:34:40.911340 | 2025-02-18 23:34:40.911598 | PLAY [Base post-logs] 2025-02-18 23:34:40.934028 | 2025-02-18 23:34:40.934189 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-02-18 23:34:41.380335 | localhost | changed 2025-02-18 23:34:41.384378 | 2025-02-18 23:34:41.384527 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-02-18 23:34:41.422531 | localhost | ok 2025-02-18 23:34:41.430311 | 2025-02-18 23:34:41.430430 | TASK [Set zuul-log-path fact] 2025-02-18 23:34:41.449705 | localhost | ok 2025-02-18 23:34:41.464130 | 2025-02-18 23:34:41.464347 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-18 23:34:41.516665 | localhost | ok 2025-02-18 23:34:41.522960 | 2025-02-18 23:34:41.523138 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-18 23:34:41.570430 | localhost | skipping: Conditional result was False 2025-02-18 23:34:41.579727 | 2025-02-18 23:34:41.579926 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-18 23:34:41.630136 | localhost | skipping: Conditional result was False 2025-02-18 23:34:41.639539 | 2025-02-18 23:34:41.639733 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-18 23:34:41.666802 | localhost | skipping: Conditional result was False 2025-02-18 23:34:41.676433 | 2025-02-18 23:34:41.676660 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-18 23:34:41.704555 | localhost | skipping: Conditional result was False 2025-02-18 23:34:41.714944 | 2025-02-18 23:34:41.715184 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-18 23:34:41.741566 | localhost | skipping: Conditional result was False 2025-02-18 23:34:41.756621 | 2025-02-18 23:34:41.756778 | TASK [upload-logs : Create log directories] 2025-02-18 23:34:42.294715 | localhost | changed 2025-02-18 23:34:42.302159 | 2025-02-18 23:34:42.302304 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-02-18 23:34:42.820163 | localhost -> localhost | ok: Runtime: 0:00:00.006886 2025-02-18 23:34:42.831673 | 2025-02-18 23:34:42.832231 | TASK [upload-logs : Upload logs to log server] 2025-02-18 23:34:43.445884 | localhost | Output suppressed because no_log was given 2025-02-18 23:34:43.451756 | 2025-02-18 23:34:43.451905 | LOOP [upload-logs : Compress console log and json output] 2025-02-18 23:34:43.527388 | localhost | skipping: Conditional result was False 2025-02-18 23:34:43.560194 | localhost | skipping: Conditional result was False 2025-02-18 23:34:43.571318 | 2025-02-18 23:34:43.571515 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-18 23:34:43.637851 | localhost | skipping: Conditional result was False 2025-02-18 23:34:43.638510 | 2025-02-18 23:34:43.650604 | localhost | skipping: Conditional result was False 2025-02-18 23:34:43.661587 | 2025-02-18 23:34:43.661787 | LOOP [upload-logs : Upload console log and json output]