2026-09-24 03:15:56.188999 | Job console starting 2026-09-24 03:15:56.205226 | Updating git repos 2026-09-24 03:15:56.238261 | Cloning repos into workspace 2026-09-24 03:15:56.309523 | Restoring repo states 2026-09-24 03:15:56.319324 | Merging changes 2026-09-24 03:15:56.319343 | Checking out repos 2026-09-24 03:15:56.393879 | Preparing playbooks 2026-09-24 03:15:57.278039 | Running Ansible setup 2026-09-24 03:16:02.149971 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-24 03:16:03.234540 | 2026-09-24 03:16:03.234711 | PLAY [Base pre] 2026-09-24 03:16:03.253499 | 2026-09-24 03:16:03.253653 | TASK [Setup log path fact] 2026-09-24 03:16:03.273053 | debian-bookworm | ok 2026-09-24 03:16:03.309370 | 2026-09-24 03:16:03.309531 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-24 03:16:03.370376 | debian-bookworm | ok 2026-09-24 03:16:03.381022 | 2026-09-24 03:16:03.381155 | TASK [emit-job-header : Print job information] 2026-09-24 03:16:03.462250 | # Job Information 2026-09-24 03:16:03.462450 | Ansible Version: 2.16.14 2026-09-24 03:16:03.462488 | Job: python-black 2026-09-24 03:16:03.462521 | Pipeline: periodic-daily 2026-09-24 03:16:03.462545 | Executor: 521e9411259a 2026-09-24 03:16:03.462566 | Triggered by: https://github.com/osism/openstack-simple-stress 2026-09-24 03:16:03.462588 | Event ID: 33a039b57c434c24a4d25cbe51e88ff5 2026-09-24 03:16:03.468179 | 2026-09-24 03:16:03.468300 | LOOP [emit-job-header : Print node information] 2026-09-24 03:16:03.577652 | debian-bookworm | ok: 2026-09-24 03:16:03.577927 | debian-bookworm | # Node Information 2026-09-24 03:16:03.578008 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-24 03:16:03.578035 | debian-bookworm | Hostname: debian 2026-09-24 03:16:03.578056 | debian-bookworm | Username: zuul 2026-09-24 03:16:03.578076 | debian-bookworm | Distro: Debian 12.15 2026-09-24 03:16:03.578104 | debian-bookworm | Provider: regiocloud-a 2026-09-24 03:16:03.578126 | debian-bookworm | Region: 2026-09-24 03:16:03.578148 | debian-bookworm | Label: debian-bookworm 2026-09-24 03:16:03.578167 | debian-bookworm | Product Name: OpenStack Nova 2026-09-24 03:16:03.578186 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2a:fb11 2026-09-24 03:16:03.594192 | 2026-09-24 03:16:03.594329 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-24 03:16:04.303137 | debian-bookworm -> localhost | changed 2026-09-24 03:16:04.309434 | 2026-09-24 03:16:04.309538 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-24 03:16:05.390948 | debian-bookworm -> localhost | changed 2026-09-24 03:16:05.402365 | 2026-09-24 03:16:05.402463 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-24 03:16:05.637322 | debian-bookworm -> localhost | ok 2026-09-24 03:16:05.643227 | 2026-09-24 03:16:05.643321 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-24 03:16:05.668094 | debian-bookworm | ok 2026-09-24 03:16:05.691770 | debian-bookworm | included: /var/lib/zuul/builds/d32be0853e06413ea4c428970cdca991/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-24 03:16:05.697589 | 2026-09-24 03:16:05.697672 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-24 03:16:06.820184 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-24 03:16:06.820365 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d32be0853e06413ea4c428970cdca991/work/d32be0853e06413ea4c428970cdca991_id_rsa 2026-09-24 03:16:06.820403 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d32be0853e06413ea4c428970cdca991/work/d32be0853e06413ea4c428970cdca991_id_rsa.pub 2026-09-24 03:16:06.820429 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-24 03:16:06.820453 | debian-bookworm -> localhost | SHA256:TXgZuidPcUY6okCF7AdBhWAzhDwcJitRvN/C4zidsTE zuul-build-sshkey 2026-09-24 03:16:06.820476 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-24 03:16:06.820507 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-24 03:16:06.820529 | debian-bookworm -> localhost | |=BO++*o . . | 2026-09-24 03:16:06.820550 | debian-bookworm -> localhost | |+B.+= o = | 2026-09-24 03:16:06.820570 | debian-bookworm -> localhost | |o .o.. + B o | 2026-09-24 03:16:06.820589 | debian-bookworm -> localhost | |. . .... * = | 2026-09-24 03:16:06.820609 | debian-bookworm -> localhost | | o o. S + | 2026-09-24 03:16:06.820630 | debian-bookworm -> localhost | | E . = | 2026-09-24 03:16:06.820650 | debian-bookworm -> localhost | | + O . | 2026-09-24 03:16:06.820669 | debian-bookworm -> localhost | | o = | 2026-09-24 03:16:06.820690 | debian-bookworm -> localhost | | . | 2026-09-24 03:16:06.820710 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-24 03:16:06.820757 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.690479 2026-09-24 03:16:06.826879 | 2026-09-24 03:16:06.826990 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-24 03:16:06.854175 | debian-bookworm | ok 2026-09-24 03:16:06.872878 | debian-bookworm | included: /var/lib/zuul/builds/d32be0853e06413ea4c428970cdca991/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-24 03:16:06.887276 | 2026-09-24 03:16:06.887386 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-24 03:16:06.902512 | debian-bookworm | skipping: Conditional result was False 2026-09-24 03:16:06.909888 | 2026-09-24 03:16:06.910026 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-24 03:16:07.678947 | debian-bookworm | changed 2026-09-24 03:16:07.683481 | 2026-09-24 03:16:07.683561 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-24 03:16:08.009079 | debian-bookworm | ok 2026-09-24 03:16:08.024345 | 2026-09-24 03:16:08.024439 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-24 03:16:08.914035 | debian-bookworm | changed 2026-09-24 03:16:08.919356 | 2026-09-24 03:16:08.919433 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-24 03:16:09.761098 | debian-bookworm | changed 2026-09-24 03:16:09.773381 | 2026-09-24 03:16:09.773471 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-24 03:16:09.833305 | debian-bookworm | skipping: Conditional result was False 2026-09-24 03:16:09.842220 | 2026-09-24 03:16:09.842304 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-24 03:16:10.767880 | debian-bookworm -> localhost | changed 2026-09-24 03:16:10.778761 | 2026-09-24 03:16:10.778846 | TASK [add-build-sshkey : Add back temp key] 2026-09-24 03:16:11.427005 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d32be0853e06413ea4c428970cdca991/work/d32be0853e06413ea4c428970cdca991_id_rsa (zuul-build-sshkey) 2026-09-24 03:16:11.427216 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.033113 2026-09-24 03:16:11.434378 | 2026-09-24 03:16:11.434481 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-24 03:16:11.937712 | debian-bookworm | ok 2026-09-24 03:16:11.942593 | 2026-09-24 03:16:11.942674 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-24 03:16:11.966201 | debian-bookworm | skipping: Conditional result was False 2026-09-24 03:16:11.981088 | 2026-09-24 03:16:11.981189 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-24 03:16:12.488029 | debian-bookworm | ok 2026-09-24 03:16:12.498797 | 2026-09-24 03:16:12.498886 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-24 03:16:12.527149 | debian-bookworm | ok 2026-09-24 03:16:12.533201 | 2026-09-24 03:16:12.533296 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-24 03:16:12.937812 | debian-bookworm -> localhost | ok 2026-09-24 03:16:12.944504 | 2026-09-24 03:16:12.944591 | TASK [validate-host : Collect information about the host] 2026-09-24 03:16:14.393961 | debian-bookworm | ok 2026-09-24 03:16:14.418086 | 2026-09-24 03:16:14.418187 | TASK [validate-host : Sanitize hostname] 2026-09-24 03:16:14.543322 | debian-bookworm | ok 2026-09-24 03:16:14.556972 | 2026-09-24 03:16:14.557073 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-24 03:16:15.285306 | debian-bookworm -> localhost | changed 2026-09-24 03:16:15.290816 | 2026-09-24 03:16:15.290907 | TASK [validate-host : Collect information about zuul worker] 2026-09-24 03:16:15.709536 | debian-bookworm | ok 2026-09-24 03:16:15.713354 | 2026-09-24 03:16:15.713430 | TASK [validate-host : Write out all zuul information for each host] 2026-09-24 03:16:16.266663 | debian-bookworm -> localhost | changed 2026-09-24 03:16:16.275875 | 2026-09-24 03:16:16.275975 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-24 03:16:16.534344 | debian-bookworm | ok 2026-09-24 03:16:16.551585 | 2026-09-24 03:16:16.551815 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-24 03:16:17.368839 | debian-bookworm | changed: 2026-09-24 03:16:17.369034 | debian-bookworm | cd+++++++++ src/ 2026-09-24 03:16:17.369066 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-24 03:16:17.369086 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-24 03:16:17.369104 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2026-09-24 03:16:17.369121 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/d32be0853e06413ea4c428970cdca991/work/logs" 2026-09-24 03:17:24.420883 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d32be0853e06413ea4c428970cdca991/work/artifacts" 2026-09-24 03:17:24.683291 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d32be0853e06413ea4c428970cdca991/work/docs" 2026-09-24 03:17:24.697768 | 2026-09-24 03:17:24.697936 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-24 03:17:25.498699 | debian-bookworm | changed: 2026-09-24 03:17:25.499115 | debian-bookworm | .d..t...... ./ 2026-09-24 03:17:25.499184 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-24 03:17:25.499677 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-24 03:17:25.499729 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-24 03:17:25.499765 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-24 03:17:25.499789 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-24 03:17:25.499842 | debian-bookworm | changed: All items complete 2026-09-24 03:17:25.499874 | 2026-09-24 03:17:26.143011 | debian-bookworm | changed: .d..t...... ./ 2026-09-24 03:17:26.682195 | debian-bookworm | changed: .d..t...... ./ 2026-09-24 03:17:26.708939 | 2026-09-24 03:17:26.709300 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-24 03:17:26.741446 | debian-bookworm | skipping: Conditional result was False 2026-09-24 03:17:26.746506 | debian-bookworm | skipping: Conditional result was False 2026-09-24 03:17:26.765607 | 2026-09-24 03:17:26.765719 | PLAY RECAP 2026-09-24 03:17:26.765876 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-24 03:17:26.765905 | 2026-09-24 03:17:26.920140 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-24 03:17:26.921397 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-24 03:17:27.807242 | 2026-09-24 03:17:27.807426 | PLAY [Base post] 2026-09-24 03:17:27.831433 | 2026-09-24 03:17:27.831597 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-24 03:17:28.524602 | debian-bookworm | changed 2026-09-24 03:17:28.531592 | 2026-09-24 03:17:28.531713 | PLAY RECAP 2026-09-24 03:17:28.531781 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-24 03:17:28.531847 | 2026-09-24 03:17:28.661195 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-24 03:17:28.662383 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-24 03:17:29.516259 | 2026-09-24 03:17:29.516430 | PLAY [Base post-logs] 2026-09-24 03:17:29.527639 | 2026-09-24 03:17:29.527780 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-24 03:17:29.991758 | localhost | changed 2026-09-24 03:17:30.006583 | 2026-09-24 03:17:30.006858 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-24 03:17:30.033250 | localhost | ok 2026-09-24 03:17:30.036626 | 2026-09-24 03:17:30.036732 | TASK [Set zuul-log-path fact] 2026-09-24 03:17:30.052430 | localhost | ok 2026-09-24 03:17:30.061044 | 2026-09-24 03:17:30.061156 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-24 03:17:30.086454 | localhost | ok 2026-09-24 03:17:30.089677 | 2026-09-24 03:17:30.089787 | TASK [upload-logs : Create log directories] 2026-09-24 03:17:30.643186 | localhost | changed 2026-09-24 03:17:30.646192 | 2026-09-24 03:17:30.646306 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-24 03:17:31.159930 | localhost -> localhost | ok: Runtime: 0:00:00.007269 2026-09-24 03:17:31.164566 | 2026-09-24 03:17:31.164683 | TASK [upload-logs : Upload logs to log server] 2026-09-24 03:17:31.822208 | localhost | Output suppressed because no_log was given 2026-09-24 03:17:31.825220 | 2026-09-24 03:17:31.825367 | LOOP [upload-logs : Compress console log and json output] 2026-09-24 03:17:31.885374 | localhost | skipping: Conditional result was False 2026-09-24 03:17:31.891432 | localhost | skipping: Conditional result was False 2026-09-24 03:17:31.903370 | 2026-09-24 03:17:31.903509 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-24 03:17:31.955258 | localhost | skipping: Conditional result was False 2026-09-24 03:17:31.955647 | 2026-09-24 03:17:31.960154 | localhost | skipping: Conditional result was False 2026-09-24 03:17:31.968428 | 2026-09-24 03:17:31.968574 | LOOP [upload-logs : Upload console log and json output]