2026-09-12 01:57:42.821523 | Job console starting 2026-09-12 01:57:42.832229 | Updating git repos 2026-09-12 01:57:42.858562 | Cloning repos into workspace 2026-09-12 01:57:42.940815 | Restoring repo states 2026-09-12 01:57:42.958545 | Merging changes 2026-09-12 01:57:43.507914 | Checking out repos 2026-09-12 01:57:43.572795 | Preparing playbooks 2026-09-12 01:57:44.813757 | Running Ansible setup 2026-09-12 01:57:49.786305 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-12 01:57:50.717887 | 2026-09-12 01:57:50.718030 | PLAY [Base pre] 2026-09-12 01:57:50.735628 | 2026-09-12 01:57:50.735797 | TASK [Setup log path fact] 2026-09-12 01:57:50.763610 | debian-bookworm | ok 2026-09-12 01:57:50.783145 | 2026-09-12 01:57:50.783269 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-12 01:57:50.810842 | debian-bookworm | ok 2026-09-12 01:57:50.827311 | 2026-09-12 01:57:50.827408 | TASK [emit-job-header : Print job information] 2026-09-12 01:57:50.869443 | # Job Information 2026-09-12 01:57:50.869627 | Ansible Version: 2.16.14 2026-09-12 01:57:50.869663 | Job: python-black 2026-09-12 01:57:50.869696 | Pipeline: check 2026-09-12 01:57:50.869719 | Executor: 521e9411259a 2026-09-12 01:57:50.869739 | Triggered by: https://github.com/osism/openstack-simple-stress/pull/353 2026-09-12 01:57:50.869761 | Event ID: 50552c30-ae4d-11f1-807c-0206f5529365 2026-09-12 01:57:50.874455 | 2026-09-12 01:57:50.874555 | LOOP [emit-job-header : Print node information] 2026-09-12 01:57:50.992146 | debian-bookworm | ok: 2026-09-12 01:57:50.992351 | debian-bookworm | # Node Information 2026-09-12 01:57:50.992388 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-12 01:57:50.992414 | debian-bookworm | Hostname: debian 2026-09-12 01:57:50.992436 | debian-bookworm | Username: zuul 2026-09-12 01:57:50.992458 | debian-bookworm | Distro: Debian 12.15 2026-09-12 01:57:50.992481 | debian-bookworm | Provider: regiocloud-a 2026-09-12 01:57:50.992502 | debian-bookworm | Region: 2026-09-12 01:57:50.992524 | debian-bookworm | Label: debian-bookworm 2026-09-12 01:57:50.992545 | debian-bookworm | Product Name: OpenStack Nova 2026-09-12 01:57:50.992564 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe28:8055 2026-09-12 01:57:51.012042 | 2026-09-12 01:57:51.012149 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-12 01:57:51.572720 | debian-bookworm -> localhost | changed 2026-09-12 01:57:51.579504 | 2026-09-12 01:57:51.579604 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-12 01:57:52.628214 | debian-bookworm -> localhost | changed 2026-09-12 01:57:52.636784 | 2026-09-12 01:57:52.636872 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-12 01:57:52.990442 | debian-bookworm -> localhost | ok 2026-09-12 01:57:52.995309 | 2026-09-12 01:57:52.995390 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-12 01:57:53.032905 | debian-bookworm | ok 2026-09-12 01:57:53.048702 | debian-bookworm | included: /var/lib/zuul/builds/b1342e6045d64b9eb1b01f97143be666/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-12 01:57:53.053361 | 2026-09-12 01:57:53.053430 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-12 01:57:56.496511 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-12 01:57:56.496757 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b1342e6045d64b9eb1b01f97143be666/work/b1342e6045d64b9eb1b01f97143be666_id_rsa 2026-09-12 01:57:56.496812 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b1342e6045d64b9eb1b01f97143be666/work/b1342e6045d64b9eb1b01f97143be666_id_rsa.pub 2026-09-12 01:57:56.496851 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-12 01:57:56.496887 | debian-bookworm -> localhost | SHA256:WrI4GmeZSDG87CbTCpKzbA8TNnnGCjJx68r2gq9lXhM zuul-build-sshkey 2026-09-12 01:57:56.496919 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-12 01:57:56.496960 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-12 01:57:56.497009 | debian-bookworm -> localhost | | | 2026-09-12 01:57:56.497041 | debian-bookworm -> localhost | | . | 2026-09-12 01:57:56.497069 | debian-bookworm -> localhost | |. = | 2026-09-12 01:57:56.497097 | debian-bookworm -> localhost | | +o= | 2026-09-12 01:57:56.497125 | debian-bookworm -> localhost | |+==+E . S | 2026-09-12 01:57:56.497160 | debian-bookworm -> localhost | |+B*. = = | 2026-09-12 01:57:56.497189 | debian-bookworm -> localhost | |O+X X o | 2026-09-12 01:57:56.497216 | debian-bookworm -> localhost | |*/o* o | 2026-09-12 01:57:56.497246 | debian-bookworm -> localhost | |B=Bo | 2026-09-12 01:57:56.497274 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-12 01:57:56.497345 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.737958 2026-09-12 01:57:56.505315 | 2026-09-12 01:57:56.505416 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-12 01:57:56.539055 | debian-bookworm | ok 2026-09-12 01:57:56.549932 | debian-bookworm | included: /var/lib/zuul/builds/b1342e6045d64b9eb1b01f97143be666/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-12 01:57:56.582081 | 2026-09-12 01:57:56.582197 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-12 01:57:56.615152 | debian-bookworm | skipping: Conditional result was False 2026-09-12 01:57:56.620684 | 2026-09-12 01:57:56.620776 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-12 01:57:57.225963 | debian-bookworm | changed 2026-09-12 01:57:57.231300 | 2026-09-12 01:57:57.239913 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-12 01:57:57.529862 | debian-bookworm | ok 2026-09-12 01:57:57.535257 | 2026-09-12 01:57:57.535350 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-12 01:57:58.169852 | debian-bookworm | changed 2026-09-12 01:57:58.174904 | 2026-09-12 01:57:58.175004 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-12 01:57:58.831031 | debian-bookworm | changed 2026-09-12 01:57:58.835385 | 2026-09-12 01:57:58.835457 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-12 01:57:58.848088 | debian-bookworm | skipping: Conditional result was False 2026-09-12 01:57:58.853761 | 2026-09-12 01:57:58.853850 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-12 01:57:59.231025 | debian-bookworm -> localhost | changed 2026-09-12 01:57:59.241082 | 2026-09-12 01:57:59.241175 | TASK [add-build-sshkey : Add back temp key] 2026-09-12 01:57:59.593596 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b1342e6045d64b9eb1b01f97143be666/work/b1342e6045d64b9eb1b01f97143be666_id_rsa (zuul-build-sshkey) 2026-09-12 01:57:59.594087 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013558 2026-09-12 01:57:59.608515 | 2026-09-12 01:57:59.608646 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-12 01:57:59.990529 | debian-bookworm | ok 2026-09-12 01:57:59.995439 | 2026-09-12 01:57:59.995529 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-12 01:58:00.008330 | debian-bookworm | skipping: Conditional result was False 2026-09-12 01:58:00.018198 | 2026-09-12 01:58:00.018284 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-12 01:58:00.422461 | debian-bookworm | ok 2026-09-12 01:58:00.432560 | 2026-09-12 01:58:00.432651 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-12 01:58:00.459889 | debian-bookworm | ok 2026-09-12 01:58:00.464657 | 2026-09-12 01:58:00.464742 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-12 01:58:00.692293 | debian-bookworm -> localhost | ok 2026-09-12 01:58:00.697485 | 2026-09-12 01:58:00.697571 | TASK [validate-host : Collect information about the host] 2026-09-12 01:58:01.749179 | debian-bookworm | ok 2026-09-12 01:58:01.765003 | 2026-09-12 01:58:01.765172 | TASK [validate-host : Sanitize hostname] 2026-09-12 01:58:01.886103 | debian-bookworm | ok 2026-09-12 01:58:01.889637 | 2026-09-12 01:58:01.889712 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-12 01:58:02.387410 | debian-bookworm -> localhost | changed 2026-09-12 01:58:02.391805 | 2026-09-12 01:58:02.391880 | TASK [validate-host : Collect information about zuul worker] 2026-09-12 01:58:02.769523 | debian-bookworm | ok 2026-09-12 01:58:02.775694 | 2026-09-12 01:58:02.775800 | TASK [validate-host : Write out all zuul information for each host] 2026-09-12 01:58:03.267616 | debian-bookworm -> localhost | changed 2026-09-12 01:58:03.278028 | 2026-09-12 01:58:03.278117 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-12 01:58:03.550584 | debian-bookworm | ok 2026-09-12 01:58:03.556037 | 2026-09-12 01:58:03.556121 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-12 01:58:04.374509 | debian-bookworm | changed: 2026-09-12 01:58:04.374756 | debian-bookworm | cd+++++++++ src/ 2026-09-12 01:58:04.374812 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-12 01:58:04.374853 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-12 01:58:04.374889 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2026-09-12 01:58:04.374922 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/b1342e6045d64b9eb1b01f97143be666/work/logs" 2026-09-12 01:59:06.226242 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b1342e6045d64b9eb1b01f97143be666/work/artifacts" 2026-09-12 01:59:06.497936 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b1342e6045d64b9eb1b01f97143be666/work/docs" 2026-09-12 01:59:06.517942 | 2026-09-12 01:59:06.518092 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-12 01:59:07.270686 | debian-bookworm | changed: 2026-09-12 01:59:07.270917 | debian-bookworm | .d..t...... ./ 2026-09-12 01:59:07.270955 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-12 01:59:07.271020 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-12 01:59:07.271042 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-12 01:59:07.271063 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-12 01:59:07.271083 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-12 01:59:07.271121 | debian-bookworm | changed: All items complete 2026-09-12 01:59:07.271146 | 2026-09-12 01:59:07.843297 | debian-bookworm | changed: .d..t...... ./ 2026-09-12 01:59:08.376107 | debian-bookworm | changed: .d..t...... ./ 2026-09-12 01:59:08.396531 | 2026-09-12 01:59:08.396654 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-12 01:59:08.739305 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006105 2026-09-12 01:59:09.002483 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.005122 2026-09-12 01:59:09.011031 | 2026-09-12 01:59:09.011129 | PLAY RECAP 2026-09-12 01:59:09.011182 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-12 01:59:09.011208 | 2026-09-12 01:59:09.137800 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-12 01:59:09.139695 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-12 01:59:09.854287 | 2026-09-12 01:59:09.854446 | PLAY [Base post] 2026-09-12 01:59:09.867483 | 2026-09-12 01:59:09.867623 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-12 01:59:10.419014 | debian-bookworm | changed 2026-09-12 01:59:10.425138 | 2026-09-12 01:59:10.425240 | PLAY RECAP 2026-09-12 01:59:10.425301 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-12 01:59:10.425361 | 2026-09-12 01:59:10.548931 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-12 01:59:10.549841 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-12 01:59:11.551249 | 2026-09-12 01:59:11.551416 | PLAY [Base post-logs] 2026-09-12 01:59:11.562297 | 2026-09-12 01:59:11.562430 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-12 01:59:11.984805 | localhost | changed 2026-09-12 01:59:12.000769 | 2026-09-12 01:59:12.000923 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-12 01:59:12.037293 | localhost | ok 2026-09-12 01:59:12.044294 | 2026-09-12 01:59:12.044475 | TASK [Set zuul-log-path fact] 2026-09-12 01:59:12.074328 | localhost | ok 2026-09-12 01:59:12.088031 | 2026-09-12 01:59:12.088177 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-12 01:59:12.125380 | localhost | ok 2026-09-12 01:59:12.130747 | 2026-09-12 01:59:12.130922 | TASK [upload-logs : Create log directories] 2026-09-12 01:59:12.634637 | localhost | changed 2026-09-12 01:59:12.637533 | 2026-09-12 01:59:12.637680 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-12 01:59:13.128595 | localhost -> localhost | ok: Runtime: 0:00:00.007962 2026-09-12 01:59:13.136082 | 2026-09-12 01:59:13.136244 | TASK [upload-logs : Upload logs to log server] 2026-09-12 01:59:13.735261 | localhost | Output suppressed because no_log was given 2026-09-12 01:59:13.739154 | 2026-09-12 01:59:13.739335 | LOOP [upload-logs : Compress console log and json output] 2026-09-12 01:59:13.787126 | localhost | skipping: Conditional result was False 2026-09-12 01:59:13.793160 | localhost | skipping: Conditional result was False 2026-09-12 01:59:13.803449 | 2026-09-12 01:59:13.803667 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-12 01:59:13.852162 | localhost | skipping: Conditional result was False 2026-09-12 01:59:13.852472 | 2026-09-12 01:59:13.857268 | localhost | skipping: Conditional result was False 2026-09-12 01:59:13.868143 | 2026-09-12 01:59:13.868369 | LOOP [upload-logs : Upload console log and json output]