2026-05-16 03:01:21.290054 | Job console starting 2026-05-16 03:01:21.309457 | Updating git repos 2026-05-16 03:01:21.739433 | Cloning repos into workspace 2026-05-16 03:01:21.856149 | Restoring repo states 2026-05-16 03:01:21.895688 | Merging changes 2026-05-16 03:01:21.895816 | Checking out repos 2026-05-16 03:01:22.022949 | Preparing playbooks 2026-05-16 03:01:23.843608 | Running Ansible setup 2026-05-16 03:01:33.311752 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-16 03:01:35.540033 | 2026-05-16 03:01:35.540158 | PLAY [Base pre] 2026-05-16 03:01:35.586754 | 2026-05-16 03:01:35.586898 | TASK [Setup log path fact] 2026-05-16 03:01:35.631675 | debian-bookworm | ok 2026-05-16 03:01:35.666513 | 2026-05-16 03:01:35.667588 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-16 03:01:35.797017 | debian-bookworm | ok 2026-05-16 03:01:35.895705 | 2026-05-16 03:01:35.896781 | TASK [emit-job-header : Print job information] 2026-05-16 03:01:36.006371 | # Job Information 2026-05-16 03:01:36.006513 | Ansible Version: 2.16.14 2026-05-16 03:01:36.006541 | Job: python-black 2026-05-16 03:01:36.006568 | Pipeline: periodic-daily 2026-05-16 03:01:36.006586 | Executor: 521e9411259a 2026-05-16 03:01:36.006626 | Triggered by: https://github.com/osism/openstack-project-manager 2026-05-16 03:01:36.006645 | Event ID: d5b6c66e664d4e3ba013414bafcf9910 2026-05-16 03:01:36.012689 | 2026-05-16 03:01:36.012796 | LOOP [emit-job-header : Print node information] 2026-05-16 03:01:36.297387 | debian-bookworm | ok: 2026-05-16 03:01:36.297605 | debian-bookworm | # Node Information 2026-05-16 03:01:36.297642 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-16 03:01:36.297669 | debian-bookworm | Hostname: debian 2026-05-16 03:01:36.297693 | debian-bookworm | Username: zuul 2026-05-16 03:01:36.297716 | debian-bookworm | Distro: Debian 12.13 2026-05-16 03:01:36.297742 | debian-bookworm | Provider: regiocloud-a 2026-05-16 03:01:36.297764 | debian-bookworm | Region: 2026-05-16 03:01:36.297785 | debian-bookworm | Label: debian-bookworm 2026-05-16 03:01:36.297804 | debian-bookworm | Product Name: OpenStack Nova 2026-05-16 03:01:36.297824 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe92:25c4 2026-05-16 03:01:36.317233 | 2026-05-16 03:01:36.318790 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-16 03:01:37.676255 | debian-bookworm -> localhost | changed 2026-05-16 03:01:37.701637 | 2026-05-16 03:01:37.701750 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-16 03:01:39.266060 | debian-bookworm -> localhost | changed 2026-05-16 03:01:39.283726 | 2026-05-16 03:01:39.287491 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-16 03:01:39.618670 | debian-bookworm -> localhost | ok 2026-05-16 03:01:39.626587 | 2026-05-16 03:01:39.626731 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-16 03:01:39.648347 | debian-bookworm | ok 2026-05-16 03:01:39.670636 | debian-bookworm | included: /var/lib/zuul/builds/ccdae66532a949598367a4faaaba7f15/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-16 03:01:39.678782 | 2026-05-16 03:01:39.678904 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-16 03:01:45.405835 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-16 03:01:45.406095 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ccdae66532a949598367a4faaaba7f15/work/ccdae66532a949598367a4faaaba7f15_id_rsa 2026-05-16 03:01:45.406138 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ccdae66532a949598367a4faaaba7f15/work/ccdae66532a949598367a4faaaba7f15_id_rsa.pub 2026-05-16 03:01:45.406166 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-16 03:01:45.406192 | debian-bookworm -> localhost | SHA256:SzPNCXMvLApDJttQ8NWqJEeP+HocmS0xOXDuriMBlNU zuul-build-sshkey 2026-05-16 03:01:45.406215 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-16 03:01:45.406247 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-16 03:01:45.406270 | debian-bookworm -> localhost | | +oo .. | 2026-05-16 03:01:45.406292 | debian-bookworm -> localhost | | o.ooE . | 2026-05-16 03:01:45.406312 | debian-bookworm -> localhost | |. o*++ .o . | 2026-05-16 03:01:45.406332 | debian-bookworm -> localhost | |. oBX o B o | 2026-05-16 03:01:45.406353 | debian-bookworm -> localhost | |. .*+O S * . | 2026-05-16 03:01:45.406381 | debian-bookworm -> localhost | |. Oo.o = . | 2026-05-16 03:01:45.406401 | debian-bookworm -> localhost | | . + o. . | 2026-05-16 03:01:45.406421 | debian-bookworm -> localhost | |. o + | 2026-05-16 03:01:45.406443 | debian-bookworm -> localhost | | ..+ | 2026-05-16 03:01:45.406463 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-16 03:01:45.406520 | debian-bookworm -> localhost | ok: Runtime: 0:00:05.044860 2026-05-16 03:01:45.412860 | 2026-05-16 03:01:45.412962 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-16 03:01:45.441723 | debian-bookworm | ok 2026-05-16 03:01:45.458368 | debian-bookworm | included: /var/lib/zuul/builds/ccdae66532a949598367a4faaaba7f15/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-16 03:01:45.467707 | 2026-05-16 03:01:45.467800 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-16 03:01:45.501577 | debian-bookworm | skipping: Conditional result was False 2026-05-16 03:01:45.508907 | 2026-05-16 03:01:45.509019 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-16 03:01:46.197244 | debian-bookworm | changed 2026-05-16 03:01:46.207289 | 2026-05-16 03:01:46.207392 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-16 03:01:46.477852 | debian-bookworm | ok 2026-05-16 03:01:46.484105 | 2026-05-16 03:01:46.484209 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-16 03:01:47.204659 | debian-bookworm | changed 2026-05-16 03:01:47.221542 | 2026-05-16 03:01:47.221669 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-16 03:01:48.085988 | debian-bookworm | changed 2026-05-16 03:01:48.168782 | 2026-05-16 03:01:48.168899 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-16 03:01:48.220566 | debian-bookworm | skipping: Conditional result was False 2026-05-16 03:01:48.227063 | 2026-05-16 03:01:48.227158 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-16 03:01:49.787937 | debian-bookworm -> localhost | changed 2026-05-16 03:01:49.815897 | 2026-05-16 03:01:49.816092 | TASK [add-build-sshkey : Add back temp key] 2026-05-16 03:01:50.963228 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ccdae66532a949598367a4faaaba7f15/work/ccdae66532a949598367a4faaaba7f15_id_rsa (zuul-build-sshkey) 2026-05-16 03:01:50.964027 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.045188 2026-05-16 03:01:50.978512 | 2026-05-16 03:01:50.980067 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-16 03:01:51.541332 | debian-bookworm | ok 2026-05-16 03:01:51.546366 | 2026-05-16 03:01:51.546468 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-16 03:01:51.583286 | debian-bookworm | skipping: Conditional result was False 2026-05-16 03:01:51.594224 | 2026-05-16 03:01:51.594332 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-16 03:01:52.423788 | debian-bookworm | ok 2026-05-16 03:01:52.434099 | 2026-05-16 03:01:52.434206 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-16 03:01:52.514242 | debian-bookworm | ok 2026-05-16 03:01:52.519883 | 2026-05-16 03:01:52.519976 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-16 03:01:53.169315 | debian-bookworm -> localhost | ok 2026-05-16 03:01:53.176257 | 2026-05-16 03:01:53.176352 | TASK [validate-host : Collect information about the host] 2026-05-16 03:01:54.595424 | debian-bookworm | ok 2026-05-16 03:01:54.611442 | 2026-05-16 03:01:54.611544 | TASK [validate-host : Sanitize hostname] 2026-05-16 03:01:54.770925 | debian-bookworm | ok 2026-05-16 03:01:54.881674 | 2026-05-16 03:01:54.881802 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-16 03:01:55.914821 | debian-bookworm -> localhost | changed 2026-05-16 03:01:55.919636 | 2026-05-16 03:01:55.919726 | TASK [validate-host : Collect information about zuul worker] 2026-05-16 03:01:56.401360 | debian-bookworm | ok 2026-05-16 03:01:56.406048 | 2026-05-16 03:01:56.406134 | TASK [validate-host : Write out all zuul information for each host] 2026-05-16 03:01:57.512956 | debian-bookworm -> localhost | changed 2026-05-16 03:01:57.520837 | 2026-05-16 03:01:57.520931 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-16 03:01:57.789570 | debian-bookworm | ok 2026-05-16 03:01:57.802532 | 2026-05-16 03:01:57.802654 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-16 03:01:59.041425 | debian-bookworm | changed: 2026-05-16 03:01:59.041654 | debian-bookworm | cd+++++++++ src/ 2026-05-16 03:01:59.041693 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-16 03:01:59.041717 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-16 03:01:59.041739 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2026-05-16 03:01:59.041759 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/ccdae66532a949598367a4faaaba7f15/work/logs" 2026-05-16 03:02:30.113861 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ccdae66532a949598367a4faaaba7f15/work/artifacts" 2026-05-16 03:02:30.707033 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ccdae66532a949598367a4faaaba7f15/work/docs" 2026-05-16 03:02:30.721719 | 2026-05-16 03:02:30.721854 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-16 03:02:32.287664 | debian-bookworm | changed: 2026-05-16 03:02:32.288933 | debian-bookworm | .d..t...... ./ 2026-05-16 03:02:32.288986 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-16 03:02:32.289021 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-16 03:02:32.289053 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-16 03:02:32.289100 | debian-bookworm | changed: All items complete 2026-05-16 03:02:32.289126 | 2026-05-16 03:02:33.494027 | debian-bookworm | changed: .d..t...... ./ 2026-05-16 03:02:34.514765 | debian-bookworm | changed: .d..t...... ./ 2026-05-16 03:02:34.535507 | 2026-05-16 03:02:34.535612 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-16 03:02:34.556726 | debian-bookworm | skipping: Conditional result was False 2026-05-16 03:02:34.562506 | debian-bookworm | skipping: Conditional result was False 2026-05-16 03:02:34.574433 | 2026-05-16 03:02:34.574502 | PLAY RECAP 2026-05-16 03:02:34.574543 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-16 03:02:34.574562 | 2026-05-16 03:02:34.715507 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-16 03:02:34.716644 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-16 03:02:36.096102 | 2026-05-16 03:02:36.096246 | PLAY [Base post] 2026-05-16 03:02:36.110470 | 2026-05-16 03:02:36.110608 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-16 03:02:36.747685 | debian-bookworm | changed 2026-05-16 03:02:36.755722 | 2026-05-16 03:02:36.755821 | PLAY RECAP 2026-05-16 03:02:36.755883 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-16 03:02:36.755942 | 2026-05-16 03:02:36.852904 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-16 03:02:36.853640 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-16 03:02:37.817953 | 2026-05-16 03:02:37.818098 | PLAY [Base post-logs] 2026-05-16 03:02:37.830642 | 2026-05-16 03:02:37.830780 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-16 03:02:38.822143 | localhost | changed 2026-05-16 03:02:38.841757 | 2026-05-16 03:02:38.841920 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-16 03:02:38.917930 | localhost | ok 2026-05-16 03:02:38.930433 | 2026-05-16 03:02:38.930545 | TASK [Set zuul-log-path fact] 2026-05-16 03:02:38.960172 | localhost | ok 2026-05-16 03:02:38.979438 | 2026-05-16 03:02:38.979562 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-16 03:02:39.034427 | localhost | ok 2026-05-16 03:02:39.038766 | 2026-05-16 03:02:39.039237 | TASK [upload-logs : Create log directories] 2026-05-16 03:02:41.013410 | localhost | changed 2026-05-16 03:02:41.019756 | 2026-05-16 03:02:41.022026 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-16 03:02:42.623811 | localhost -> localhost | ok: Runtime: 0:00:00.048187 2026-05-16 03:02:42.627780 | 2026-05-16 03:02:42.627880 | TASK [upload-logs : Upload logs to log server] 2026-05-16 03:02:43.939760 | localhost | Output suppressed because no_log was given 2026-05-16 03:02:43.941536 | 2026-05-16 03:02:43.941656 | LOOP [upload-logs : Compress console log and json output] 2026-05-16 03:02:44.027894 | localhost | skipping: Conditional result was False 2026-05-16 03:02:44.034240 | localhost | skipping: Conditional result was False 2026-05-16 03:02:44.038311 | 2026-05-16 03:02:44.038447 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-16 03:02:44.104813 | localhost | skipping: Conditional result was False 2026-05-16 03:02:44.105043 | 2026-05-16 03:02:44.110427 | localhost | skipping: Conditional result was False 2026-05-16 03:02:44.114928 | 2026-05-16 03:02:44.115055 | LOOP [upload-logs : Upload console log and json output]