2026-08-31 19:49:20.118334 | Job console starting 2026-08-31 19:49:20.149564 | Updating git repos 2026-08-31 19:49:20.174026 | Cloning repos into workspace 2026-08-31 19:49:20.230444 | Restoring repo states 2026-08-31 19:49:20.235526 | Merging changes 2026-08-31 19:49:20.818700 | Checking out repos 2026-08-31 19:49:20.870272 | Preparing playbooks 2026-08-31 19:49:21.739686 | Running Ansible setup 2026-08-31 19:49:26.606935 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-31 19:49:27.568418 | 2026-08-31 19:49:27.568595 | PLAY [Base pre] 2026-08-31 19:49:27.586643 | 2026-08-31 19:49:27.586878 | TASK [Setup log path fact] 2026-08-31 19:49:27.607488 | debian-bookworm | ok 2026-08-31 19:49:27.626826 | 2026-08-31 19:49:27.627013 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-31 19:49:27.666082 | debian-bookworm | ok 2026-08-31 19:49:27.679139 | 2026-08-31 19:49:27.679271 | TASK [emit-job-header : Print job information] 2026-08-31 19:49:27.718666 | # Job Information 2026-08-31 19:49:27.718878 | Ansible Version: 2.16.14 2026-08-31 19:49:27.718919 | Job: python-black 2026-08-31 19:49:27.718951 | Pipeline: check 2026-08-31 19:49:27.718975 | Executor: 521e9411259a 2026-08-31 19:49:27.718996 | Triggered by: https://github.com/osism/openstack-simple-stress/pull/349 2026-08-31 19:49:27.719018 | Event ID: 07e3ead0-a575-11f1-98d4-49ae48214f0a 2026-08-31 19:49:27.724596 | 2026-08-31 19:49:27.724710 | LOOP [emit-job-header : Print node information] 2026-08-31 19:49:27.878489 | debian-bookworm | ok: 2026-08-31 19:49:27.878686 | debian-bookworm | # Node Information 2026-08-31 19:49:27.878764 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-31 19:49:27.878792 | debian-bookworm | Hostname: debian 2026-08-31 19:49:27.878814 | debian-bookworm | Username: zuul 2026-08-31 19:49:27.878856 | debian-bookworm | Distro: Debian 12.15 2026-08-31 19:49:27.878883 | debian-bookworm | Provider: regiocloud-a 2026-08-31 19:49:27.878905 | debian-bookworm | Region: 2026-08-31 19:49:27.878926 | debian-bookworm | Label: debian-bookworm 2026-08-31 19:49:27.878946 | debian-bookworm | Product Name: OpenStack Nova 2026-08-31 19:49:27.878966 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1e:9e5c 2026-08-31 19:49:27.895705 | 2026-08-31 19:49:27.895862 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-31 19:49:28.464058 | debian-bookworm -> localhost | changed 2026-08-31 19:49:28.469626 | 2026-08-31 19:49:28.469712 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-31 19:49:29.664395 | debian-bookworm -> localhost | changed 2026-08-31 19:49:29.673025 | 2026-08-31 19:49:29.673125 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-31 19:49:29.949277 | debian-bookworm -> localhost | ok 2026-08-31 19:49:29.955115 | 2026-08-31 19:49:29.955219 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-31 19:49:29.974172 | debian-bookworm | ok 2026-08-31 19:49:30.000353 | debian-bookworm | included: /var/lib/zuul/builds/c1e1db3b64994da3ab1aacb12f3f9d8b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-31 19:49:30.014232 | 2026-08-31 19:49:30.014340 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-31 19:49:31.745505 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-31 19:49:31.745669 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c1e1db3b64994da3ab1aacb12f3f9d8b/work/c1e1db3b64994da3ab1aacb12f3f9d8b_id_rsa 2026-08-31 19:49:31.745702 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c1e1db3b64994da3ab1aacb12f3f9d8b/work/c1e1db3b64994da3ab1aacb12f3f9d8b_id_rsa.pub 2026-08-31 19:49:31.745741 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-31 19:49:31.745763 | debian-bookworm -> localhost | SHA256:6S88tYwEcKIY86k4UIIgmr2gWRLhSCMwtuotSaosOz4 zuul-build-sshkey 2026-08-31 19:49:31.745782 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-31 19:49:31.745808 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-31 19:49:31.745826 | debian-bookworm -> localhost | |%= | 2026-08-31 19:49:31.745844 | debian-bookworm -> localhost | |&=+ o . | 2026-08-31 19:49:31.745860 | debian-bookworm -> localhost | |*Xoo + | 2026-08-31 19:49:31.745877 | debian-bookworm -> localhost | |==+. . . | 2026-08-31 19:49:31.745893 | debian-bookworm -> localhost | |*o. .S | 2026-08-31 19:49:31.745912 | debian-bookworm -> localhost | |B o .. . | 2026-08-31 19:49:31.745929 | debian-bookworm -> localhost | |.= . o.+ . | 2026-08-31 19:49:31.745945 | debian-bookworm -> localhost | |=E. =.o | 2026-08-31 19:49:31.745962 | debian-bookworm -> localhost | |==. o. | 2026-08-31 19:49:31.745978 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-31 19:49:31.746018 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.252090 2026-08-31 19:49:31.751213 | 2026-08-31 19:49:31.751293 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-31 19:49:31.767080 | debian-bookworm | ok 2026-08-31 19:49:31.774983 | debian-bookworm | included: /var/lib/zuul/builds/c1e1db3b64994da3ab1aacb12f3f9d8b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-31 19:49:31.781890 | 2026-08-31 19:49:31.781959 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-31 19:49:31.794055 | debian-bookworm | skipping: Conditional result was False 2026-08-31 19:49:31.798410 | 2026-08-31 19:49:31.798480 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-31 19:49:32.405282 | debian-bookworm | changed 2026-08-31 19:49:32.409596 | 2026-08-31 19:49:32.409677 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-31 19:49:32.672270 | debian-bookworm | ok 2026-08-31 19:49:32.679781 | 2026-08-31 19:49:32.679893 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-31 19:49:33.372745 | debian-bookworm | changed 2026-08-31 19:49:33.383131 | 2026-08-31 19:49:33.383274 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-31 19:49:34.041765 | debian-bookworm | changed 2026-08-31 19:49:34.047108 | 2026-08-31 19:49:34.047199 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-31 19:49:34.059887 | debian-bookworm | skipping: Conditional result was False 2026-08-31 19:49:34.065629 | 2026-08-31 19:49:34.065719 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-31 19:49:34.462271 | debian-bookworm -> localhost | changed 2026-08-31 19:49:34.472364 | 2026-08-31 19:49:34.472459 | TASK [add-build-sshkey : Add back temp key] 2026-08-31 19:49:34.839712 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c1e1db3b64994da3ab1aacb12f3f9d8b/work/c1e1db3b64994da3ab1aacb12f3f9d8b_id_rsa (zuul-build-sshkey) 2026-08-31 19:49:34.839927 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009604 2026-08-31 19:49:34.847148 | 2026-08-31 19:49:34.847248 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-31 19:49:35.238348 | debian-bookworm | ok 2026-08-31 19:49:35.243306 | 2026-08-31 19:49:35.243394 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-31 19:49:35.279965 | debian-bookworm | skipping: Conditional result was False 2026-08-31 19:49:35.289748 | 2026-08-31 19:49:35.289840 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-31 19:49:35.691558 | debian-bookworm | ok 2026-08-31 19:49:35.701774 | 2026-08-31 19:49:35.701875 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-31 19:49:35.730867 | debian-bookworm | ok 2026-08-31 19:49:35.736282 | 2026-08-31 19:49:35.736379 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-31 19:49:35.981635 | debian-bookworm -> localhost | ok 2026-08-31 19:49:35.987888 | 2026-08-31 19:49:35.987989 | TASK [validate-host : Collect information about the host] 2026-08-31 19:49:37.129113 | debian-bookworm | ok 2026-08-31 19:49:37.141501 | 2026-08-31 19:49:37.141592 | TASK [validate-host : Sanitize hostname] 2026-08-31 19:49:37.242468 | debian-bookworm | ok 2026-08-31 19:49:37.246602 | 2026-08-31 19:49:37.246687 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-31 19:49:37.765613 | debian-bookworm -> localhost | changed 2026-08-31 19:49:37.771096 | 2026-08-31 19:49:37.771204 | TASK [validate-host : Collect information about zuul worker] 2026-08-31 19:49:38.257178 | debian-bookworm | ok 2026-08-31 19:49:38.265092 | 2026-08-31 19:49:38.265187 | TASK [validate-host : Write out all zuul information for each host] 2026-08-31 19:49:38.749871 | debian-bookworm -> localhost | changed 2026-08-31 19:49:38.758879 | 2026-08-31 19:49:38.758969 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-31 19:49:39.038951 | debian-bookworm | ok 2026-08-31 19:49:39.044116 | 2026-08-31 19:49:39.044201 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-31 19:49:39.816985 | debian-bookworm | changed: 2026-08-31 19:49:39.817155 | debian-bookworm | cd+++++++++ src/ 2026-08-31 19:49:39.817189 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-31 19:49:39.817213 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-31 19:49:39.817235 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2026-08-31 19:49:39.817256 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/c1e1db3b64994da3ab1aacb12f3f9d8b/work/logs" 2026-08-31 19:50:42.882491 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c1e1db3b64994da3ab1aacb12f3f9d8b/work/artifacts" 2026-08-31 19:50:43.161125 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c1e1db3b64994da3ab1aacb12f3f9d8b/work/docs" 2026-08-31 19:50:43.192617 | 2026-08-31 19:50:43.192832 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-31 19:50:44.204606 | debian-bookworm | changed: 2026-08-31 19:50:44.204863 | debian-bookworm | .d..t...... ./ 2026-08-31 19:50:44.204901 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-31 19:50:44.204926 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-31 19:50:44.204947 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-31 19:50:44.204968 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-31 19:50:44.204989 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-31 19:50:44.205029 | debian-bookworm | changed: All items complete 2026-08-31 19:50:44.205055 | 2026-08-31 19:50:44.764963 | debian-bookworm | changed: .d..t...... ./ 2026-08-31 19:50:45.295709 | debian-bookworm | changed: .d..t...... ./ 2026-08-31 19:50:45.308475 | 2026-08-31 19:50:45.308597 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-31 19:50:45.635596 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.005599 2026-08-31 19:50:45.920535 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008179 2026-08-31 19:50:45.930644 | 2026-08-31 19:50:45.930761 | PLAY RECAP 2026-08-31 19:50:45.930814 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-31 19:50:45.930976 | 2026-08-31 19:50:46.065169 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-31 19:50:46.066246 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-31 19:50:46.804444 | 2026-08-31 19:50:46.804605 | PLAY [Base post] 2026-08-31 19:50:46.817922 | 2026-08-31 19:50:46.818061 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-31 19:50:47.393314 | debian-bookworm | changed 2026-08-31 19:50:47.399593 | 2026-08-31 19:50:47.399695 | PLAY RECAP 2026-08-31 19:50:47.399777 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-31 19:50:47.399838 | 2026-08-31 19:50:47.559017 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-31 19:50:47.559859 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-31 19:50:48.350184 | 2026-08-31 19:50:48.350342 | PLAY [Base post-logs] 2026-08-31 19:50:48.361103 | 2026-08-31 19:50:48.361235 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-31 19:50:48.864368 | localhost | changed 2026-08-31 19:50:48.878055 | 2026-08-31 19:50:48.878207 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-31 19:50:48.914181 | localhost | ok 2026-08-31 19:50:48.917213 | 2026-08-31 19:50:48.917314 | TASK [Set zuul-log-path fact] 2026-08-31 19:50:48.944670 | localhost | ok 2026-08-31 19:50:48.953450 | 2026-08-31 19:50:48.953564 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-31 19:50:48.999065 | localhost | ok 2026-08-31 19:50:49.006323 | 2026-08-31 19:50:49.007245 | TASK [upload-logs : Create log directories] 2026-08-31 19:50:49.534494 | localhost | changed 2026-08-31 19:50:49.537747 | 2026-08-31 19:50:49.537858 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-31 19:50:50.081567 | localhost -> localhost | ok: Runtime: 0:00:00.007186 2026-08-31 19:50:50.090986 | 2026-08-31 19:50:50.091198 | TASK [upload-logs : Upload logs to log server] 2026-08-31 19:50:50.648095 | localhost | Output suppressed because no_log was given 2026-08-31 19:50:50.651846 | 2026-08-31 19:50:50.652027 | LOOP [upload-logs : Compress console log and json output] 2026-08-31 19:50:50.711203 | localhost | skipping: Conditional result was False 2026-08-31 19:50:50.716267 | localhost | skipping: Conditional result was False 2026-08-31 19:50:50.722563 | 2026-08-31 19:50:50.722758 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-31 19:50:50.767501 | localhost | skipping: Conditional result was False 2026-08-31 19:50:50.768059 | 2026-08-31 19:50:50.771474 | localhost | skipping: Conditional result was False 2026-08-31 19:50:50.784598 | 2026-08-31 19:50:50.784852 | LOOP [upload-logs : Upload console log and json output]