2026-07-05 12:50:10.708002 | Job console starting 2026-07-05 12:50:10.725944 | Updating git repos 2026-07-05 12:50:10.753298 | Cloning repos into workspace 2026-07-05 12:50:10.798046 | Restoring repo states 2026-07-05 12:50:10.803230 | Merging changes 2026-07-05 12:50:11.294261 | Checking out repos 2026-07-05 12:50:11.319517 | Preparing playbooks 2026-07-05 12:50:12.512158 | Running Ansible setup 2026-07-05 12:50:17.312894 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-05 12:50:18.133634 | 2026-07-05 12:50:18.133797 | PLAY [Base pre] 2026-07-05 12:50:18.152593 | 2026-07-05 12:50:18.152763 | TASK [Setup log path fact] 2026-07-05 12:50:18.172862 | debian-bookworm | ok 2026-07-05 12:50:18.192263 | 2026-07-05 12:50:18.192465 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-05 12:50:18.221353 | debian-bookworm | ok 2026-07-05 12:50:18.232043 | 2026-07-05 12:50:18.232166 | TASK [emit-job-header : Print job information] 2026-07-05 12:50:18.271530 | # Job Information 2026-07-05 12:50:18.271725 | Ansible Version: 2.16.14 2026-07-05 12:50:18.271761 | Job: python-black 2026-07-05 12:50:18.271793 | Pipeline: check 2026-07-05 12:50:18.271816 | Executor: 521e9411259a 2026-07-05 12:50:18.271836 | Triggered by: https://github.com/osism/openstack-simple-stress/pull/296 2026-07-05 12:50:18.271858 | Event ID: 088cc6f0-7870-11f1-9cfe-29dddf78e418 2026-07-05 12:50:18.276928 | 2026-07-05 12:50:18.277045 | LOOP [emit-job-header : Print node information] 2026-07-05 12:50:18.402271 | debian-bookworm | ok: 2026-07-05 12:50:18.402717 | debian-bookworm | # Node Information 2026-07-05 12:50:18.402827 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-05 12:50:18.402943 | debian-bookworm | Hostname: debian 2026-07-05 12:50:18.403002 | debian-bookworm | Username: zuul 2026-07-05 12:50:18.403058 | debian-bookworm | Distro: Debian 12.14 2026-07-05 12:50:18.403120 | debian-bookworm | Provider: regiocloud-a 2026-07-05 12:50:18.403174 | debian-bookworm | Region: 2026-07-05 12:50:18.403230 | debian-bookworm | Label: debian-bookworm 2026-07-05 12:50:18.403279 | debian-bookworm | Product Name: OpenStack Nova 2026-07-05 12:50:18.403329 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe28:f811 2026-07-05 12:50:18.427148 | 2026-07-05 12:50:18.427336 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-05 12:50:19.151985 | debian-bookworm -> localhost | changed 2026-07-05 12:50:19.160279 | 2026-07-05 12:50:19.160464 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-05 12:50:20.570589 | debian-bookworm -> localhost | changed 2026-07-05 12:50:20.582049 | 2026-07-05 12:50:20.582193 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-05 12:50:21.036049 | debian-bookworm -> localhost | ok 2026-07-05 12:50:21.041081 | 2026-07-05 12:50:21.041176 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-05 12:50:21.059808 | debian-bookworm | ok 2026-07-05 12:50:21.075295 | debian-bookworm | included: /var/lib/zuul/builds/91a3d812cc424bdea3ea501a4579bc3d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-05 12:50:21.080240 | 2026-07-05 12:50:21.080320 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-05 12:50:22.240048 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-05 12:50:22.240250 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/91a3d812cc424bdea3ea501a4579bc3d/work/91a3d812cc424bdea3ea501a4579bc3d_id_rsa 2026-07-05 12:50:22.240284 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/91a3d812cc424bdea3ea501a4579bc3d/work/91a3d812cc424bdea3ea501a4579bc3d_id_rsa.pub 2026-07-05 12:50:22.240306 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-05 12:50:22.240327 | debian-bookworm -> localhost | SHA256:jg7xmZTth+hM8NtTABpY5Cd9QiT2niRLINnk9JTXxEg zuul-build-sshkey 2026-07-05 12:50:22.240346 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-05 12:50:22.240374 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-05 12:50:22.240393 | debian-bookworm -> localhost | |.+++*+E=. | 2026-07-05 12:50:22.240411 | debian-bookworm -> localhost | |.+o*o=+ o | 2026-07-05 12:50:22.240454 | debian-bookworm -> localhost | | . *+*.. | 2026-07-05 12:50:22.240472 | debian-bookworm -> localhost | | ..B *. | 2026-07-05 12:50:22.240489 | debian-bookworm -> localhost | | + = S. | 2026-07-05 12:50:22.240509 | debian-bookworm -> localhost | | * B .. | 2026-07-05 12:50:22.240527 | debian-bookworm -> localhost | | . O +.. | 2026-07-05 12:50:22.240544 | debian-bookworm -> localhost | | * o.. | 2026-07-05 12:50:22.240561 | debian-bookworm -> localhost | | = .. | 2026-07-05 12:50:22.240577 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-05 12:50:22.240621 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.640077 2026-07-05 12:50:22.245836 | 2026-07-05 12:50:22.245922 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-05 12:50:22.285968 | debian-bookworm | ok 2026-07-05 12:50:22.304331 | debian-bookworm | included: /var/lib/zuul/builds/91a3d812cc424bdea3ea501a4579bc3d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-05 12:50:22.318659 | 2026-07-05 12:50:22.318754 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-05 12:50:22.364355 | debian-bookworm | skipping: Conditional result was False 2026-07-05 12:50:22.370279 | 2026-07-05 12:50:22.370377 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-05 12:50:23.030054 | debian-bookworm | changed 2026-07-05 12:50:23.038252 | 2026-07-05 12:50:23.038376 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-05 12:50:23.282340 | debian-bookworm | ok 2026-07-05 12:50:23.292610 | 2026-07-05 12:50:23.292722 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-05 12:50:23.938111 | debian-bookworm | changed 2026-07-05 12:50:23.944252 | 2026-07-05 12:50:23.944350 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-05 12:50:24.560744 | debian-bookworm | changed 2026-07-05 12:50:24.567383 | 2026-07-05 12:50:24.567490 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-05 12:50:24.590672 | debian-bookworm | skipping: Conditional result was False 2026-07-05 12:50:24.601259 | 2026-07-05 12:50:24.601469 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-05 12:50:25.032957 | debian-bookworm -> localhost | changed 2026-07-05 12:50:25.043451 | 2026-07-05 12:50:25.043568 | TASK [add-build-sshkey : Add back temp key] 2026-07-05 12:50:25.344681 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/91a3d812cc424bdea3ea501a4579bc3d/work/91a3d812cc424bdea3ea501a4579bc3d_id_rsa (zuul-build-sshkey) 2026-07-05 12:50:25.344924 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010349 2026-07-05 12:50:25.352481 | 2026-07-05 12:50:25.352577 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-05 12:50:25.729360 | debian-bookworm | ok 2026-07-05 12:50:25.735253 | 2026-07-05 12:50:25.735352 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-05 12:50:25.758960 | debian-bookworm | skipping: Conditional result was False 2026-07-05 12:50:25.768963 | 2026-07-05 12:50:25.769053 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-05 12:50:26.166674 | debian-bookworm | ok 2026-07-05 12:50:26.177978 | 2026-07-05 12:50:26.178091 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-05 12:50:26.218335 | debian-bookworm | ok 2026-07-05 12:50:26.223352 | 2026-07-05 12:50:26.223453 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-05 12:50:26.495517 | debian-bookworm -> localhost | ok 2026-07-05 12:50:26.501675 | 2026-07-05 12:50:26.501769 | TASK [validate-host : Collect information about the host] 2026-07-05 12:50:27.663479 | debian-bookworm | ok 2026-07-05 12:50:27.675517 | 2026-07-05 12:50:27.675645 | TASK [validate-host : Sanitize hostname] 2026-07-05 12:50:27.803939 | debian-bookworm | ok 2026-07-05 12:50:27.808574 | 2026-07-05 12:50:27.808688 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-05 12:50:28.328392 | debian-bookworm -> localhost | changed 2026-07-05 12:50:28.333990 | 2026-07-05 12:50:28.334093 | TASK [validate-host : Collect information about zuul worker] 2026-07-05 12:50:28.722609 | debian-bookworm | ok 2026-07-05 12:50:28.728576 | 2026-07-05 12:50:28.728675 | TASK [validate-host : Write out all zuul information for each host] 2026-07-05 12:50:29.213921 | debian-bookworm -> localhost | changed 2026-07-05 12:50:29.232389 | 2026-07-05 12:50:29.232556 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-05 12:50:29.504486 | debian-bookworm | ok 2026-07-05 12:50:29.509850 | 2026-07-05 12:50:29.509942 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-05 12:50:30.316934 | debian-bookworm | changed: 2026-07-05 12:50:30.317115 | debian-bookworm | cd+++++++++ src/ 2026-07-05 12:50:30.317148 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-05 12:50:30.317173 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-05 12:50:30.317195 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2026-07-05 12:50:30.317216 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/91a3d812cc424bdea3ea501a4579bc3d/work/logs" 2026-07-05 12:51:33.459318 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/91a3d812cc424bdea3ea501a4579bc3d/work/artifacts" 2026-07-05 12:51:33.936310 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/91a3d812cc424bdea3ea501a4579bc3d/work/docs" 2026-07-05 12:51:33.951243 | 2026-07-05 12:51:33.951418 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-05 12:51:34.791500 | debian-bookworm | changed: 2026-07-05 12:51:34.791890 | debian-bookworm | .d..t...... ./ 2026-07-05 12:51:34.791949 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-05 12:51:34.791975 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-05 12:51:34.791997 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-05 12:51:34.792018 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-05 12:51:34.792047 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-05 12:51:34.792095 | debian-bookworm | changed: All items complete 2026-07-05 12:51:34.792121 | 2026-07-05 12:51:35.579494 | debian-bookworm | changed: .d..t...... ./ 2026-07-05 12:51:36.417823 | debian-bookworm | changed: .d..t...... ./ 2026-07-05 12:51:36.435888 | 2026-07-05 12:51:36.436011 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-05 12:51:36.866171 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.024237 2026-07-05 12:51:37.571327 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.021660 2026-07-05 12:51:37.584364 | 2026-07-05 12:51:37.584468 | PLAY RECAP 2026-07-05 12:51:37.584520 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-05 12:51:37.584544 | 2026-07-05 12:51:37.875596 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-05 12:51:37.876283 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-05 12:51:39.001118 | 2026-07-05 12:51:39.001251 | PLAY [Base post] 2026-07-05 12:51:39.034400 | 2026-07-05 12:51:39.034528 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-05 12:51:39.662928 | debian-bookworm | changed 2026-07-05 12:51:39.667983 | 2026-07-05 12:51:39.668061 | PLAY RECAP 2026-07-05 12:51:39.668111 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-05 12:51:39.668164 | 2026-07-05 12:51:39.808479 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-05 12:51:39.809249 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-05 12:51:40.942396 | 2026-07-05 12:51:40.942530 | PLAY [Base post-logs] 2026-07-05 12:51:40.951968 | 2026-07-05 12:51:40.952082 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-05 12:51:41.896955 | localhost | changed 2026-07-05 12:51:41.905143 | 2026-07-05 12:51:41.905254 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-05 12:51:41.949716 | localhost | ok 2026-07-05 12:51:41.954033 | 2026-07-05 12:51:41.954155 | TASK [Set zuul-log-path fact] 2026-07-05 12:51:42.056083 | localhost | ok 2026-07-05 12:51:42.066212 | 2026-07-05 12:51:42.066311 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-05 12:51:42.139303 | localhost | ok 2026-07-05 12:51:42.142384 | 2026-07-05 12:51:42.142472 | TASK [upload-logs : Create log directories] 2026-07-05 12:51:42.961763 | localhost | changed 2026-07-05 12:51:42.963991 | 2026-07-05 12:51:42.964069 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-05 12:51:43.529399 | localhost -> localhost | ok: Runtime: 0:00:00.008313 2026-07-05 12:51:43.532612 | 2026-07-05 12:51:43.532697 | TASK [upload-logs : Upload logs to log server] 2026-07-05 12:51:44.143813 | localhost | Output suppressed because no_log was given 2026-07-05 12:51:44.145295 | 2026-07-05 12:51:44.145384 | LOOP [upload-logs : Compress console log and json output] 2026-07-05 12:51:44.194827 | localhost | skipping: Conditional result was False 2026-07-05 12:51:44.201619 | localhost | skipping: Conditional result was False 2026-07-05 12:51:44.211395 | 2026-07-05 12:51:44.211482 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-05 12:51:44.255029 | localhost | skipping: Conditional result was False 2026-07-05 12:51:44.255259 | 2026-07-05 12:51:44.261656 | localhost | skipping: Conditional result was False 2026-07-05 12:51:44.267907 | 2026-07-05 12:51:44.267988 | LOOP [upload-logs : Upload console log and json output]