2026-07-18 03:18:47.807287 | Job console starting 2026-07-18 03:18:47.824580 | Updating git repos 2026-07-18 03:18:47.863457 | Cloning repos into workspace 2026-07-18 03:18:47.940831 | Restoring repo states 2026-07-18 03:18:47.950626 | Merging changes 2026-07-18 03:18:47.950647 | Checking out repos 2026-07-18 03:18:48.001164 | Preparing playbooks 2026-07-18 03:18:48.837754 | Running Ansible setup 2026-07-18 03:18:53.229124 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-18 03:18:54.208073 | 2026-07-18 03:18:54.208262 | PLAY [Base pre] 2026-07-18 03:18:54.226409 | 2026-07-18 03:18:54.226556 | TASK [Setup log path fact] 2026-07-18 03:18:54.256536 | debian-bookworm | ok 2026-07-18 03:18:54.273222 | 2026-07-18 03:18:54.273363 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-18 03:18:54.312400 | debian-bookworm | ok 2026-07-18 03:18:54.322942 | 2026-07-18 03:18:54.323101 | TASK [emit-job-header : Print job information] 2026-07-18 03:18:54.366020 | # Job Information 2026-07-18 03:18:54.366291 | Ansible Version: 2.16.14 2026-07-18 03:18:54.366345 | Job: python-black 2026-07-18 03:18:54.366397 | Pipeline: periodic-daily 2026-07-18 03:18:54.366431 | Executor: 521e9411259a 2026-07-18 03:18:54.366463 | Triggered by: https://github.com/osism/openstack-simple-stress 2026-07-18 03:18:54.366499 | Event ID: 16fa74cd1b3b4cb1bbbba917d4ac9948 2026-07-18 03:18:54.378165 | 2026-07-18 03:18:54.378297 | LOOP [emit-job-header : Print node information] 2026-07-18 03:18:54.527152 | debian-bookworm | ok: 2026-07-18 03:18:54.527447 | debian-bookworm | # Node Information 2026-07-18 03:18:54.527497 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-18 03:18:54.527533 | debian-bookworm | Hostname: debian 2026-07-18 03:18:54.527564 | debian-bookworm | Username: zuul 2026-07-18 03:18:54.527594 | debian-bookworm | Distro: Debian 12.15 2026-07-18 03:18:54.527629 | debian-bookworm | Provider: regiocloud-a 2026-07-18 03:18:54.527659 | debian-bookworm | Region: 2026-07-18 03:18:54.527689 | debian-bookworm | Label: debian-bookworm 2026-07-18 03:18:54.527719 | debian-bookworm | Product Name: OpenStack Nova 2026-07-18 03:18:54.527747 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed7:749b 2026-07-18 03:18:54.552352 | 2026-07-18 03:18:54.552547 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-18 03:18:55.075135 | debian-bookworm -> localhost | changed 2026-07-18 03:18:55.083491 | 2026-07-18 03:18:55.083621 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-18 03:18:56.279402 | debian-bookworm -> localhost | changed 2026-07-18 03:18:56.299893 | 2026-07-18 03:18:56.300090 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-18 03:18:56.635292 | debian-bookworm -> localhost | ok 2026-07-18 03:18:56.651271 | 2026-07-18 03:18:56.651485 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-18 03:18:56.696243 | debian-bookworm | ok 2026-07-18 03:18:56.716709 | debian-bookworm | included: /var/lib/zuul/builds/c925585a6b8343f29e8782bbb30882b9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-18 03:18:56.725267 | 2026-07-18 03:18:56.725394 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-18 03:18:58.687529 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-18 03:18:58.687920 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c925585a6b8343f29e8782bbb30882b9/work/c925585a6b8343f29e8782bbb30882b9_id_rsa 2026-07-18 03:18:58.687972 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c925585a6b8343f29e8782bbb30882b9/work/c925585a6b8343f29e8782bbb30882b9_id_rsa.pub 2026-07-18 03:18:58.688001 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-18 03:18:58.688028 | debian-bookworm -> localhost | SHA256:4CUJeHTtlwi2cyxjwJkB1iD1XS5uM7NGKoCsHzozVDU zuul-build-sshkey 2026-07-18 03:18:58.688052 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-18 03:18:58.688086 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-18 03:18:58.688109 | debian-bookworm -> localhost | |..=B++... | 2026-07-18 03:18:58.688132 | debian-bookworm -> localhost | | o..BEo+. | 2026-07-18 03:18:58.688153 | debian-bookworm -> localhost | | .ooB=o. . | 2026-07-18 03:18:58.688173 | debian-bookworm -> localhost | |o . o*== o | 2026-07-18 03:18:58.688194 | debian-bookworm -> localhost | |o.. .O=S. | 2026-07-18 03:18:58.688221 | debian-bookworm -> localhost | |.o + = | 2026-07-18 03:18:58.688242 | debian-bookworm -> localhost | |o o . o | 2026-07-18 03:18:58.688263 | debian-bookworm -> localhost | |+o o . | 2026-07-18 03:18:58.688284 | debian-bookworm -> localhost | |.+. | 2026-07-18 03:18:58.688305 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-18 03:18:58.688370 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.359977 2026-07-18 03:18:58.701719 | 2026-07-18 03:18:58.701888 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-18 03:18:58.747207 | debian-bookworm | ok 2026-07-18 03:18:58.768322 | debian-bookworm | included: /var/lib/zuul/builds/c925585a6b8343f29e8782bbb30882b9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-18 03:18:58.787731 | 2026-07-18 03:18:58.787897 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-18 03:18:58.819315 | debian-bookworm | skipping: Conditional result was False 2026-07-18 03:18:58.826136 | 2026-07-18 03:18:58.826258 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-18 03:18:59.473461 | debian-bookworm | changed 2026-07-18 03:18:59.479586 | 2026-07-18 03:18:59.479719 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-18 03:18:59.725567 | debian-bookworm | ok 2026-07-18 03:18:59.735912 | 2026-07-18 03:18:59.736100 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-18 03:19:00.370175 | debian-bookworm | changed 2026-07-18 03:19:00.376147 | 2026-07-18 03:19:00.376282 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-18 03:19:01.052506 | debian-bookworm | changed 2026-07-18 03:19:01.062986 | 2026-07-18 03:19:01.063130 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-18 03:19:01.089661 | debian-bookworm | skipping: Conditional result was False 2026-07-18 03:19:01.098148 | 2026-07-18 03:19:01.098279 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-18 03:19:01.671815 | debian-bookworm -> localhost | changed 2026-07-18 03:19:01.692599 | 2026-07-18 03:19:01.692777 | TASK [add-build-sshkey : Add back temp key] 2026-07-18 03:19:02.151323 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c925585a6b8343f29e8782bbb30882b9/work/c925585a6b8343f29e8782bbb30882b9_id_rsa (zuul-build-sshkey) 2026-07-18 03:19:02.151859 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017557 2026-07-18 03:19:02.163853 | 2026-07-18 03:19:02.164024 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-18 03:19:02.638639 | debian-bookworm | ok 2026-07-18 03:19:02.648440 | 2026-07-18 03:19:02.648639 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-18 03:19:02.685511 | debian-bookworm | skipping: Conditional result was False 2026-07-18 03:19:02.722632 | 2026-07-18 03:19:02.722853 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-18 03:19:03.182670 | debian-bookworm | ok 2026-07-18 03:19:03.201971 | 2026-07-18 03:19:03.202123 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-18 03:19:03.250304 | debian-bookworm | ok 2026-07-18 03:19:03.256054 | 2026-07-18 03:19:03.256188 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-18 03:19:03.644646 | debian-bookworm -> localhost | ok 2026-07-18 03:19:03.652849 | 2026-07-18 03:19:03.652975 | TASK [validate-host : Collect information about the host] 2026-07-18 03:19:04.796672 | debian-bookworm | ok 2026-07-18 03:19:04.810454 | 2026-07-18 03:19:04.811010 | TASK [validate-host : Sanitize hostname] 2026-07-18 03:19:05.005548 | debian-bookworm | ok 2026-07-18 03:19:05.012253 | 2026-07-18 03:19:05.012400 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-18 03:19:05.632398 | debian-bookworm -> localhost | changed 2026-07-18 03:19:05.641091 | 2026-07-18 03:19:05.641244 | TASK [validate-host : Collect information about zuul worker] 2026-07-18 03:19:06.069290 | debian-bookworm | ok 2026-07-18 03:19:06.075719 | 2026-07-18 03:19:06.075869 | TASK [validate-host : Write out all zuul information for each host] 2026-07-18 03:19:06.675713 | debian-bookworm -> localhost | changed 2026-07-18 03:19:06.686403 | 2026-07-18 03:19:06.686546 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-18 03:19:06.943461 | debian-bookworm | ok 2026-07-18 03:19:06.951616 | 2026-07-18 03:19:06.951760 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-18 03:19:07.816894 | debian-bookworm | changed: 2026-07-18 03:19:07.817206 | debian-bookworm | cd+++++++++ src/ 2026-07-18 03:19:07.817245 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-18 03:19:07.817270 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-18 03:19:07.817292 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2026-07-18 03:19:07.817313 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/c925585a6b8343f29e8782bbb30882b9/work/logs" 2026-07-18 03:20:08.619369 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c925585a6b8343f29e8782bbb30882b9/work/artifacts" 2026-07-18 03:20:08.926266 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c925585a6b8343f29e8782bbb30882b9/work/docs" 2026-07-18 03:20:08.940898 | 2026-07-18 03:20:08.941059 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-18 03:20:10.039612 | debian-bookworm | changed: 2026-07-18 03:20:10.039907 | debian-bookworm | .d..t...... ./ 2026-07-18 03:20:10.039973 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-18 03:20:10.040000 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-18 03:20:10.040022 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-18 03:20:10.040044 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-18 03:20:10.040065 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-18 03:20:10.040108 | debian-bookworm | changed: All items complete 2026-07-18 03:20:10.040130 | 2026-07-18 03:20:10.657289 | debian-bookworm | changed: .d..t...... ./ 2026-07-18 03:20:11.946925 | debian-bookworm | changed: .d..t...... ./ 2026-07-18 03:20:11.986624 | 2026-07-18 03:20:11.986827 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-18 03:20:12.149532 | debian-bookworm | skipping: Conditional result was False 2026-07-18 03:20:12.178184 | debian-bookworm | skipping: Conditional result was False 2026-07-18 03:20:12.189811 | 2026-07-18 03:20:12.189966 | PLAY RECAP 2026-07-18 03:20:12.190052 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-18 03:20:12.190082 | 2026-07-18 03:20:12.932202 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-18 03:20:12.933123 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-18 03:20:15.276573 | 2026-07-18 03:20:15.276804 | PLAY [Base post] 2026-07-18 03:20:15.308016 | 2026-07-18 03:20:15.308210 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-18 03:20:15.999091 | debian-bookworm | changed 2026-07-18 03:20:16.021999 | 2026-07-18 03:20:16.022195 | PLAY RECAP 2026-07-18 03:20:16.022268 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-18 03:20:16.022334 | 2026-07-18 03:20:16.245852 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-18 03:20:16.246796 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-18 03:20:17.476009 | 2026-07-18 03:20:17.476585 | PLAY [Base post-logs] 2026-07-18 03:20:17.489452 | 2026-07-18 03:20:17.489625 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-18 03:20:18.613252 | localhost | changed 2026-07-18 03:20:18.701803 | 2026-07-18 03:20:18.702696 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-18 03:20:18.819030 | localhost | ok 2026-07-18 03:20:18.831118 | 2026-07-18 03:20:18.831261 | TASK [Set zuul-log-path fact] 2026-07-18 03:20:18.904348 | localhost | ok 2026-07-18 03:20:18.923908 | 2026-07-18 03:20:18.924788 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-18 03:20:19.035449 | localhost | ok 2026-07-18 03:20:19.109148 | 2026-07-18 03:20:19.110029 | TASK [upload-logs : Create log directories] 2026-07-18 03:20:20.515234 | localhost | changed 2026-07-18 03:20:20.518124 | 2026-07-18 03:20:20.518223 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-18 03:20:21.524247 | localhost -> localhost | ok: Runtime: 0:00:00.020038 2026-07-18 03:20:21.527959 | 2026-07-18 03:20:21.528055 | TASK [upload-logs : Upload logs to log server] 2026-07-18 03:20:22.008848 | localhost | Output suppressed because no_log was given 2026-07-18 03:20:22.010493 | 2026-07-18 03:20:22.010577 | LOOP [upload-logs : Compress console log and json output] 2026-07-18 03:20:22.055417 | localhost | skipping: Conditional result was False 2026-07-18 03:20:22.059725 | localhost | skipping: Conditional result was False 2026-07-18 03:20:22.070012 | 2026-07-18 03:20:22.070130 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-18 03:20:22.111535 | localhost | skipping: Conditional result was False 2026-07-18 03:20:22.111990 | 2026-07-18 03:20:22.115235 | localhost | skipping: Conditional result was False 2026-07-18 03:20:22.136745 | 2026-07-18 03:20:22.136878 | LOOP [upload-logs : Upload console log and json output]