2025-04-30 03:07:47.798805 | Job console starting... 2025-04-30 03:07:47.809392 | Updating repositories 2025-04-30 03:07:47.862993 | Preparing job workspace 2025-04-30 03:07:49.157436 | Running Ansible setup... 2025-04-30 03:07:54.299888 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-30 03:07:54.936982 | 2025-04-30 03:07:54.937117 | PLAY [Base pre] 2025-04-30 03:07:54.969139 | 2025-04-30 03:07:54.969261 | TASK [Setup log path fact] 2025-04-30 03:07:54.990062 | ubuntu-noble | ok 2025-04-30 03:07:55.009098 | 2025-04-30 03:07:55.009279 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-30 03:07:55.044022 | ubuntu-noble | ok 2025-04-30 03:07:55.057231 | 2025-04-30 03:07:55.057340 | TASK [emit-job-header : Print job information] 2025-04-30 03:07:55.150657 | # Job Information 2025-04-30 03:07:55.150946 | Ansible Version: 2.15.3 2025-04-30 03:07:55.151006 | Job: tox 2025-04-30 03:07:55.151056 | Pipeline: periodic-daily 2025-04-30 03:07:55.151090 | Executor: 7d211f194f6a 2025-04-30 03:07:55.151118 | Triggered by: https://github.com/osism/openstack-simple-stress 2025-04-30 03:07:55.151145 | Event ID: 9d124ae0f3cd4e98a745a22b946fa625 2025-04-30 03:07:55.165945 | 2025-04-30 03:07:55.166168 | LOOP [emit-job-header : Print node information] 2025-04-30 03:07:55.337178 | ubuntu-noble | ok: 2025-04-30 03:07:55.337359 | ubuntu-noble | # Node Information 2025-04-30 03:07:55.337392 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-30 03:07:55.337418 | ubuntu-noble | Hostname: ubuntu 2025-04-30 03:07:55.337439 | ubuntu-noble | Username: zuul 2025-04-30 03:07:55.337460 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-30 03:07:55.337483 | ubuntu-noble | Provider: regiocloud-a 2025-04-30 03:07:55.337503 | ubuntu-noble | Label: ubuntu-noble 2025-04-30 03:07:55.337524 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-30 03:07:55.337544 | ubuntu-noble | Interface IP: 81.163.192.65 2025-04-30 03:07:55.360548 | 2025-04-30 03:07:55.360676 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-30 03:07:55.932637 | ubuntu-noble -> localhost | changed 2025-04-30 03:07:55.941294 | 2025-04-30 03:07:55.941403 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-30 03:07:56.970881 | ubuntu-noble -> localhost | changed 2025-04-30 03:07:56.992975 | 2025-04-30 03:07:56.993082 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-30 03:07:57.332524 | ubuntu-noble -> localhost | ok 2025-04-30 03:07:57.338776 | 2025-04-30 03:07:57.338889 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-30 03:07:57.388122 | ubuntu-noble | ok 2025-04-30 03:07:57.401499 | ubuntu-noble | included: /var/lib/zuul/builds/a7e6cebd2c4f4b2ba110436e51c336cb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-30 03:07:57.408078 | 2025-04-30 03:07:57.408164 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-30 03:07:58.043116 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-30 03:07:58.043368 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/a7e6cebd2c4f4b2ba110436e51c336cb/work/a7e6cebd2c4f4b2ba110436e51c336cb_id_rsa 2025-04-30 03:07:58.043407 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/a7e6cebd2c4f4b2ba110436e51c336cb/work/a7e6cebd2c4f4b2ba110436e51c336cb_id_rsa.pub 2025-04-30 03:07:58.043433 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-30 03:07:58.043458 | ubuntu-noble -> localhost | SHA256:5WtWk6SbmVtMqCHlj5Mwm41YSiX+J2Shv+KkokEIDoU zuul-build-sshkey 2025-04-30 03:07:58.043479 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-30 03:07:58.043500 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-30 03:07:58.043521 | ubuntu-noble -> localhost | | .. | 2025-04-30 03:07:58.043542 | ubuntu-noble -> localhost | |E. | 2025-04-30 03:07:58.043563 | ubuntu-noble -> localhost | |o . o . . . | 2025-04-30 03:07:58.043594 | ubuntu-noble -> localhost | |= . + + o + . | 2025-04-30 03:07:58.043615 | ubuntu-noble -> localhost | |.o + B S + = | 2025-04-30 03:07:58.043635 | ubuntu-noble -> localhost | |. . O O * X . | 2025-04-30 03:07:58.043662 | ubuntu-noble -> localhost | |. + B B X o | 2025-04-30 03:07:58.043683 | ubuntu-noble -> localhost | |.. o. + + o | 2025-04-30 03:07:58.043703 | ubuntu-noble -> localhost | |o...... . | 2025-04-30 03:07:58.043724 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-30 03:07:58.043772 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.086785 2025-04-30 03:07:58.057312 | 2025-04-30 03:07:58.057414 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-30 03:07:58.091944 | ubuntu-noble | ok 2025-04-30 03:07:58.104289 | ubuntu-noble | included: /var/lib/zuul/builds/a7e6cebd2c4f4b2ba110436e51c336cb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-30 03:07:58.114041 | 2025-04-30 03:07:58.114124 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-30 03:07:58.138470 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:07:58.147674 | 2025-04-30 03:07:58.147773 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-30 03:07:58.735346 | ubuntu-noble | changed 2025-04-30 03:07:58.744128 | 2025-04-30 03:07:58.744251 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-30 03:07:59.046974 | ubuntu-noble | ok 2025-04-30 03:07:59.054123 | 2025-04-30 03:07:59.054240 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-30 03:07:59.515194 | ubuntu-noble | ok 2025-04-30 03:07:59.524310 | 2025-04-30 03:07:59.524478 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-30 03:07:59.937183 | ubuntu-noble | ok 2025-04-30 03:07:59.951669 | 2025-04-30 03:07:59.952504 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-30 03:08:00.019426 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:08:00.027826 | 2025-04-30 03:08:00.027982 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-30 03:08:00.591072 | ubuntu-noble -> localhost | changed 2025-04-30 03:08:00.607645 | 2025-04-30 03:08:00.607789 | TASK [add-build-sshkey : Add back temp key] 2025-04-30 03:08:01.014150 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/a7e6cebd2c4f4b2ba110436e51c336cb/work/a7e6cebd2c4f4b2ba110436e51c336cb_id_rsa (zuul-build-sshkey) 2025-04-30 03:08:01.014469 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.037725 2025-04-30 03:08:01.023342 | 2025-04-30 03:08:01.023463 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-30 03:08:01.479352 | ubuntu-noble | ok 2025-04-30 03:08:01.486345 | 2025-04-30 03:08:01.486464 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-30 03:08:01.532721 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:08:01.555609 | 2025-04-30 03:08:01.555771 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-30 03:08:02.039544 | ubuntu-noble | ok 2025-04-30 03:08:02.102366 | 2025-04-30 03:08:02.102516 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-30 03:08:02.145765 | ubuntu-noble | ok 2025-04-30 03:08:02.153159 | 2025-04-30 03:08:02.153282 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-30 03:08:02.527838 | ubuntu-noble -> localhost | ok 2025-04-30 03:08:02.536255 | 2025-04-30 03:08:02.536368 | TASK [validate-host : Collect information about the host] 2025-04-30 03:08:03.701918 | ubuntu-noble | ok 2025-04-30 03:08:03.722354 | 2025-04-30 03:08:03.722644 | TASK [validate-host : Sanitize hostname] 2025-04-30 03:08:03.811007 | ubuntu-noble | ok 2025-04-30 03:08:03.825949 | 2025-04-30 03:08:03.826118 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-30 03:08:04.960255 | ubuntu-noble -> localhost | changed 2025-04-30 03:08:04.983329 | 2025-04-30 03:08:04.983505 | TASK [validate-host : Collect information about zuul worker] 2025-04-30 03:08:05.641535 | ubuntu-noble | ok 2025-04-30 03:08:05.680500 | 2025-04-30 03:08:05.681328 | TASK [validate-host : Write out all zuul information for each host] 2025-04-30 03:08:06.594216 | ubuntu-noble -> localhost | changed 2025-04-30 03:08:06.622463 | 2025-04-30 03:08:06.622876 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-30 03:08:06.942941 | ubuntu-noble | ok 2025-04-30 03:08:06.955008 | 2025-04-30 03:08:06.955112 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-30 03:08:08.259896 | ubuntu-noble | changed: 2025-04-30 03:08:08.260076 | ubuntu-noble | .d..t...... src/ 2025-04-30 03:08:08.260111 | ubuntu-noble | .d..t...... src/github.com/ 2025-04-30 03:08:08.260137 | ubuntu-noble | .d..t...... src/github.com/osism/ 2025-04-30 03:08:08.260159 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2025-04-30 03:08:08.260184 | ubuntu-noble | localhost | changed 2025-04-30 03:08:35.240316 | 2025-04-30 03:08:35.240458 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-04-30 03:08:35.341366 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:08:35.347732 | 2025-04-30 03:08:35.347857 | TASK [fetch-tox-output : Set envlist fact] 2025-04-30 03:08:35.418963 | ubuntu-noble | ok 2025-04-30 03:08:35.428915 | 2025-04-30 03:08:35.429017 | TASK [fetch-tox-output : Get tox version] 2025-04-30 03:08:36.311875 | ubuntu-noble | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-04-30 03:08:36.328000 | ubuntu-noble | 4.25.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-04-30 03:08:36.520651 | ubuntu-noble | ok: Runtime: 0:00:00.284752 2025-04-30 03:08:36.528379 | 2025-04-30 03:08:36.528495 | TASK [fetch-tox-output : Find all default environments] 2025-04-30 03:08:36.703198 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:08:36.712132 | 2025-04-30 03:08:36.712257 | TASK [fetch-tox-output : Set envlist fact] 2025-04-30 03:08:36.781879 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:08:36.789445 | 2025-04-30 03:08:36.789554 | TASK [fetch-tox-output : Find all default environments] 2025-04-30 03:08:37.014639 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:08:37.022257 | 2025-04-30 03:08:37.022367 | TASK [fetch-tox-output : Set envlist fact] 2025-04-30 03:08:37.091483 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:08:37.100702 | 2025-04-30 03:08:37.102854 | LOOP [fetch-tox-output : Copy tox logs] 2025-04-30 03:08:37.204655 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:08:37.234424 | 2025-04-30 03:08:37.234557 | LOOP [fetch-tox-output : Collect tox logs] 2025-04-30 03:08:39.023454 | ubuntu-noble | ok: 2025-04-30 03:08:39.023620 | ubuntu-noble | rsync: [sender] change_dir "/home/zuul/src/github.com/osism/openstack-simple-stress/.tox/test/log" failed: No such file or directory (2) 2025-04-30 03:08:39.023653 | ubuntu-noble | rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1819) [Receiver=3.2.3] 2025-04-30 03:08:39.023677 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32) 2025-04-30 03:08:39.023705 | 2025-04-30 03:08:39.174079 | 2025-04-30 03:08:39.174166 | PLAY RECAP 2025-04-30 03:08:39.174214 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-04-30 03:08:39.174236 | 2025-04-30 03:08:39.508942 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-04-30 03:08:39.512229 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-04-30 03:08:41.323937 | 2025-04-30 03:08:41.324092 | PLAY [all] 2025-04-30 03:08:41.422551 | 2025-04-30 03:08:41.422720 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-04-30 03:08:41.756224 | ubuntu-noble | changed: non-zero return code 2025-04-30 03:08:41.775311 | 2025-04-30 03:08:41.775465 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-04-30 03:08:41.886328 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:08:41.894944 | 2025-04-30 03:08:41.895065 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-04-30 03:08:41.988725 | 2025-04-30 03:08:41.988950 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-04-30 03:08:42.063902 | 2025-04-30 03:08:42.064248 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-04-30 03:08:42.120575 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:08:42.128750 | 2025-04-30 03:08:42.128888 | LOOP [fetch-subunit-output : Generate subunit file] 2025-04-30 03:08:42.175049 | 2025-04-30 03:08:42.175269 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-04-30 03:08:42.210781 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:08:42.218968 | 2025-04-30 03:08:42.219102 | TASK [fetch-subunit-output : Remove the temporary file] 2025-04-30 03:08:42.265171 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:08:42.297795 | 2025-04-30 03:08:42.298054 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-04-30 03:08:42.396884 | ubuntu-noble | skipping: Conditional result was False 2025-04-30 03:08:42.530805 | 2025-04-30 03:08:42.530920 | PLAY RECAP 2025-04-30 03:08:42.530980 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-04-30 03:08:42.531134 | 2025-04-30 03:08:43.120453 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-04-30 03:08:43.124078 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-04-30 03:08:45.002044 | 2025-04-30 03:08:45.002158 | PLAY [Base post] 2025-04-30 03:08:45.031945 | 2025-04-30 03:08:45.032093 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-04-30 03:09:47.486582 | ubuntu-noble | ERROR 2025-04-30 03:09:47.486778 | ubuntu-noble | { 2025-04-30 03:09:47.486818 | ubuntu-noble | "msg": "Data could not be sent to remote host \"81.163.192.65\". Make sure this host can be reached over ssh: @@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@\r\n@ WARNING: REMOTE HOST IDENTIFICATION HAS CHANGED! @\r\n@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@\r\nIT IS POSSIBLE THAT SOMEONE IS DOING SOMETHING NASTY!\r\nSomeone could be eavesdropping on you right now (man-in-the-middle attack)!\r\nIt is also possible that a host key has just been changed.\r\nThe fingerprint for the ECDSA key sent by the remote host is\nSHA256:KFl5oTeYmNYDMM9tvlpnuXICRAGqK2zhMkDO8IjQrno.\r\nPlease contact your system administrator.\r\nAdd correct host key in /var/lib/zuul/builds/a7e6cebd2c4f4b2ba110436e51c336cb/work/.ssh/known_hosts to get rid of this message.\r\nOffending RSA key in /var/lib/zuul/builds/a7e6cebd2c4f4b2ba110436e51c336cb/work/.ssh/known_hosts:4\r\n remove with:\r\n ssh-keygen -f \"/var/lib/zuul/builds/a7e6cebd2c4f4b2ba110436e51c336cb/work/.ssh/known_hosts\" -R \"81.163.192.65\"\r\nECDSA host key for 81.163.192.65 has changed and you have requested strict checking.\r\nHost key verification failed.\r\n", 2025-04-30 03:09:47.486849 | ubuntu-noble | "unreachable": true 2025-04-30 03:09:47.486895 | ubuntu-noble | } unreachable 2025-04-30 03:09:47.488204 | 2025-04-30 03:09:47.488262 | PLAY RECAP 2025-04-30 03:09:47.488305 | ubuntu-noble | ok: 0 changed: 0 unreachable: 1 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-04-30 03:09:47.488329 | 2025-04-30 03:09:47.556353 | POST-RUN END RESULT_UNREACHABLE: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-04-30 03:09:47.559092 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-04-30 03:09:48.288641 | 2025-04-30 03:09:48.288787 | PLAY [Base post-logs] 2025-04-30 03:09:48.305731 | 2025-04-30 03:09:48.305857 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-04-30 03:09:48.793599 | localhost | changed 2025-04-30 03:09:48.797299 | 2025-04-30 03:09:48.797407 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-04-30 03:09:48.824232 | localhost | ok 2025-04-30 03:09:48.831380 | 2025-04-30 03:09:48.831477 | TASK [Set zuul-log-path fact] 2025-04-30 03:09:48.859334 | localhost | ok 2025-04-30 03:09:48.869238 | 2025-04-30 03:09:48.869351 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-30 03:09:48.906693 | localhost | ok 2025-04-30 03:09:48.912794 | 2025-04-30 03:09:48.912893 | TASK [upload-logs : Create log directories] 2025-04-30 03:09:49.452878 | localhost | changed 2025-04-30 03:09:49.457140 | 2025-04-30 03:09:49.457226 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-04-30 03:09:50.029335 | localhost -> localhost | ok: Runtime: 0:00:00.004486 2025-04-30 03:09:50.034223 | 2025-04-30 03:09:50.034313 | TASK [upload-logs : Upload logs to log server] 2025-04-30 03:09:50.676242 | localhost | Output suppressed because no_log was given 2025-04-30 03:09:50.680829 | 2025-04-30 03:09:50.680953 | LOOP [upload-logs : Compress console log and json output] 2025-04-30 03:09:50.783489 | localhost | skipping: Conditional result was False 2025-04-30 03:09:50.804329 | localhost | skipping: Conditional result was False 2025-04-30 03:09:50.818816 | 2025-04-30 03:09:50.818925 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-30 03:09:50.925159 | localhost | skipping: Conditional result was False 2025-04-30 03:09:50.925446 | 2025-04-30 03:09:50.940197 | localhost | skipping: Conditional result was False 2025-04-30 03:09:50.948154 | 2025-04-30 03:09:50.948272 | LOOP [upload-logs : Upload console log and json output]