2026-08-11 03:16:18.747969 | Job console starting 2026-08-11 03:16:18.760395 | Updating git repos 2026-08-11 03:16:18.783174 | Cloning repos into workspace 2026-08-11 03:16:18.838778 | Restoring repo states 2026-08-11 03:16:18.845190 | Merging changes 2026-08-11 03:16:18.845210 | Checking out repos 2026-08-11 03:16:18.878159 | Preparing playbooks 2026-08-11 03:16:19.793773 | Running Ansible setup 2026-08-11 03:16:24.932889 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-11 03:16:26.000453 | 2026-08-11 03:16:26.000634 | PLAY [Base pre] 2026-08-11 03:16:26.048242 | 2026-08-11 03:16:26.048417 | TASK [Setup log path fact] 2026-08-11 03:16:26.080100 | debian-bookworm | ok 2026-08-11 03:16:26.120018 | 2026-08-11 03:16:26.120203 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-11 03:16:26.169962 | debian-bookworm | ok 2026-08-11 03:16:26.184912 | 2026-08-11 03:16:26.185058 | TASK [emit-job-header : Print job information] 2026-08-11 03:16:26.224497 | # Job Information 2026-08-11 03:16:26.224765 | Ansible Version: 2.16.14 2026-08-11 03:16:26.224806 | Job: python-black 2026-08-11 03:16:26.224857 | Pipeline: periodic-daily 2026-08-11 03:16:26.224881 | Executor: 521e9411259a 2026-08-11 03:16:26.224901 | Triggered by: https://github.com/osism/openstack-simple-stress 2026-08-11 03:16:26.224924 | Event ID: 737e8093866a4260a4ba6650e5b62167 2026-08-11 03:16:26.231207 | 2026-08-11 03:16:26.231349 | LOOP [emit-job-header : Print node information] 2026-08-11 03:16:26.358267 | debian-bookworm | ok: 2026-08-11 03:16:26.365232 | debian-bookworm | # Node Information 2026-08-11 03:16:26.365361 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-11 03:16:26.365393 | debian-bookworm | Hostname: debian 2026-08-11 03:16:26.365417 | debian-bookworm | Username: zuul 2026-08-11 03:16:26.365439 | debian-bookworm | Distro: Debian 12.15 2026-08-11 03:16:26.365464 | debian-bookworm | Provider: regiocloud-a 2026-08-11 03:16:26.365486 | debian-bookworm | Region: 2026-08-11 03:16:26.365508 | debian-bookworm | Label: debian-bookworm 2026-08-11 03:16:26.365528 | debian-bookworm | Product Name: OpenStack Nova 2026-08-11 03:16:26.365547 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe26:ff12 2026-08-11 03:16:26.378741 | 2026-08-11 03:16:26.378972 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-11 03:16:27.058101 | debian-bookworm -> localhost | changed 2026-08-11 03:16:27.066229 | 2026-08-11 03:16:27.066385 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-11 03:16:28.821785 | debian-bookworm -> localhost | changed 2026-08-11 03:16:28.838409 | 2026-08-11 03:16:28.838550 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-11 03:16:29.540718 | debian-bookworm -> localhost | ok 2026-08-11 03:16:29.547927 | 2026-08-11 03:16:29.548067 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-11 03:16:29.609594 | debian-bookworm | ok 2026-08-11 03:16:29.662246 | debian-bookworm | included: /var/lib/zuul/builds/3416988a781a4242a6fc59bfdff0dd45/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-11 03:16:29.702732 | 2026-08-11 03:16:29.703466 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-11 03:16:32.645794 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-11 03:16:32.645970 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3416988a781a4242a6fc59bfdff0dd45/work/3416988a781a4242a6fc59bfdff0dd45_id_rsa 2026-08-11 03:16:32.646002 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3416988a781a4242a6fc59bfdff0dd45/work/3416988a781a4242a6fc59bfdff0dd45_id_rsa.pub 2026-08-11 03:16:32.646037 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-11 03:16:32.646057 | debian-bookworm -> localhost | SHA256:1UQKGFEuFmSwPMQkxvXdktsCotzIJbiXfr5HkjIud28 zuul-build-sshkey 2026-08-11 03:16:32.646075 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-11 03:16:32.646101 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-11 03:16:32.646129 | debian-bookworm -> localhost | | .o+=o*=o .o | 2026-08-11 03:16:32.646149 | debian-bookworm -> localhost | | o.+.+.+ + + | 2026-08-11 03:16:32.646167 | debian-bookworm -> localhost | |. . * = = + . | 2026-08-11 03:16:32.646183 | debian-bookworm -> localhost | | + B + o = | 2026-08-11 03:16:32.646199 | debian-bookworm -> localhost | |. B .. S . | 2026-08-11 03:16:32.646230 | debian-bookworm -> localhost | | oo o . . | 2026-08-11 03:16:32.646248 | debian-bookworm -> localhost | | ..o.o | 2026-08-11 03:16:32.646265 | debian-bookworm -> localhost | |. oo. E | 2026-08-11 03:16:32.646282 | debian-bookworm -> localhost | | o .o=. | 2026-08-11 03:16:32.646299 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-11 03:16:32.646340 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.673359 2026-08-11 03:16:32.651439 | 2026-08-11 03:16:32.651516 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-11 03:16:32.667498 | debian-bookworm | ok 2026-08-11 03:16:32.675647 | debian-bookworm | included: /var/lib/zuul/builds/3416988a781a4242a6fc59bfdff0dd45/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-11 03:16:32.682117 | 2026-08-11 03:16:32.682193 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-11 03:16:32.705155 | debian-bookworm | skipping: Conditional result was False 2026-08-11 03:16:32.717976 | 2026-08-11 03:16:32.718127 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-11 03:16:33.401159 | debian-bookworm | changed 2026-08-11 03:16:33.410247 | 2026-08-11 03:16:33.410377 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-11 03:16:33.671213 | debian-bookworm | ok 2026-08-11 03:16:33.675660 | 2026-08-11 03:16:33.675745 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-11 03:16:34.343594 | debian-bookworm | changed 2026-08-11 03:16:34.350220 | 2026-08-11 03:16:34.350342 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-11 03:16:35.037639 | debian-bookworm | changed 2026-08-11 03:16:35.046806 | 2026-08-11 03:16:35.046979 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-11 03:16:35.073748 | debian-bookworm | skipping: Conditional result was False 2026-08-11 03:16:35.081131 | 2026-08-11 03:16:35.081228 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-11 03:16:35.635525 | debian-bookworm -> localhost | changed 2026-08-11 03:16:35.645922 | 2026-08-11 03:16:35.646027 | TASK [add-build-sshkey : Add back temp key] 2026-08-11 03:16:36.024285 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3416988a781a4242a6fc59bfdff0dd45/work/3416988a781a4242a6fc59bfdff0dd45_id_rsa (zuul-build-sshkey) 2026-08-11 03:16:36.024499 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009943 2026-08-11 03:16:36.031849 | 2026-08-11 03:16:36.031946 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-11 03:16:36.440056 | debian-bookworm | ok 2026-08-11 03:16:36.447315 | 2026-08-11 03:16:36.447436 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-11 03:16:36.472176 | debian-bookworm | skipping: Conditional result was False 2026-08-11 03:16:36.497105 | 2026-08-11 03:16:36.497228 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-11 03:16:36.953956 | debian-bookworm | ok 2026-08-11 03:16:36.968954 | 2026-08-11 03:16:36.969064 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-11 03:16:36.996977 | debian-bookworm | ok 2026-08-11 03:16:37.007512 | 2026-08-11 03:16:37.007616 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-11 03:16:37.459846 | debian-bookworm -> localhost | ok 2026-08-11 03:16:37.467210 | 2026-08-11 03:16:37.467307 | TASK [validate-host : Collect information about the host] 2026-08-11 03:16:38.666029 | debian-bookworm | ok 2026-08-11 03:16:38.677301 | 2026-08-11 03:16:38.677396 | TASK [validate-host : Sanitize hostname] 2026-08-11 03:16:38.840281 | debian-bookworm | ok 2026-08-11 03:16:38.859674 | 2026-08-11 03:16:38.859849 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-11 03:16:40.293925 | debian-bookworm -> localhost | changed 2026-08-11 03:16:40.322400 | 2026-08-11 03:16:40.322693 | TASK [validate-host : Collect information about zuul worker] 2026-08-11 03:16:40.904831 | debian-bookworm | ok 2026-08-11 03:16:40.917535 | 2026-08-11 03:16:40.917687 | TASK [validate-host : Write out all zuul information for each host] 2026-08-11 03:16:42.453720 | debian-bookworm -> localhost | changed 2026-08-11 03:16:42.475166 | 2026-08-11 03:16:42.475509 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-11 03:16:42.768371 | debian-bookworm | ok 2026-08-11 03:16:42.792253 | 2026-08-11 03:16:42.792410 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-11 03:16:44.065450 | debian-bookworm | changed: 2026-08-11 03:16:44.065696 | debian-bookworm | cd+++++++++ src/ 2026-08-11 03:16:44.065733 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-11 03:16:44.065757 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-11 03:16:44.065779 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2026-08-11 03:16:44.065800 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/3416988a781a4242a6fc59bfdff0dd45/work/logs" 2026-08-11 03:17:47.616544 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3416988a781a4242a6fc59bfdff0dd45/work/artifacts" 2026-08-11 03:17:48.782337 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3416988a781a4242a6fc59bfdff0dd45/work/docs" 2026-08-11 03:17:48.798124 | 2026-08-11 03:17:48.798294 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-11 03:17:49.703300 | debian-bookworm | changed: 2026-08-11 03:17:49.703893 | debian-bookworm | .d..t...... ./ 2026-08-11 03:17:49.703952 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-11 03:17:49.703980 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-11 03:17:49.704014 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-11 03:17:49.704041 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-11 03:17:49.704064 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-11 03:17:49.704115 | debian-bookworm | changed: All items complete 2026-08-11 03:17:49.704143 | 2026-08-11 03:17:50.283479 | debian-bookworm | changed: .d..t...... ./ 2026-08-11 03:17:51.256860 | debian-bookworm | changed: .d..t...... ./ 2026-08-11 03:17:51.295582 | 2026-08-11 03:17:51.295730 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-11 03:17:51.326126 | debian-bookworm | skipping: Conditional result was False 2026-08-11 03:17:51.338329 | debian-bookworm | skipping: Conditional result was False 2026-08-11 03:17:51.355933 | 2026-08-11 03:17:51.356075 | PLAY RECAP 2026-08-11 03:17:51.356126 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-11 03:17:51.356149 | 2026-08-11 03:17:51.513519 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-11 03:17:51.514452 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-11 03:17:52.409451 | 2026-08-11 03:17:52.409643 | PLAY [Base post] 2026-08-11 03:17:52.424995 | 2026-08-11 03:17:52.425160 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-11 03:17:53.005206 | debian-bookworm | changed 2026-08-11 03:17:53.012741 | 2026-08-11 03:17:53.012923 | PLAY RECAP 2026-08-11 03:17:53.013059 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-11 03:17:53.013181 | 2026-08-11 03:17:53.111856 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-11 03:17:53.112494 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-11 03:17:53.969556 | 2026-08-11 03:17:53.969687 | PLAY [Base post-logs] 2026-08-11 03:17:53.984752 | 2026-08-11 03:17:53.984887 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-11 03:17:54.461275 | localhost | changed 2026-08-11 03:17:54.474719 | 2026-08-11 03:17:54.474876 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-11 03:17:54.519568 | localhost | ok 2026-08-11 03:17:54.522395 | 2026-08-11 03:17:54.522478 | TASK [Set zuul-log-path fact] 2026-08-11 03:17:54.547052 | localhost | ok 2026-08-11 03:17:54.554817 | 2026-08-11 03:17:54.554949 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-11 03:17:54.579553 | localhost | ok 2026-08-11 03:17:54.582302 | 2026-08-11 03:17:54.582388 | TASK [upload-logs : Create log directories] 2026-08-11 03:17:55.239295 | localhost | changed 2026-08-11 03:17:55.241598 | 2026-08-11 03:17:55.241677 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-11 03:17:55.848447 | localhost -> localhost | ok: Runtime: 0:00:00.006819 2026-08-11 03:17:55.852164 | 2026-08-11 03:17:55.852265 | TASK [upload-logs : Upload logs to log server] 2026-08-11 03:17:56.479144 | localhost | Output suppressed because no_log was given 2026-08-11 03:17:56.480744 | 2026-08-11 03:17:56.480829 | LOOP [upload-logs : Compress console log and json output] 2026-08-11 03:17:56.547216 | localhost | skipping: Conditional result was False 2026-08-11 03:17:56.553642 | localhost | skipping: Conditional result was False 2026-08-11 03:17:56.556601 | 2026-08-11 03:17:56.556693 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-11 03:17:56.619808 | localhost | skipping: Conditional result was False 2026-08-11 03:17:56.620096 | 2026-08-11 03:17:56.641008 | localhost | skipping: Conditional result was False 2026-08-11 03:17:56.652700 | 2026-08-11 03:17:56.652814 | LOOP [upload-logs : Upload console log and json output]