2025-02-21 18:31:14.011899 | Job console starting... 2025-02-21 18:31:14.114668 | Updating repositories 2025-02-21 18:31:14.419586 | Preparing job workspace 2025-02-21 18:31:17.785138 | Running Ansible setup... 2025-02-21 18:31:26.376510 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-21 18:31:27.819258 | 2025-02-21 18:31:27.819374 | PLAY [Base pre] 2025-02-21 18:31:27.865464 | 2025-02-21 18:31:27.865576 | TASK [Setup log path fact] 2025-02-21 18:31:27.949089 | ubuntu-noble | ok 2025-02-21 18:31:28.009392 | 2025-02-21 18:31:28.009545 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-21 18:31:28.108622 | ubuntu-noble | ok 2025-02-21 18:31:28.114821 | 2025-02-21 18:31:28.114906 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-21 18:31:28.193981 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:28.200503 | 2025-02-21 18:31:28.200599 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-21 18:31:28.301780 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:28.308523 | 2025-02-21 18:31:28.308632 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-21 18:31:28.334419 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:28.340183 | 2025-02-21 18:31:28.340267 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-21 18:31:28.395526 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:28.401328 | 2025-02-21 18:31:28.401424 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-21 18:31:28.446423 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:28.466369 | 2025-02-21 18:31:28.466477 | TASK [emit-job-header : Print job information] 2025-02-21 18:31:28.576849 | # Job Information 2025-02-21 18:31:28.577065 | Ansible Version: 2.15.3 2025-02-21 18:31:28.577095 | Job: mypy 2025-02-21 18:31:28.577118 | Pipeline: check 2025-02-21 18:31:28.577135 | Executor: 7d211f194f6a 2025-02-21 18:31:28.577151 | Triggered by: https://github.com/osism/openstack-simple-stress/pull/160 2025-02-21 18:31:28.577166 | Event ID: fc9d7640-f081-11ef-833c-9be3e03dd3d0 2025-02-21 18:31:28.586636 | 2025-02-21 18:31:28.586730 | LOOP [emit-job-header : Print node information] 2025-02-21 18:31:28.994289 | ubuntu-noble | ok: 2025-02-21 18:31:28.994432 | ubuntu-noble | # Node Information 2025-02-21 18:31:28.994481 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-21 18:31:28.994501 | ubuntu-noble | Hostname: ubuntu 2025-02-21 18:31:28.994519 | ubuntu-noble | Username: zuul 2025-02-21 18:31:28.994535 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-21 18:31:28.994551 | ubuntu-noble | Provider: regiocloud-a 2025-02-21 18:31:28.994566 | ubuntu-noble | Label: ubuntu-noble 2025-02-21 18:31:28.994581 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-21 18:31:28.994598 | ubuntu-noble | Interface IP: 81.163.193.189 2025-02-21 18:31:29.010352 | 2025-02-21 18:31:29.010497 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-21 18:31:30.251598 | ubuntu-noble -> localhost | changed 2025-02-21 18:31:30.268230 | 2025-02-21 18:31:30.268315 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-21 18:31:32.735130 | ubuntu-noble -> localhost | changed 2025-02-21 18:31:32.748696 | 2025-02-21 18:31:32.748785 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-21 18:31:33.137407 | ubuntu-noble -> localhost | ok 2025-02-21 18:31:33.143377 | 2025-02-21 18:31:33.143489 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-21 18:31:33.171967 | ubuntu-noble | ok 2025-02-21 18:31:33.197449 | ubuntu-noble | included: /var/lib/zuul/builds/d17e9f24f4f744f08dcf7e3a41d675da/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-21 18:31:33.203863 | 2025-02-21 18:31:33.203947 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-21 18:31:33.765378 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-21 18:31:33.765665 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/d17e9f24f4f744f08dcf7e3a41d675da/work/d17e9f24f4f744f08dcf7e3a41d675da_id_rsa 2025-02-21 18:31:33.765723 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/d17e9f24f4f744f08dcf7e3a41d675da/work/d17e9f24f4f744f08dcf7e3a41d675da_id_rsa.pub 2025-02-21 18:31:33.765763 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-21 18:31:33.765802 | ubuntu-noble -> localhost | SHA256:GiIvMUCIwrx85uDeoh0D87API4/f2g9GDewwODrvq9s zuul-build-sshkey 2025-02-21 18:31:33.765839 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-21 18:31:33.765880 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-21 18:31:33.765915 | ubuntu-noble -> localhost | |=. | 2025-02-21 18:31:33.765948 | ubuntu-noble -> localhost | |=+ . | 2025-02-21 18:31:33.765980 | ubuntu-noble -> localhost | |* + o | 2025-02-21 18:31:33.766012 | ubuntu-noble -> localhost | |.* * o | 2025-02-21 18:31:33.766043 | ubuntu-noble -> localhost | |B O + o S | 2025-02-21 18:31:33.766074 | ubuntu-noble -> localhost | | X B . o | 2025-02-21 18:31:33.766105 | ubuntu-noble -> localhost | |* B + . | 2025-02-21 18:31:33.766136 | ubuntu-noble -> localhost | |.% O . | 2025-02-21 18:31:33.766168 | ubuntu-noble -> localhost | |*+Eoo.. | 2025-02-21 18:31:33.766198 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-21 18:31:33.766266 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.096895 2025-02-21 18:31:33.776267 | 2025-02-21 18:31:33.776367 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-21 18:31:33.806917 | ubuntu-noble | ok 2025-02-21 18:31:33.829812 | ubuntu-noble | included: /var/lib/zuul/builds/d17e9f24f4f744f08dcf7e3a41d675da/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-21 18:31:33.840496 | 2025-02-21 18:31:33.840583 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-21 18:31:33.865113 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:33.873251 | 2025-02-21 18:31:33.873338 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-21 18:31:34.849411 | ubuntu-noble | changed 2025-02-21 18:31:34.859366 | 2025-02-21 18:31:34.859553 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-21 18:31:35.210293 | ubuntu-noble | ok 2025-02-21 18:31:35.219672 | 2025-02-21 18:31:35.219786 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-21 18:31:36.061668 | ubuntu-noble | changed 2025-02-21 18:31:36.074906 | 2025-02-21 18:31:36.075009 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-21 18:31:36.960960 | ubuntu-noble | changed 2025-02-21 18:31:36.967628 | 2025-02-21 18:31:36.967722 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-21 18:31:37.020071 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:37.078673 | 2025-02-21 18:31:37.078777 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-21 18:31:37.743086 | ubuntu-noble -> localhost | changed 2025-02-21 18:31:37.760587 | 2025-02-21 18:31:37.760692 | TASK [add-build-sshkey : Add back temp key] 2025-02-21 18:31:38.333627 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/d17e9f24f4f744f08dcf7e3a41d675da/work/d17e9f24f4f744f08dcf7e3a41d675da_id_rsa (zuul-build-sshkey) 2025-02-21 18:31:38.333864 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.025535 2025-02-21 18:31:38.341430 | 2025-02-21 18:31:38.341550 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-21 18:31:38.834435 | ubuntu-noble | ok 2025-02-21 18:31:38.849393 | 2025-02-21 18:31:38.849525 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-21 18:31:38.914117 | ubuntu-noble | skipping: Conditional result was False 2025-02-21 18:31:38.931724 | 2025-02-21 18:31:38.931832 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-21 18:31:39.482022 | ubuntu-noble | ok 2025-02-21 18:31:39.491876 | 2025-02-21 18:31:39.491954 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-21 18:31:39.521097 | ubuntu-noble | ok 2025-02-21 18:31:39.526162 | 2025-02-21 18:31:39.526237 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-21 18:31:39.754224 | ubuntu-noble -> localhost | ok 2025-02-21 18:31:39.760574 | 2025-02-21 18:31:39.760652 | TASK [validate-host : Collect information about the host] 2025-02-21 18:31:41.047004 | ubuntu-noble | ok 2025-02-21 18:31:41.072953 | 2025-02-21 18:31:41.073083 | TASK [validate-host : Sanitize hostname] 2025-02-21 18:31:41.200043 | ubuntu-noble | ok 2025-02-21 18:31:41.205370 | 2025-02-21 18:31:41.205502 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-21 18:31:42.376992 | ubuntu-noble -> localhost | changed 2025-02-21 18:31:42.383905 | 2025-02-21 18:31:42.384009 | TASK [validate-host : Collect information about zuul worker] 2025-02-21 18:31:43.142932 | ubuntu-noble | ok 2025-02-21 18:31:43.149125 | 2025-02-21 18:31:43.149221 | TASK [validate-host : Write out all zuul information for each host] 2025-02-21 18:31:44.172258 | ubuntu-noble -> localhost | changed 2025-02-21 18:31:44.184743 | 2025-02-21 18:31:44.184834 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-21 18:31:44.572533 | ubuntu-noble | ok 2025-02-21 18:31:44.578113 | 2025-02-21 18:31:44.578196 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-21 18:31:45.766840 | ubuntu-noble | changed: 2025-02-21 18:31:45.766986 | ubuntu-noble | cd+++++++++ src/ 2025-02-21 18:31:45.767014 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-21 18:31:45.767034 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-21 18:31:45.767052 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2025-02-21 18:31:45.767068 | ubuntu-noble | =2 in /tmp/venv/lib/python3.12/site-packages (from types-requests) (2.3.0) 2025-02-21 18:32:53.072685 | ubuntu-noble | Downloading types_PyYAML-6.0.12.20241230-py3-none-any.whl (20 kB) 2025-02-21 18:32:53.101201 | ubuntu-noble | Downloading types_decorator-5.1.8.20250215-py3-none-any.whl (8.1 kB) 2025-02-21 18:32:53.126779 | ubuntu-noble | Downloading types_requests-2.32.0.20241016-py3-none-any.whl (15 kB) 2025-02-21 18:32:53.188557 | ubuntu-noble | Downloading types_simplejson-3.20.0.20250218-py3-none-any.whl (10 kB) 2025-02-21 18:32:53.510749 | ubuntu-noble | Installing collected packages: types-simplejson, types-requests, types-PyYAML, types-decorator 2025-02-21 18:32:53.618739 | 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:32:58.735067 | ubuntu-noble | Installing missing stub packages: 2025-02-21 18:32:58.754788 | ubuntu-noble | /tmp/venv/bin/python3 -m pip install types-PyYAML types-decorator types-requests types-simplejson 2025-02-21 18:32:58.755136 | ubuntu-noble | 2025-02-21 18:32:58.755169 | ubuntu-noble | 2025-02-21 18:32:58.755185 | ubuntu-noble | Success: no issues found in 5 source files 2025-02-21 18:32:58.988889 | ubuntu-noble | ok 2025-02-21 18:32:59.037705 | 2025-02-21 18:32:59.037804 | PLAY RECAP 2025-02-21 18:32:59.037861 | ubuntu-noble | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2025-02-21 18:32:59.037886 | 2025-02-21 18:32:59.145608 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/mypy/run.yaml@main] 2025-02-21 18:32:59.148647 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-02-21 18:32:59.834152 | 2025-02-21 18:32:59.834281 | PLAY [Base post] 2025-02-21 18:32:59.857858 | 2025-02-21 18:32:59.857976 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-02-21 18:33:00.527752 | ubuntu-noble | changed 2025-02-21 18:33:00.564909 | 2025-02-21 18:33:00.565078 | PLAY RECAP 2025-02-21 18:33:00.565169 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-02-21 18:33:00.565249 | 2025-02-21 18:33:00.659735 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-02-21 18:33:00.662443 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-02-21 18:33:01.401058 | 2025-02-21 18:33:01.401199 | PLAY [Base post-logs] 2025-02-21 18:33:01.416082 | 2025-02-21 18:33:01.416195 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-02-21 18:33:01.851482 | localhost | changed 2025-02-21 18:33:01.854915 | 2025-02-21 18:33:01.855019 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-02-21 18:33:01.881645 | localhost | ok 2025-02-21 18:33:01.887596 | 2025-02-21 18:33:01.887690 | TASK [Set zuul-log-path fact] 2025-02-21 18:33:01.904155 | localhost | ok 2025-02-21 18:33:01.916651 | 2025-02-21 18:33:01.916750 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-21 18:33:01.953486 | localhost | ok 2025-02-21 18:33:01.956874 | 2025-02-21 18:33:01.956977 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-21 18:33:01.992553 | localhost | skipping: Conditional result was False 2025-02-21 18:33:02.001732 | 2025-02-21 18:33:02.001907 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-21 18:33:02.042417 | localhost | skipping: Conditional result was False 2025-02-21 18:33:02.051369 | 2025-02-21 18:33:02.051561 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-21 18:33:02.077904 | localhost | skipping: Conditional result was False 2025-02-21 18:33:02.081812 | 2025-02-21 18:33:02.081914 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-21 18:33:02.105949 | localhost | skipping: Conditional result was False 2025-02-21 18:33:02.109171 | 2025-02-21 18:33:02.109252 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-21 18:33:02.133250 | localhost | skipping: Conditional result was False 2025-02-21 18:33:02.140564 | 2025-02-21 18:33:02.140655 | TASK [upload-logs : Create log directories] 2025-02-21 18:33:02.617276 | localhost | changed 2025-02-21 18:33:02.621484 | 2025-02-21 18:33:02.621567 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-02-21 18:33:03.150523 | localhost -> localhost | ok: Runtime: 0:00:00.006027 2025-02-21 18:33:03.156802 | 2025-02-21 18:33:03.156939 | TASK [upload-logs : Upload logs to log server] 2025-02-21 18:33:03.786800 | localhost | Output suppressed because no_log was given 2025-02-21 18:33:03.790357 | 2025-02-21 18:33:03.790528 | LOOP [upload-logs : Compress console log and json output] 2025-02-21 18:33:03.877410 | localhost | skipping: Conditional result was False 2025-02-21 18:33:03.886505 | localhost | skipping: Conditional result was False 2025-02-21 18:33:03.893002 | 2025-02-21 18:33:03.893174 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-21 18:33:03.970518 | localhost | skipping: Conditional result was False 2025-02-21 18:33:03.970850 | 2025-02-21 18:33:03.985817 | localhost | skipping: Conditional result was False 2025-02-21 18:33:03.999844 | 2025-02-21 18:33:03.999990 | LOOP [upload-logs : Upload console log and json output]