2026-06-03 03:08:08.284541 | Job console starting 2026-06-03 03:08:08.298354 | Updating git repos 2026-06-03 03:08:08.435460 | Cloning repos into workspace 2026-06-03 03:08:08.532229 | Restoring repo states 2026-06-03 03:08:08.556020 | Merging changes 2026-06-03 03:08:08.556042 | Checking out repos 2026-06-03 03:08:08.793484 | Preparing playbooks 2026-06-03 03:08:09.804326 | Running Ansible setup 2026-06-03 03:08:15.117717 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-03 03:08:15.877191 | 2026-06-03 03:08:15.877371 | PLAY [Base pre] 2026-06-03 03:08:15.895041 | 2026-06-03 03:08:15.895191 | TASK [Setup log path fact] 2026-06-03 03:08:15.914444 | debian-bookworm | ok 2026-06-03 03:08:15.930690 | 2026-06-03 03:08:15.930905 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-03 03:08:15.990783 | debian-bookworm | ok 2026-06-03 03:08:16.001739 | 2026-06-03 03:08:16.001865 | TASK [emit-job-header : Print job information] 2026-06-03 03:08:16.053698 | # Job Information 2026-06-03 03:08:16.053916 | Ansible Version: 2.16.14 2026-06-03 03:08:16.053953 | Job: python-black 2026-06-03 03:08:16.053988 | Pipeline: periodic-daily 2026-06-03 03:08:16.054011 | Executor: 521e9411259a 2026-06-03 03:08:16.054032 | Triggered by: https://github.com/osism/python-osism 2026-06-03 03:08:16.054054 | Event ID: 89074a44b2d4410ea0cadae961869bd2 2026-06-03 03:08:16.059535 | 2026-06-03 03:08:16.059685 | LOOP [emit-job-header : Print node information] 2026-06-03 03:08:16.172209 | debian-bookworm | ok: 2026-06-03 03:08:16.172432 | debian-bookworm | # Node Information 2026-06-03 03:08:16.172468 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-03 03:08:16.172493 | debian-bookworm | Hostname: debian 2026-06-03 03:08:16.172515 | debian-bookworm | Username: zuul 2026-06-03 03:08:16.172537 | debian-bookworm | Distro: Debian 12.14 2026-06-03 03:08:16.172561 | debian-bookworm | Provider: regiocloud-a 2026-06-03 03:08:16.172583 | debian-bookworm | Region: 2026-06-03 03:08:16.172605 | debian-bookworm | Label: debian-bookworm 2026-06-03 03:08:16.172626 | debian-bookworm | Product Name: OpenStack Nova 2026-06-03 03:08:16.172646 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe17:2b22 2026-06-03 03:08:16.188935 | 2026-06-03 03:08:16.189078 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-03 03:08:16.739101 | debian-bookworm -> localhost | changed 2026-06-03 03:08:16.763175 | 2026-06-03 03:08:16.763434 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-03 03:08:17.852101 | debian-bookworm -> localhost | changed 2026-06-03 03:08:17.867221 | 2026-06-03 03:08:17.867361 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-03 03:08:18.150507 | debian-bookworm -> localhost | ok 2026-06-03 03:08:18.160712 | 2026-06-03 03:08:18.160885 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-03 03:08:18.197338 | debian-bookworm | ok 2026-06-03 03:08:18.214502 | debian-bookworm | included: /var/lib/zuul/builds/4266ff26bd7d42778fe55c563e69ee73/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-03 03:08:18.221308 | 2026-06-03 03:08:18.221413 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-03 03:08:19.421957 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-03 03:08:19.422449 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4266ff26bd7d42778fe55c563e69ee73/work/4266ff26bd7d42778fe55c563e69ee73_id_rsa 2026-06-03 03:08:19.422557 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4266ff26bd7d42778fe55c563e69ee73/work/4266ff26bd7d42778fe55c563e69ee73_id_rsa.pub 2026-06-03 03:08:19.422634 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-03 03:08:19.422730 | debian-bookworm -> localhost | SHA256:UhfGVCWU+rig1IdVRCmZuNOKPO9AaqqqSZGhVD9D8+A zuul-build-sshkey 2026-06-03 03:08:19.422794 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-03 03:08:19.422951 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-03 03:08:19.423019 | debian-bookworm -> localhost | | . + ++B*+. | 2026-06-03 03:08:19.423081 | debian-bookworm -> localhost | | . + + ..=.+. | 2026-06-03 03:08:19.423139 | debian-bookworm -> localhost | | o E ..o.+ | 2026-06-03 03:08:19.423195 | debian-bookworm -> localhost | |o o o.o.+ | 2026-06-03 03:08:19.423252 | debian-bookworm -> localhost | |.o .ooS= o | 2026-06-03 03:08:19.423318 | debian-bookworm -> localhost | | . o=.= o . | 2026-06-03 03:08:19.423379 | debian-bookworm -> localhost | | . o..+ o . | 2026-06-03 03:08:19.423436 | debian-bookworm -> localhost | |.. o ... . | 2026-06-03 03:08:19.423494 | debian-bookworm -> localhost | |B.. .. | 2026-06-03 03:08:19.423550 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-03 03:08:19.423724 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.683463 2026-06-03 03:08:19.437428 | 2026-06-03 03:08:19.437566 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-03 03:08:19.468285 | debian-bookworm | ok 2026-06-03 03:08:19.478934 | debian-bookworm | included: /var/lib/zuul/builds/4266ff26bd7d42778fe55c563e69ee73/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-03 03:08:19.488904 | 2026-06-03 03:08:19.489018 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-03 03:08:19.513392 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:08:19.527404 | 2026-06-03 03:08:19.527785 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-03 03:08:20.294017 | debian-bookworm | changed 2026-06-03 03:08:20.303529 | 2026-06-03 03:08:20.303705 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-03 03:08:20.581904 | debian-bookworm | ok 2026-06-03 03:08:20.592270 | 2026-06-03 03:08:20.592403 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-03 03:08:21.322993 | debian-bookworm | changed 2026-06-03 03:08:21.340556 | 2026-06-03 03:08:21.340774 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-03 03:08:22.024199 | debian-bookworm | changed 2026-06-03 03:08:22.030396 | 2026-06-03 03:08:22.030510 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-03 03:08:22.055406 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:08:22.061992 | 2026-06-03 03:08:22.062111 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-03 03:08:22.533071 | debian-bookworm -> localhost | changed 2026-06-03 03:08:22.552509 | 2026-06-03 03:08:22.552778 | TASK [add-build-sshkey : Add back temp key] 2026-06-03 03:08:23.044645 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4266ff26bd7d42778fe55c563e69ee73/work/4266ff26bd7d42778fe55c563e69ee73_id_rsa (zuul-build-sshkey) 2026-06-03 03:08:23.045181 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.026374 2026-06-03 03:08:23.068917 | 2026-06-03 03:08:23.069107 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-03 03:08:23.664703 | debian-bookworm | ok 2026-06-03 03:08:23.678098 | 2026-06-03 03:08:23.678317 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-03 03:08:23.763363 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:08:23.791825 | 2026-06-03 03:08:23.792022 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-03 03:08:24.297956 | debian-bookworm | ok 2026-06-03 03:08:24.311200 | 2026-06-03 03:08:24.311341 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-03 03:08:24.354140 | debian-bookworm | ok 2026-06-03 03:08:24.359862 | 2026-06-03 03:08:24.359977 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-03 03:08:24.921776 | debian-bookworm -> localhost | ok 2026-06-03 03:08:24.929263 | 2026-06-03 03:08:24.929446 | TASK [validate-host : Collect information about the host] 2026-06-03 03:08:26.589536 | debian-bookworm | ok 2026-06-03 03:08:26.611409 | 2026-06-03 03:08:26.611569 | TASK [validate-host : Sanitize hostname] 2026-06-03 03:08:26.758713 | debian-bookworm | ok 2026-06-03 03:08:26.805602 | 2026-06-03 03:08:26.805765 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-03 03:08:27.967462 | debian-bookworm -> localhost | changed 2026-06-03 03:08:27.973754 | 2026-06-03 03:08:27.973885 | TASK [validate-host : Collect information about zuul worker] 2026-06-03 03:08:28.550948 | debian-bookworm | ok 2026-06-03 03:08:28.555981 | 2026-06-03 03:08:28.556092 | TASK [validate-host : Write out all zuul information for each host] 2026-06-03 03:08:29.479563 | debian-bookworm -> localhost | changed 2026-06-03 03:08:29.490093 | 2026-06-03 03:08:29.490215 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-03 03:08:29.808855 | debian-bookworm | ok 2026-06-03 03:08:29.814915 | 2026-06-03 03:08:29.815051 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-03 03:08:31.231885 | debian-bookworm | changed: 2026-06-03 03:08:31.232109 | debian-bookworm | cd+++++++++ src/ 2026-06-03 03:08:31.232146 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-03 03:08:31.232172 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-03 03:08:31.232195 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-06-03 03:08:31.232216 | debian-bookworm | Containerfile 2026-06-03 03:08:31.232350 | debian-bookworm | Containerfile 2026-06-03 03:08:31.249235 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/4266ff26bd7d42778fe55c563e69ee73/work/logs" 2026-06-03 03:09:07.499055 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/4266ff26bd7d42778fe55c563e69ee73/work/artifacts" 2026-06-03 03:09:08.116830 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/4266ff26bd7d42778fe55c563e69ee73/work/docs" 2026-06-03 03:09:08.136800 | 2026-06-03 03:09:08.136917 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-03 03:09:09.119639 | debian-bookworm | changed: 2026-06-03 03:09:09.119915 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-03 03:09:09.119954 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-03 03:09:09.119984 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-03 03:09:09.120029 | debian-bookworm | changed: All items complete 2026-06-03 03:09:09.120058 | 2026-06-03 03:09:09.727911 | debian-bookworm | changed: .d..t...... ./ 2026-06-03 03:09:10.365389 | debian-bookworm | changed: .d..t...... ./ 2026-06-03 03:09:10.398730 | 2026-06-03 03:09:10.398890 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-03 03:09:10.480721 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:09:10.497370 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:09:10.514677 | 2026-06-03 03:09:10.514767 | PLAY RECAP 2026-06-03 03:09:10.514906 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-03 03:09:10.514935 | 2026-06-03 03:09:10.657347 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-03 03:09:10.658996 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-03 03:09:11.532394 | 2026-06-03 03:09:11.532513 | PLAY [Base post] 2026-06-03 03:09:11.553749 | 2026-06-03 03:09:11.553867 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-03 03:09:12.306655 | debian-bookworm | changed 2026-06-03 03:09:12.323000 | 2026-06-03 03:09:12.323121 | PLAY RECAP 2026-06-03 03:09:12.323184 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-03 03:09:12.323248 | 2026-06-03 03:09:12.601319 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-03 03:09:12.602130 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-03 03:09:13.542925 | 2026-06-03 03:09:13.543196 | PLAY [Base post-logs] 2026-06-03 03:09:13.558148 | 2026-06-03 03:09:13.558280 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-03 03:09:14.220823 | localhost | changed 2026-06-03 03:09:14.231245 | 2026-06-03 03:09:14.231396 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-03 03:09:14.257170 | localhost | ok 2026-06-03 03:09:14.260226 | 2026-06-03 03:09:14.260318 | TASK [Set zuul-log-path fact] 2026-06-03 03:09:14.275803 | localhost | ok 2026-06-03 03:09:14.285822 | 2026-06-03 03:09:14.285926 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-03 03:09:14.343067 | localhost | ok 2026-06-03 03:09:14.346381 | 2026-06-03 03:09:14.346472 | TASK [upload-logs : Create log directories] 2026-06-03 03:09:14.963333 | localhost | changed 2026-06-03 03:09:14.966800 | 2026-06-03 03:09:14.966925 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-03 03:09:15.785221 | localhost -> localhost | ok: Runtime: 0:00:00.023993 2026-06-03 03:09:15.789107 | 2026-06-03 03:09:15.789210 | TASK [upload-logs : Upload logs to log server] 2026-06-03 03:09:16.383047 | localhost | Output suppressed because no_log was given 2026-06-03 03:09:16.385777 | 2026-06-03 03:09:16.385873 | LOOP [upload-logs : Compress console log and json output] 2026-06-03 03:09:16.438263 | localhost | skipping: Conditional result was False 2026-06-03 03:09:16.450263 | localhost | skipping: Conditional result was False 2026-06-03 03:09:16.459230 | 2026-06-03 03:09:16.459349 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-03 03:09:16.504461 | localhost | skipping: Conditional result was False 2026-06-03 03:09:16.504872 | 2026-06-03 03:09:16.509088 | localhost | skipping: Conditional result was False 2026-06-03 03:09:16.515370 | 2026-06-03 03:09:16.515481 | LOOP [upload-logs : Upload console log and json output]