2025-02-21 18:31:06.135356 | Job console starting... 2025-02-21 18:31:06.158945 | Updating repositories 2025-02-21 18:31:11.614413 | Preparing job workspace 2025-02-21 18:31:13.641917 | Running Ansible setup... 2025-02-21 18:31:21.354375 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-21 18:31:22.050522 | 2025-02-21 18:31:22.050652 | PLAY [Base pre] 2025-02-21 18:31:22.078394 | 2025-02-21 18:31:22.078526 | TASK [Setup log path fact] 2025-02-21 18:31:22.118436 | ubuntu-noble | ok 2025-02-21 18:31:22.151000 | 2025-02-21 18:31:22.151156 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-21 18:31:22.214165 | ubuntu-noble | ok 2025-02-21 18:31:22.221042 | 2025-02-21 18:31:22.221150 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-21 18:31:22.255334 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:22.277186 | 2025-02-21 18:31:22.277348 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-21 18:31:22.370215 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:22.389605 | 2025-02-21 18:31:22.389726 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-21 18:31:22.419234 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:22.426419 | 2025-02-21 18:31:22.426555 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-21 18:31:22.462956 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:22.469151 | 2025-02-21 18:31:22.469241 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-21 18:31:22.492764 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:22.517293 | 2025-02-21 18:31:22.517389 | TASK [emit-job-header : Print job information] 2025-02-21 18:31:22.608853 | # Job Information 2025-02-21 18:31:22.608984 | Ansible Version: 2.15.3 2025-02-21 18:31:22.609010 | Job: mypy 2025-02-21 18:31:22.609035 | Pipeline: check 2025-02-21 18:31:22.609053 | Executor: 7d211f194f6a 2025-02-21 18:31:22.609069 | Triggered by: https://github.com/osism/openstack-simple-stress/pull/159 2025-02-21 18:31:22.609084 | Event ID: f96c0c70-f081-11ef-91e9-bc30a788c73f 2025-02-21 18:31:22.618594 | 2025-02-21 18:31:22.618692 | LOOP [emit-job-header : Print node information] 2025-02-21 18:31:22.858792 | ubuntu-noble | ok: 2025-02-21 18:31:22.859044 | ubuntu-noble | # Node Information 2025-02-21 18:31:22.859080 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-21 18:31:22.859102 | ubuntu-noble | Hostname: ubuntu 2025-02-21 18:31:22.859120 | ubuntu-noble | Username: zuul 2025-02-21 18:31:22.859137 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-21 18:31:22.859154 | ubuntu-noble | Provider: regiocloud-a 2025-02-21 18:31:22.859170 | ubuntu-noble | Label: ubuntu-noble 2025-02-21 18:31:22.859186 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-21 18:31:22.859202 | ubuntu-noble | Interface IP: 81.163.193.101 2025-02-21 18:31:22.888095 | 2025-02-21 18:31:22.888194 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-21 18:31:23.985171 | ubuntu-noble -> localhost | changed 2025-02-21 18:31:23.992018 | 2025-02-21 18:31:23.992104 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-21 18:31:26.233711 | ubuntu-noble -> localhost | changed 2025-02-21 18:31:26.259031 | 2025-02-21 18:31:26.259126 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-21 18:31:27.205458 | ubuntu-noble -> localhost | ok 2025-02-21 18:31:27.211337 | 2025-02-21 18:31:27.211414 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-21 18:31:27.253862 | ubuntu-noble | ok 2025-02-21 18:31:27.288859 | ubuntu-noble | included: /var/lib/zuul/builds/dee0a6bb40614b81a42b82d906e9f2cd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-21 18:31:27.295258 | 2025-02-21 18:31:27.295331 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-21 18:31:29.060341 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-21 18:31:29.060558 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/dee0a6bb40614b81a42b82d906e9f2cd/work/dee0a6bb40614b81a42b82d906e9f2cd_id_rsa 2025-02-21 18:31:29.060590 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/dee0a6bb40614b81a42b82d906e9f2cd/work/dee0a6bb40614b81a42b82d906e9f2cd_id_rsa.pub 2025-02-21 18:31:29.060611 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-21 18:31:29.060631 | ubuntu-noble -> localhost | SHA256:m3LFqHokNZPS1/FlOWvFlA8u5Q1gg7AuDTaaO4tRLak zuul-build-sshkey 2025-02-21 18:31:29.060650 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-21 18:31:29.060671 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-21 18:31:29.060689 | ubuntu-noble -> localhost | | .. .+. +o| 2025-02-21 18:31:29.060706 | ubuntu-noble -> localhost | | .o. .O.o| 2025-02-21 18:31:29.060722 | ubuntu-noble -> localhost | | .+... o * B.| 2025-02-21 18:31:29.060738 | ubuntu-noble -> localhost | | .**=.o. o = o| 2025-02-21 18:31:29.060754 | ubuntu-noble -> localhost | | *oo+S o o | 2025-02-21 18:31:29.060770 | ubuntu-noble -> localhost | | o.o.o + | 2025-02-21 18:31:29.060786 | ubuntu-noble -> localhost | | E ooo + | 2025-02-21 18:31:29.060803 | ubuntu-noble -> localhost | | o +.o | 2025-02-21 18:31:29.060819 | ubuntu-noble -> localhost | | . o. | 2025-02-21 18:31:29.060835 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-21 18:31:29.060875 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.753921 2025-02-21 18:31:29.066922 | 2025-02-21 18:31:29.067002 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-21 18:31:29.095621 | ubuntu-noble | ok 2025-02-21 18:31:29.121622 | ubuntu-noble | included: /var/lib/zuul/builds/dee0a6bb40614b81a42b82d906e9f2cd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-21 18:31:29.150064 | 2025-02-21 18:31:29.150165 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-21 18:31:29.184532 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:29.193927 | 2025-02-21 18:31:29.194013 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-21 18:31:30.312670 | ubuntu-noble | changed 2025-02-21 18:31:30.321319 | 2025-02-21 18:31:30.321413 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-21 18:31:30.712914 | ubuntu-noble | ok 2025-02-21 18:31:30.725794 | 2025-02-21 18:31:30.725895 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-21 18:31:31.598409 | ubuntu-noble | changed 2025-02-21 18:31:31.607755 | 2025-02-21 18:31:31.607849 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-21 18:31:32.487302 | ubuntu-noble | changed 2025-02-21 18:31:32.493688 | 2025-02-21 18:31:32.493761 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-21 18:31:32.548068 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:32.554389 | 2025-02-21 18:31:32.554493 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-21 18:31:33.147624 | ubuntu-noble -> localhost | changed 2025-02-21 18:31:33.162734 | 2025-02-21 18:31:33.163011 | TASK [add-build-sshkey : Add back temp key] 2025-02-21 18:31:33.530930 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/dee0a6bb40614b81a42b82d906e9f2cd/work/dee0a6bb40614b81a42b82d906e9f2cd_id_rsa (zuul-build-sshkey) 2025-02-21 18:31:33.531098 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.010271 2025-02-21 18:31:33.538012 | 2025-02-21 18:31:33.538094 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-21 18:31:33.960297 | ubuntu-noble | ok 2025-02-21 18:31:33.965797 | 2025-02-21 18:31:33.965876 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-21 18:31:34.036740 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:34.049266 | 2025-02-21 18:31:34.049380 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-21 18:31:34.542502 | ubuntu-noble | ok 2025-02-21 18:31:34.557402 | 2025-02-21 18:31:34.557515 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-21 18:31:34.593293 | ubuntu-noble | ok 2025-02-21 18:31:34.601532 | 2025-02-21 18:31:34.601621 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-21 18:31:34.904874 | ubuntu-noble -> localhost | ok 2025-02-21 18:31:34.913697 | 2025-02-21 18:31:34.913932 | TASK [validate-host : Collect information about the host] 2025-02-21 18:31:36.114826 | ubuntu-noble | ok 2025-02-21 18:31:36.143649 | 2025-02-21 18:31:36.143766 | TASK [validate-host : Sanitize hostname] 2025-02-21 18:31:36.217696 | ubuntu-noble | ok 2025-02-21 18:31:36.225623 | 2025-02-21 18:31:36.225725 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-21 18:31:37.147753 | ubuntu-noble -> localhost | changed 2025-02-21 18:31:37.155392 | 2025-02-21 18:31:37.155494 | TASK [validate-host : Collect information about zuul worker] 2025-02-21 18:31:37.811623 | ubuntu-noble | ok 2025-02-21 18:31:37.818803 | 2025-02-21 18:31:37.818903 | TASK [validate-host : Write out all zuul information for each host] 2025-02-21 18:31:38.971139 | ubuntu-noble -> localhost | changed 2025-02-21 18:31:38.984043 | 2025-02-21 18:31:38.984142 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-21 18:31:39.369047 | ubuntu-noble | ok 2025-02-21 18:31:39.377768 | 2025-02-21 18:31:39.377864 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-21 18:31:40.206344 | ubuntu-noble | changed: 2025-02-21 18:31:40.206520 | ubuntu-noble | cd+++++++++ src/ 2025-02-21 18:31:40.206553 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-21 18:31:40.206577 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-21 18:31:40.206598 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2025-02-21 18:31:40.206619 | ubuntu-noble | =2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-02-21 18:32:55.595471 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-02-21 18:32:55.626774 | ubuntu-noble | Downloading types_decorator-5.1.8.20250215-py3-none-any.whl (8.1 kB) 2025-02-21 18:32:55.653249 | ubuntu-noble | Downloading types_requests-2.32.0.20241016-py3-none-any.whl (15 kB) 2025-02-21 18:32:55.683013 | ubuntu-noble | Downloading types_simplejson-3.20.0.20250218-py3-none-any.whl (10 kB) 2025-02-21 18:32:56.049168 | ubuntu-noble | Installing collected packages: types-simplejson, types-requests, types-PyYAML, types-decorator 2025-02-21 18:32:56.158666 | ubuntu-noble | Successfully installed types-PyYAML-6.0.12.20241230 types-decorator-5.1.8.20250215 types-requests-2.32.0.20241016 types-simplejson-3.20.0.20250218 2025-02-21 18:33:00.794134 | ubuntu-noble | Installing missing stub packages: 2025-02-21 18:33:00.814315 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-requests types-simplejson 2025-02-21 18:33:00.814389 | ubuntu-noble | 2025-02-21 18:33:00.814396 | ubuntu-noble | 2025-02-21 18:33:00.814409 | ubuntu-noble | Success: no issues found in 5 source files 2025-02-21 18:33:01.268567 | ubuntu-noble | ok 2025-02-21 18:33:01.310707 | 2025-02-21 18:33:01.310795 | PLAY RECAP 2025-02-21 18:33:01.310848 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-02-21 18:33:01.310874 | 2025-02-21 18:33:01.425171 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-02-21 18:33:01.427647 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-02-21 18:33:02.182666 | 2025-02-21 18:33:02.182792 | PLAY [Base post] 2025-02-21 18:33:02.208181 | 2025-02-21 18:33:02.208297 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-02-21 18:33:02.934485 | ubuntu-noble | changed 2025-02-21 18:33:02.968549 | 2025-02-21 18:33:02.968661 | PLAY RECAP 2025-02-21 18:33:02.968722 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-02-21 18:33:02.968782 | 2025-02-21 18:33:03.068359 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-02-21 18:33:03.076866 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-02-21 18:33:03.894361 | 2025-02-21 18:33:03.894538 | PLAY [Base post-logs] 2025-02-21 18:33:03.917786 | 2025-02-21 18:33:03.917936 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-02-21 18:33:04.388869 | localhost | changed 2025-02-21 18:33:04.393635 | 2025-02-21 18:33:04.393771 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-02-21 18:33:04.421091 | localhost | ok 2025-02-21 18:33:04.427122 | 2025-02-21 18:33:04.427219 | TASK [Set zuul-log-path fact] 2025-02-21 18:33:04.465574 | localhost | ok 2025-02-21 18:33:04.480906 | 2025-02-21 18:33:04.481036 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-21 18:33:04.533586 | localhost | ok 2025-02-21 18:33:04.536777 | 2025-02-21 18:33:04.536899 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-21 18:33:04.603940 | localhost | skipping: Conditional result was False 2025-02-21 18:33:04.607813 | 2025-02-21 18:33:04.609734 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-21 18:33:04.716459 | localhost | skipping: Conditional result was False 2025-02-21 18:33:04.720882 | 2025-02-21 18:33:04.721002 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-21 18:33:04.746839 | localhost | skipping: Conditional result was False 2025-02-21 18:33:04.750670 | 2025-02-21 18:33:04.750794 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-21 18:33:04.776209 | localhost | skipping: Conditional result was False 2025-02-21 18:33:04.785043 | 2025-02-21 18:33:04.785240 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-21 18:33:04.821681 | localhost | skipping: Conditional result was False 2025-02-21 18:33:04.829819 | 2025-02-21 18:33:04.829956 | TASK [upload-logs : Create log directories] 2025-02-21 18:33:05.502240 | localhost | changed 2025-02-21 18:33:05.509159 | 2025-02-21 18:33:05.509282 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-02-21 18:33:06.230921 | localhost -> localhost | ok: Runtime: 0:00:00.006214 2025-02-21 18:33:06.236927 | 2025-02-21 18:33:06.237044 | TASK [upload-logs : Upload logs to log server] 2025-02-21 18:33:06.872789 | localhost | Output suppressed because no_log was given 2025-02-21 18:33:06.876886 | 2025-02-21 18:33:06.877002 | LOOP [upload-logs : Compress console log and json output] 2025-02-21 18:33:06.947610 | localhost | skipping: Conditional result was False 2025-02-21 18:33:06.966906 | localhost | skipping: Conditional result was False 2025-02-21 18:33:06.980635 | 2025-02-21 18:33:06.980796 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-21 18:33:07.056196 | localhost | skipping: Conditional result was False 2025-02-21 18:33:07.056989 | 2025-02-21 18:33:07.068659 | localhost | skipping: Conditional result was False 2025-02-21 18:33:07.081727 | 2025-02-21 18:33:07.082011 | LOOP [upload-logs : Upload console log and json output]