2026-05-10 03:16:03.269851 | Job console starting 2026-05-10 03:16:03.277811 | Updating git repos 2026-05-10 03:16:03.337425 | Cloning repos into workspace 2026-05-10 03:16:03.412973 | Restoring repo states 2026-05-10 03:16:03.433026 | Merging changes 2026-05-10 03:16:03.433040 | Checking out repos 2026-05-10 03:16:03.522648 | Preparing playbooks 2026-05-10 03:16:05.028902 | Running Ansible setup 2026-05-10 03:16:10.979234 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-10 03:16:11.965598 | 2026-05-10 03:16:11.965730 | PLAY [Base pre] 2026-05-10 03:16:11.996620 | 2026-05-10 03:16:11.996742 | TASK [Setup log path fact] 2026-05-10 03:16:12.043507 | debian-bookworm | ok 2026-05-10 03:16:12.062390 | 2026-05-10 03:16:12.062526 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-10 03:16:12.090691 | debian-bookworm | ok 2026-05-10 03:16:12.100913 | 2026-05-10 03:16:12.101017 | TASK [emit-job-header : Print job information] 2026-05-10 03:16:12.146589 | # Job Information 2026-05-10 03:16:12.146737 | Ansible Version: 2.16.14 2026-05-10 03:16:12.146767 | Job: python-black 2026-05-10 03:16:12.146796 | Pipeline: periodic-daily 2026-05-10 03:16:12.146815 | Executor: 521e9411259a 2026-05-10 03:16:12.146850 | Triggered by: https://github.com/osism/openstack-sandbox-manager 2026-05-10 03:16:12.146870 | Event ID: f676a0c086d845ddbaf7275be5b41e39 2026-05-10 03:16:12.151071 | 2026-05-10 03:16:12.151162 | LOOP [emit-job-header : Print node information] 2026-05-10 03:16:12.253112 | debian-bookworm | ok: 2026-05-10 03:16:12.253312 | debian-bookworm | # Node Information 2026-05-10 03:16:12.253342 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-10 03:16:12.253363 | debian-bookworm | Hostname: debian 2026-05-10 03:16:12.253381 | debian-bookworm | Username: zuul 2026-05-10 03:16:12.253398 | debian-bookworm | Distro: Debian 12.13 2026-05-10 03:16:12.253423 | debian-bookworm | Provider: regiocloud-a 2026-05-10 03:16:12.253444 | debian-bookworm | Region: 2026-05-10 03:16:12.253462 | debian-bookworm | Label: debian-bookworm 2026-05-10 03:16:12.253478 | debian-bookworm | Product Name: OpenStack Nova 2026-05-10 03:16:12.253494 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe08:3a91 2026-05-10 03:16:12.270804 | 2026-05-10 03:16:12.270964 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-10 03:16:12.860194 | debian-bookworm -> localhost | changed 2026-05-10 03:16:12.865869 | 2026-05-10 03:16:12.865966 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-10 03:16:14.177895 | debian-bookworm -> localhost | changed 2026-05-10 03:16:14.187116 | 2026-05-10 03:16:14.187255 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-10 03:16:14.446141 | debian-bookworm -> localhost | ok 2026-05-10 03:16:14.455735 | 2026-05-10 03:16:14.455823 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-10 03:16:14.474028 | debian-bookworm | ok 2026-05-10 03:16:14.489657 | debian-bookworm | included: /var/lib/zuul/builds/55f378e246d442d5a772654290e6c979/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-10 03:16:14.495076 | 2026-05-10 03:16:14.495157 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-10 03:16:17.220993 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-10 03:16:17.221168 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/55f378e246d442d5a772654290e6c979/work/55f378e246d442d5a772654290e6c979_id_rsa 2026-05-10 03:16:17.221199 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/55f378e246d442d5a772654290e6c979/work/55f378e246d442d5a772654290e6c979_id_rsa.pub 2026-05-10 03:16:17.221222 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-10 03:16:17.221242 | debian-bookworm -> localhost | SHA256:sbq5F6FmrHtJ8oodEzxw04YAnQF4d3dcQ8gjrmnz4hs zuul-build-sshkey 2026-05-10 03:16:17.221282 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-10 03:16:17.221313 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-10 03:16:17.221332 | debian-bookworm -> localhost | |++oo o ++ | 2026-05-10 03:16:17.221350 | debian-bookworm -> localhost | |. +..o. o * . | 2026-05-10 03:16:17.221368 | debian-bookworm -> localhost | | ...+.oo.o . | 2026-05-10 03:16:17.221384 | debian-bookworm -> localhost | | + o oo | 2026-05-10 03:16:17.221401 | debian-bookworm -> localhost | | +. +S. | 2026-05-10 03:16:17.221422 | debian-bookworm -> localhost | | .o@.. | 2026-05-10 03:16:17.221441 | debian-bookworm -> localhost | | oOE+ . | 2026-05-10 03:16:17.221459 | debian-bookworm -> localhost | | o.o=+o | 2026-05-10 03:16:17.221477 | debian-bookworm -> localhost | | . +=*= | 2026-05-10 03:16:17.221495 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-10 03:16:17.221539 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.192191 2026-05-10 03:16:17.228051 | 2026-05-10 03:16:17.228142 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-10 03:16:17.256300 | debian-bookworm | ok 2026-05-10 03:16:17.263759 | debian-bookworm | included: /var/lib/zuul/builds/55f378e246d442d5a772654290e6c979/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-10 03:16:17.286772 | 2026-05-10 03:16:17.286881 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-10 03:16:17.331311 | debian-bookworm | skipping: Conditional result was False 2026-05-10 03:16:17.336493 | 2026-05-10 03:16:17.336592 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-10 03:16:18.229318 | debian-bookworm | changed 2026-05-10 03:16:18.241597 | 2026-05-10 03:16:18.243323 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-10 03:16:18.547384 | debian-bookworm | ok 2026-05-10 03:16:18.557234 | 2026-05-10 03:16:18.557400 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-10 03:16:19.382867 | debian-bookworm | changed 2026-05-10 03:16:19.396339 | 2026-05-10 03:16:19.396448 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-10 03:16:20.207237 | debian-bookworm | changed 2026-05-10 03:16:20.215678 | 2026-05-10 03:16:20.215780 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-10 03:16:20.239214 | debian-bookworm | skipping: Conditional result was False 2026-05-10 03:16:20.248168 | 2026-05-10 03:16:20.248285 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-10 03:16:20.758334 | debian-bookworm -> localhost | changed 2026-05-10 03:16:20.781184 | 2026-05-10 03:16:20.781337 | TASK [add-build-sshkey : Add back temp key] 2026-05-10 03:16:21.135391 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/55f378e246d442d5a772654290e6c979/work/55f378e246d442d5a772654290e6c979_id_rsa (zuul-build-sshkey) 2026-05-10 03:16:21.135626 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.027455 2026-05-10 03:16:21.143765 | 2026-05-10 03:16:21.143881 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-10 03:16:21.532925 | debian-bookworm | ok 2026-05-10 03:16:21.537970 | 2026-05-10 03:16:21.538065 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-10 03:16:21.561527 | debian-bookworm | skipping: Conditional result was False 2026-05-10 03:16:21.593360 | 2026-05-10 03:16:21.593544 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-10 03:16:22.018530 | debian-bookworm | ok 2026-05-10 03:16:22.032183 | 2026-05-10 03:16:22.032322 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-10 03:16:22.060096 | debian-bookworm | ok 2026-05-10 03:16:22.065128 | 2026-05-10 03:16:22.065218 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-10 03:16:22.357731 | debian-bookworm -> localhost | ok 2026-05-10 03:16:22.364228 | 2026-05-10 03:16:22.364376 | TASK [validate-host : Collect information about the host] 2026-05-10 03:16:23.603581 | debian-bookworm | ok 2026-05-10 03:16:23.616178 | 2026-05-10 03:16:23.616296 | TASK [validate-host : Sanitize hostname] 2026-05-10 03:16:23.726104 | debian-bookworm | ok 2026-05-10 03:16:23.770392 | 2026-05-10 03:16:23.770503 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-10 03:16:24.306999 | debian-bookworm -> localhost | changed 2026-05-10 03:16:24.313420 | 2026-05-10 03:16:24.313526 | TASK [validate-host : Collect information about zuul worker] 2026-05-10 03:16:24.739259 | debian-bookworm | ok 2026-05-10 03:16:24.746554 | 2026-05-10 03:16:24.746662 | TASK [validate-host : Write out all zuul information for each host] 2026-05-10 03:16:25.269612 | debian-bookworm -> localhost | changed 2026-05-10 03:16:25.304678 | 2026-05-10 03:16:25.304838 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-10 03:16:25.578097 | debian-bookworm | ok 2026-05-10 03:16:25.583802 | 2026-05-10 03:16:25.583922 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-10 03:16:26.392120 | debian-bookworm | changed: 2026-05-10 03:16:26.392508 | debian-bookworm | cd+++++++++ src/ 2026-05-10 03:16:26.392558 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-10 03:16:26.392584 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-10 03:16:26.392606 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2026-05-10 03:16:26.392627 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/55f378e246d442d5a772654290e6c979/work/logs" 2026-05-10 03:16:53.075765 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/55f378e246d442d5a772654290e6c979/work/artifacts" 2026-05-10 03:16:53.480706 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/55f378e246d442d5a772654290e6c979/work/docs" 2026-05-10 03:16:53.490579 | 2026-05-10 03:16:53.490677 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-10 03:16:54.327698 | debian-bookworm | changed: 2026-05-10 03:16:54.327906 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-10 03:16:54.327965 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-10 03:16:54.328019 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-10 03:16:54.328090 | debian-bookworm | changed: All items complete 2026-05-10 03:16:54.328137 | 2026-05-10 03:16:55.318218 | debian-bookworm | changed: .d..t...... ./ 2026-05-10 03:16:56.146695 | debian-bookworm | changed: .d..t...... ./ 2026-05-10 03:16:56.162321 | 2026-05-10 03:16:56.162432 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-10 03:16:56.186084 | debian-bookworm | skipping: Conditional result was False 2026-05-10 03:16:56.192016 | debian-bookworm | skipping: Conditional result was False 2026-05-10 03:16:56.202968 | 2026-05-10 03:16:56.203046 | PLAY RECAP 2026-05-10 03:16:56.203092 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-10 03:16:56.203116 | 2026-05-10 03:16:56.363943 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-10 03:16:56.364634 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-10 03:16:57.121391 | 2026-05-10 03:16:57.121520 | PLAY [Base post] 2026-05-10 03:16:57.146002 | 2026-05-10 03:16:57.146133 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-10 03:16:57.699195 | debian-bookworm | changed 2026-05-10 03:16:57.712197 | 2026-05-10 03:16:57.712329 | PLAY RECAP 2026-05-10 03:16:57.712392 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-10 03:16:57.712456 | 2026-05-10 03:16:57.852395 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-10 03:16:57.853127 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-10 03:16:58.718910 | 2026-05-10 03:16:58.719055 | PLAY [Base post-logs] 2026-05-10 03:16:58.729081 | 2026-05-10 03:16:58.729215 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-10 03:16:59.374297 | localhost | changed 2026-05-10 03:16:59.384317 | 2026-05-10 03:16:59.384453 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-10 03:16:59.424367 | localhost | ok 2026-05-10 03:16:59.427251 | 2026-05-10 03:16:59.427366 | TASK [Set zuul-log-path fact] 2026-05-10 03:16:59.465061 | localhost | ok 2026-05-10 03:16:59.472748 | 2026-05-10 03:16:59.472859 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-10 03:16:59.506115 | localhost | ok 2026-05-10 03:16:59.508921 | 2026-05-10 03:16:59.509010 | TASK [upload-logs : Create log directories] 2026-05-10 03:17:00.043002 | localhost | changed 2026-05-10 03:17:00.051814 | 2026-05-10 03:17:00.051925 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-10 03:17:00.647512 | localhost -> localhost | ok: Runtime: 0:00:00.004785 2026-05-10 03:17:00.651243 | 2026-05-10 03:17:00.651352 | TASK [upload-logs : Upload logs to log server] 2026-05-10 03:17:01.235834 | localhost | Output suppressed because no_log was given 2026-05-10 03:17:01.237466 | 2026-05-10 03:17:01.237554 | LOOP [upload-logs : Compress console log and json output] 2026-05-10 03:17:01.296774 | localhost | skipping: Conditional result was False 2026-05-10 03:17:01.302827 | localhost | skipping: Conditional result was False 2026-05-10 03:17:01.310014 | 2026-05-10 03:17:01.310119 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-10 03:17:01.372572 | localhost | skipping: Conditional result was False 2026-05-10 03:17:01.372800 | 2026-05-10 03:17:01.377381 | localhost | skipping: Conditional result was False 2026-05-10 03:17:01.386033 | 2026-05-10 03:17:01.386139 | LOOP [upload-logs : Upload console log and json output]