2026-09-02 03:19:04.700896 | Job console starting 2026-09-02 03:19:04.714174 | Updating git repos 2026-09-02 03:19:04.731560 | Cloning repos into workspace 2026-09-02 03:19:04.781713 | Restoring repo states 2026-09-02 03:19:04.786791 | Merging changes 2026-09-02 03:19:04.786817 | Checking out repos 2026-09-02 03:19:04.839477 | Preparing playbooks 2026-09-02 03:19:05.693781 | Running Ansible setup 2026-09-02 03:19:10.246008 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-02 03:19:11.033298 | 2026-09-02 03:19:11.033501 | PLAY [Base pre] 2026-09-02 03:19:11.051522 | 2026-09-02 03:19:11.051671 | TASK [Setup log path fact] 2026-09-02 03:19:11.081375 | debian-bookworm | ok 2026-09-02 03:19:11.098060 | 2026-09-02 03:19:11.098210 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-02 03:19:11.127074 | debian-bookworm | ok 2026-09-02 03:19:11.137362 | 2026-09-02 03:19:11.137488 | TASK [emit-job-header : Print job information] 2026-09-02 03:19:11.178136 | # Job Information 2026-09-02 03:19:11.178346 | Ansible Version: 2.16.14 2026-09-02 03:19:11.178411 | Job: python-black 2026-09-02 03:19:11.178457 | Pipeline: periodic-daily 2026-09-02 03:19:11.178487 | Executor: 521e9411259a 2026-09-02 03:19:11.178515 | Triggered by: https://github.com/osism/openstack-simple-stress 2026-09-02 03:19:11.178546 | Event ID: 6a98138b9f544d4fb9bd72291e7fecf2 2026-09-02 03:19:11.185032 | 2026-09-02 03:19:11.185153 | LOOP [emit-job-header : Print node information] 2026-09-02 03:19:11.325623 | debian-bookworm | ok: 2026-09-02 03:19:11.325876 | debian-bookworm | # Node Information 2026-09-02 03:19:11.325934 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-02 03:19:11.326019 | debian-bookworm | Hostname: debian 2026-09-02 03:19:11.326119 | debian-bookworm | Username: zuul 2026-09-02 03:19:11.326158 | debian-bookworm | Distro: Debian 12.15 2026-09-02 03:19:11.326193 | debian-bookworm | Provider: regiocloud-a 2026-09-02 03:19:11.326222 | debian-bookworm | Region: 2026-09-02 03:19:11.326252 | debian-bookworm | Label: debian-bookworm 2026-09-02 03:19:11.326280 | debian-bookworm | Product Name: OpenStack Nova 2026-09-02 03:19:11.326309 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe91:7ec5 2026-09-02 03:19:11.345936 | 2026-09-02 03:19:11.346062 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-02 03:19:11.860610 | debian-bookworm -> localhost | changed 2026-09-02 03:19:11.885386 | 2026-09-02 03:19:11.885592 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-02 03:19:13.023008 | debian-bookworm -> localhost | changed 2026-09-02 03:19:13.034574 | 2026-09-02 03:19:13.034695 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-02 03:19:13.324747 | debian-bookworm -> localhost | ok 2026-09-02 03:19:13.331489 | 2026-09-02 03:19:13.331675 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-02 03:19:13.364893 | debian-bookworm | ok 2026-09-02 03:19:13.381882 | debian-bookworm | included: /var/lib/zuul/builds/7d4025b2bc4d4880abeb69b6c0cce01f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-02 03:19:13.392087 | 2026-09-02 03:19:13.392215 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-02 03:19:15.492405 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-02 03:19:15.492955 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7d4025b2bc4d4880abeb69b6c0cce01f/work/7d4025b2bc4d4880abeb69b6c0cce01f_id_rsa 2026-09-02 03:19:15.493056 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7d4025b2bc4d4880abeb69b6c0cce01f/work/7d4025b2bc4d4880abeb69b6c0cce01f_id_rsa.pub 2026-09-02 03:19:15.493116 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-02 03:19:15.493170 | debian-bookworm -> localhost | SHA256:gISHzFvKei3gEB+kDd1b/Ynb+h4/Bp9y3kYvc9nvwEc zuul-build-sshkey 2026-09-02 03:19:15.493219 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-02 03:19:15.493280 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-02 03:19:15.493437 | debian-bookworm -> localhost | |.=.+. . | 2026-09-02 03:19:15.493494 | debian-bookworm -> localhost | |.+B.+.. . | 2026-09-02 03:19:15.493542 | debian-bookworm -> localhost | |.+.*.o. o . | 2026-09-02 03:19:15.493587 | debian-bookworm -> localhost | |o = . .. o | 2026-09-02 03:19:15.493835 | debian-bookworm -> localhost | |oo . So E| 2026-09-02 03:19:15.493930 | debian-bookworm -> localhost | |..o . . o ... | 2026-09-02 03:19:15.494001 | debian-bookworm -> localhost | | . . ..o oo.+| 2026-09-02 03:19:15.494045 | debian-bookworm -> localhost | | . .o*.+++| 2026-09-02 03:19:15.494088 | debian-bookworm -> localhost | | oo=oo.=+| 2026-09-02 03:19:15.494131 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-02 03:19:15.494249 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.564447 2026-09-02 03:19:15.508664 | 2026-09-02 03:19:15.508789 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-02 03:19:15.538940 | debian-bookworm | ok 2026-09-02 03:19:15.551028 | debian-bookworm | included: /var/lib/zuul/builds/7d4025b2bc4d4880abeb69b6c0cce01f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-02 03:19:15.561552 | 2026-09-02 03:19:15.561651 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-02 03:19:15.586772 | debian-bookworm | skipping: Conditional result was False 2026-09-02 03:19:15.593981 | 2026-09-02 03:19:15.595660 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-02 03:19:16.268572 | debian-bookworm | changed 2026-09-02 03:19:16.279462 | 2026-09-02 03:19:16.279580 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-02 03:19:16.569860 | debian-bookworm | ok 2026-09-02 03:19:16.597504 | 2026-09-02 03:19:16.597692 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-02 03:19:17.207987 | debian-bookworm | changed 2026-09-02 03:19:17.213877 | 2026-09-02 03:19:17.213994 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-02 03:19:17.833069 | debian-bookworm | changed 2026-09-02 03:19:17.839429 | 2026-09-02 03:19:17.839547 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-02 03:19:17.863321 | debian-bookworm | skipping: Conditional result was False 2026-09-02 03:19:17.869774 | 2026-09-02 03:19:17.869877 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-02 03:19:18.324140 | debian-bookworm -> localhost | changed 2026-09-02 03:19:18.335341 | 2026-09-02 03:19:18.335494 | TASK [add-build-sshkey : Add back temp key] 2026-09-02 03:19:18.692075 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7d4025b2bc4d4880abeb69b6c0cce01f/work/7d4025b2bc4d4880abeb69b6c0cce01f_id_rsa (zuul-build-sshkey) 2026-09-02 03:19:18.692412 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011551 2026-09-02 03:19:18.711859 | 2026-09-02 03:19:18.712131 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-02 03:19:19.126627 | debian-bookworm | ok 2026-09-02 03:19:19.134665 | 2026-09-02 03:19:19.134812 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-02 03:19:19.160053 | debian-bookworm | skipping: Conditional result was False 2026-09-02 03:19:19.174801 | 2026-09-02 03:19:19.176982 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-02 03:19:19.652753 | debian-bookworm | ok 2026-09-02 03:19:19.665667 | 2026-09-02 03:19:19.665798 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-02 03:19:19.710332 | debian-bookworm | ok 2026-09-02 03:19:19.716479 | 2026-09-02 03:19:19.716597 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-02 03:19:20.018404 | debian-bookworm -> localhost | ok 2026-09-02 03:19:20.027404 | 2026-09-02 03:19:20.027535 | TASK [validate-host : Collect information about the host] 2026-09-02 03:19:21.246264 | debian-bookworm | ok 2026-09-02 03:19:21.259925 | 2026-09-02 03:19:21.260045 | TASK [validate-host : Sanitize hostname] 2026-09-02 03:19:21.558884 | debian-bookworm | ok 2026-09-02 03:19:21.568860 | 2026-09-02 03:19:21.568991 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-02 03:19:22.251340 | debian-bookworm -> localhost | changed 2026-09-02 03:19:22.257533 | 2026-09-02 03:19:22.257657 | TASK [validate-host : Collect information about zuul worker] 2026-09-02 03:19:22.658542 | debian-bookworm | ok 2026-09-02 03:19:22.663519 | 2026-09-02 03:19:22.663609 | TASK [validate-host : Write out all zuul information for each host] 2026-09-02 03:19:23.176582 | debian-bookworm -> localhost | changed 2026-09-02 03:19:23.185710 | 2026-09-02 03:19:23.185806 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-02 03:19:23.424489 | debian-bookworm | ok 2026-09-02 03:19:23.430091 | 2026-09-02 03:19:23.430180 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-02 03:19:24.280225 | debian-bookworm | changed: 2026-09-02 03:19:24.280424 | debian-bookworm | cd+++++++++ src/ 2026-09-02 03:19:24.280462 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-02 03:19:24.280487 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-02 03:19:24.280509 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2026-09-02 03:19:24.280530 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/7d4025b2bc4d4880abeb69b6c0cce01f/work/logs" 2026-09-02 03:20:26.513795 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/7d4025b2bc4d4880abeb69b6c0cce01f/work/artifacts" 2026-09-02 03:20:26.892320 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/7d4025b2bc4d4880abeb69b6c0cce01f/work/docs" 2026-09-02 03:20:26.910234 | 2026-09-02 03:20:26.910370 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-02 03:20:27.742057 | debian-bookworm | changed: 2026-09-02 03:20:27.742292 | debian-bookworm | .d..t...... ./ 2026-09-02 03:20:27.742328 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-02 03:20:27.742362 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-02 03:20:27.742384 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-02 03:20:27.742405 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-02 03:20:27.742425 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-02 03:20:27.742463 | debian-bookworm | changed: All items complete 2026-09-02 03:20:27.742489 | 2026-09-02 03:20:28.245791 | debian-bookworm | changed: .d..t...... ./ 2026-09-02 03:20:28.759209 | debian-bookworm | changed: .d..t...... ./ 2026-09-02 03:20:28.787743 | 2026-09-02 03:20:28.787830 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-02 03:20:28.810594 | debian-bookworm | skipping: Conditional result was False 2026-09-02 03:20:28.814291 | debian-bookworm | skipping: Conditional result was False 2026-09-02 03:20:28.831926 | 2026-09-02 03:20:28.831984 | PLAY RECAP 2026-09-02 03:20:28.832026 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-09-02 03:20:28.832046 | 2026-09-02 03:20:28.958264 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-02 03:20:28.958912 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-02 03:20:29.631775 | 2026-09-02 03:20:29.631952 | PLAY [Base post] 2026-09-02 03:20:29.673382 | 2026-09-02 03:20:29.673507 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-02 03:20:30.190906 | debian-bookworm | changed 2026-09-02 03:20:30.196973 | 2026-09-02 03:20:30.197056 | PLAY RECAP 2026-09-02 03:20:30.197118 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-02 03:20:30.197182 | 2026-09-02 03:20:30.289244 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-02 03:20:30.289902 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-02 03:20:30.973944 | 2026-09-02 03:20:30.974055 | PLAY [Base post-logs] 2026-09-02 03:20:30.981887 | 2026-09-02 03:20:30.981975 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-02 03:20:31.361086 | localhost | changed 2026-09-02 03:20:31.368756 | 2026-09-02 03:20:31.368860 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-02 03:20:31.396281 | localhost | ok 2026-09-02 03:20:31.398601 | 2026-09-02 03:20:31.398671 | TASK [Set zuul-log-path fact] 2026-09-02 03:20:31.412133 | localhost | ok 2026-09-02 03:20:31.418242 | 2026-09-02 03:20:31.418319 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-02 03:20:31.441872 | localhost | ok 2026-09-02 03:20:31.444288 | 2026-09-02 03:20:31.444388 | TASK [upload-logs : Create log directories] 2026-09-02 03:20:31.968843 | localhost | changed 2026-09-02 03:20:31.971449 | 2026-09-02 03:20:31.971538 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-02 03:20:32.439950 | localhost -> localhost | ok: Runtime: 0:00:00.006674 2026-09-02 03:20:32.444779 | 2026-09-02 03:20:32.444895 | TASK [upload-logs : Upload logs to log server] 2026-09-02 03:20:33.065610 | localhost | Output suppressed because no_log was given 2026-09-02 03:20:33.067221 | 2026-09-02 03:20:33.067303 | LOOP [upload-logs : Compress console log and json output] 2026-09-02 03:20:33.122896 | localhost | skipping: Conditional result was False 2026-09-02 03:20:33.128418 | localhost | skipping: Conditional result was False 2026-09-02 03:20:33.132694 | 2026-09-02 03:20:33.132782 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-02 03:20:33.179305 | localhost | skipping: Conditional result was False 2026-09-02 03:20:33.179591 | 2026-09-02 03:20:33.184195 | localhost | skipping: Conditional result was False 2026-09-02 03:20:33.188202 | 2026-09-02 03:20:33.188291 | LOOP [upload-logs : Upload console log and json output]