2025-09-06 03:12:14.626087 | Job console starting 2025-09-06 03:12:14.643625 | Updating git repos 2025-09-06 03:12:14.687824 | Cloning repos into workspace 2025-09-06 03:12:14.783568 | Restoring repo states 2025-09-06 03:12:14.802410 | Merging changes 2025-09-06 03:12:14.802436 | Checking out repos 2025-09-06 03:12:14.965177 | Preparing playbooks 2025-09-06 03:12:16.003068 | Running Ansible setup 2025-09-06 03:12:20.543567 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-06 03:12:21.359144 | 2025-09-06 03:12:21.359339 | PLAY [Base pre] 2025-09-06 03:12:21.375622 | 2025-09-06 03:12:21.375744 | TASK [Setup log path fact] 2025-09-06 03:12:21.405165 | debian-bookworm | ok 2025-09-06 03:12:21.420062 | 2025-09-06 03:12:21.420260 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-06 03:12:21.459421 | debian-bookworm | ok 2025-09-06 03:12:21.473962 | 2025-09-06 03:12:21.474084 | TASK [emit-job-header : Print job information] 2025-09-06 03:12:21.538997 | # Job Information 2025-09-06 03:12:21.539242 | Ansible Version: 2.16.14 2025-09-06 03:12:21.539286 | Job: python-black 2025-09-06 03:12:21.539327 | Pipeline: periodic-daily 2025-09-06 03:12:21.539355 | Executor: 521e9411259a 2025-09-06 03:12:21.539381 | Triggered by: https://github.com/osism/testbed 2025-09-06 03:12:21.539407 | Event ID: 694dd98cbeee4386ac72a52f28a07a17 2025-09-06 03:12:21.547444 | 2025-09-06 03:12:21.547580 | LOOP [emit-job-header : Print node information] 2025-09-06 03:12:21.663980 | debian-bookworm | ok: 2025-09-06 03:12:21.664337 | debian-bookworm | # Node Information 2025-09-06 03:12:21.664385 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-06 03:12:21.664412 | debian-bookworm | Hostname: debian 2025-09-06 03:12:21.664435 | debian-bookworm | Username: zuul 2025-09-06 03:12:21.664455 | debian-bookworm | Distro: Debian 12.11 2025-09-06 03:12:21.664479 | debian-bookworm | Provider: regiocloud-a 2025-09-06 03:12:21.664501 | debian-bookworm | Region: 2025-09-06 03:12:21.664522 | debian-bookworm | Label: debian-bookworm 2025-09-06 03:12:21.664541 | debian-bookworm | Product Name: OpenStack Nova 2025-09-06 03:12:21.664560 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee7:c308 2025-09-06 03:12:21.685260 | 2025-09-06 03:12:21.685391 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-06 03:12:22.249260 | debian-bookworm -> localhost | changed 2025-09-06 03:12:22.257810 | 2025-09-06 03:12:22.257929 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-06 03:12:23.446306 | debian-bookworm -> localhost | changed 2025-09-06 03:12:23.458186 | 2025-09-06 03:12:23.458325 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-06 03:12:23.750442 | debian-bookworm -> localhost | ok 2025-09-06 03:12:23.759704 | 2025-09-06 03:12:23.759847 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-06 03:12:23.791361 | debian-bookworm | ok 2025-09-06 03:12:23.809538 | debian-bookworm | included: /var/lib/zuul/builds/18749ccac15f4b3f8c779fead65346fe/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-06 03:12:23.815788 | 2025-09-06 03:12:23.815897 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-06 03:12:25.094966 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-06 03:12:25.095240 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/18749ccac15f4b3f8c779fead65346fe/work/18749ccac15f4b3f8c779fead65346fe_id_rsa 2025-09-06 03:12:25.095283 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/18749ccac15f4b3f8c779fead65346fe/work/18749ccac15f4b3f8c779fead65346fe_id_rsa.pub 2025-09-06 03:12:25.095311 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-06 03:12:25.095336 | debian-bookworm -> localhost | SHA256:qiHAeRus8SSivG94GMPJcXdl8Xg6zFcHqSEP2bEwLZI zuul-build-sshkey 2025-09-06 03:12:25.095359 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-06 03:12:25.095400 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-06 03:12:25.095422 | debian-bookworm -> localhost | | .+=.... | 2025-09-06 03:12:25.095443 | debian-bookworm -> localhost | | E B=+... | 2025-09-06 03:12:25.095463 | debian-bookworm -> localhost | | +.=+o. . | 2025-09-06 03:12:25.095484 | debian-bookworm -> localhost | |..o. . .o oo. . | 2025-09-06 03:12:25.095504 | debian-bookworm -> localhost | |==+=. . S= . | 2025-09-06 03:12:25.095528 | debian-bookworm -> localhost | |+BB o . o | 2025-09-06 03:12:25.095549 | debian-bookworm -> localhost | |.o*o. . | 2025-09-06 03:12:25.095568 | debian-bookworm -> localhost | | o.+ o | 2025-09-06 03:12:25.095589 | debian-bookworm -> localhost | | .+.. | 2025-09-06 03:12:25.095609 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-06 03:12:25.095668 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.485513 2025-09-06 03:12:25.102319 | 2025-09-06 03:12:25.102435 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-06 03:12:25.132492 | debian-bookworm | ok 2025-09-06 03:12:25.142011 | debian-bookworm | included: /var/lib/zuul/builds/18749ccac15f4b3f8c779fead65346fe/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-06 03:12:25.151155 | 2025-09-06 03:12:25.151278 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-06 03:12:25.175913 | debian-bookworm | skipping: Conditional result was False 2025-09-06 03:12:25.182476 | 2025-09-06 03:12:25.182585 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-06 03:12:25.889419 | debian-bookworm | changed 2025-09-06 03:12:25.895299 | 2025-09-06 03:12:25.895409 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-06 03:12:26.160289 | debian-bookworm | ok 2025-09-06 03:12:26.174363 | 2025-09-06 03:12:26.174491 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-06 03:12:26.871175 | debian-bookworm | changed 2025-09-06 03:12:26.883470 | 2025-09-06 03:12:26.883723 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-06 03:12:27.610782 | debian-bookworm | changed 2025-09-06 03:12:27.628389 | 2025-09-06 03:12:27.628533 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-06 03:12:27.666443 | debian-bookworm | skipping: Conditional result was False 2025-09-06 03:12:27.677394 | 2025-09-06 03:12:27.677532 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-06 03:12:28.442280 | debian-bookworm -> localhost | changed 2025-09-06 03:12:28.466632 | 2025-09-06 03:12:28.466773 | TASK [add-build-sshkey : Add back temp key] 2025-09-06 03:12:28.816940 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/18749ccac15f4b3f8c779fead65346fe/work/18749ccac15f4b3f8c779fead65346fe_id_rsa (zuul-build-sshkey) 2025-09-06 03:12:28.817442 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020285 2025-09-06 03:12:28.832335 | 2025-09-06 03:12:28.832597 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-06 03:12:29.409707 | debian-bookworm | ok 2025-09-06 03:12:29.415345 | 2025-09-06 03:12:29.415456 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-06 03:12:29.439898 | debian-bookworm | skipping: Conditional result was False 2025-09-06 03:12:29.452346 | 2025-09-06 03:12:29.452452 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-06 03:12:29.970628 | debian-bookworm | ok 2025-09-06 03:12:29.997237 | 2025-09-06 03:12:29.997559 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-06 03:12:30.041678 | debian-bookworm | ok 2025-09-06 03:12:30.047673 | 2025-09-06 03:12:30.047785 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-06 03:12:30.476397 | debian-bookworm -> localhost | ok 2025-09-06 03:12:30.484741 | 2025-09-06 03:12:30.484855 | TASK [validate-host : Collect information about the host] 2025-09-06 03:12:31.864578 | debian-bookworm | ok 2025-09-06 03:12:31.880968 | 2025-09-06 03:12:31.881117 | TASK [validate-host : Sanitize hostname] 2025-09-06 03:12:32.005508 | debian-bookworm | ok 2025-09-06 03:12:32.057114 | 2025-09-06 03:12:32.057447 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-06 03:12:32.967394 | debian-bookworm -> localhost | changed 2025-09-06 03:12:32.972847 | 2025-09-06 03:12:32.972940 | TASK [validate-host : Collect information about zuul worker] 2025-09-06 03:12:33.428263 | debian-bookworm | ok 2025-09-06 03:12:33.436394 | 2025-09-06 03:12:33.436953 | TASK [validate-host : Write out all zuul information for each host] 2025-09-06 03:12:33.952973 | debian-bookworm -> localhost | changed 2025-09-06 03:12:33.965730 | 2025-09-06 03:12:33.965830 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-06 03:12:34.247737 | debian-bookworm | ok 2025-09-06 03:12:34.252987 | 2025-09-06 03:12:34.253075 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-06 03:12:35.680216 | debian-bookworm | changed: 2025-09-06 03:12:35.680418 | debian-bookworm | cd+++++++++ src/ 2025-09-06 03:12:35.680453 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-06 03:12:35.680478 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-06 03:12:35.680500 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-09-06 03:12:35.680520 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005038 2025-09-06 03:13:02.470261 | 2025-09-06 03:13:02.470376 | TASK [upload-logs : Upload logs to log server] 2025-09-06 03:13:03.033567 | localhost | Output suppressed because no_log was given 2025-09-06 03:13:03.035405 | 2025-09-06 03:13:03.035514 | LOOP [upload-logs : Compress console log and json output] 2025-09-06 03:13:03.089650 | localhost | skipping: Conditional result was False 2025-09-06 03:13:03.095741 | localhost | skipping: Conditional result was False 2025-09-06 03:13:03.102990 | 2025-09-06 03:13:03.103105 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-06 03:13:03.150399 | localhost | skipping: Conditional result was False 2025-09-06 03:13:03.150680 | 2025-09-06 03:13:03.157735 | localhost | skipping: Conditional result was False 2025-09-06 03:13:03.170628 | 2025-09-06 03:13:03.170748 | LOOP [upload-logs : Upload console log and json output]