2026-05-22 03:04:42.087647 | Job console starting 2026-05-22 03:04:42.104447 | Updating git repos 2026-05-22 03:04:42.148400 | Cloning repos into workspace 2026-05-22 03:04:42.288518 | Restoring repo states 2026-05-22 03:04:42.328175 | Merging changes 2026-05-22 03:04:42.328190 | Checking out repos 2026-05-22 03:04:42.440285 | Preparing playbooks 2026-05-22 03:04:44.043750 | Running Ansible setup 2026-05-22 03:04:48.817389 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-22 03:04:49.732012 | 2026-05-22 03:04:49.732142 | PLAY [Base pre] 2026-05-22 03:04:49.768930 | 2026-05-22 03:04:49.769054 | TASK [Setup log path fact] 2026-05-22 03:04:49.807221 | debian-bookworm | ok 2026-05-22 03:04:49.838880 | 2026-05-22 03:04:49.839038 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-22 03:04:49.888344 | debian-bookworm | ok 2026-05-22 03:04:49.908642 | 2026-05-22 03:04:49.908758 | TASK [emit-job-header : Print job information] 2026-05-22 03:04:49.962525 | # Job Information 2026-05-22 03:04:49.962736 | Ansible Version: 2.16.14 2026-05-22 03:04:49.962771 | Job: python-black 2026-05-22 03:04:49.962811 | Pipeline: periodic-daily 2026-05-22 03:04:49.962854 | Executor: 521e9411259a 2026-05-22 03:04:49.962877 | Triggered by: https://github.com/osism/generics 2026-05-22 03:04:49.962898 | Event ID: 7f8b773abb2d47f5adbab31b3704a9ac 2026-05-22 03:04:49.969571 | 2026-05-22 03:04:49.969670 | LOOP [emit-job-header : Print node information] 2026-05-22 03:04:50.117107 | debian-bookworm | ok: 2026-05-22 03:04:50.117323 | debian-bookworm | # Node Information 2026-05-22 03:04:50.117395 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-22 03:04:50.117425 | debian-bookworm | Hostname: debian 2026-05-22 03:04:50.117448 | debian-bookworm | Username: zuul 2026-05-22 03:04:50.117470 | debian-bookworm | Distro: Debian 12.14 2026-05-22 03:04:50.117501 | debian-bookworm | Provider: regiocloud-a 2026-05-22 03:04:50.117533 | debian-bookworm | Region: 2026-05-22 03:04:50.117569 | debian-bookworm | Label: debian-bookworm 2026-05-22 03:04:50.117600 | debian-bookworm | Product Name: OpenStack Nova 2026-05-22 03:04:50.117631 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3b:481e 2026-05-22 03:04:50.138670 | 2026-05-22 03:04:50.141624 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-22 03:04:50.785640 | debian-bookworm -> localhost | changed 2026-05-22 03:04:50.792473 | 2026-05-22 03:04:50.792575 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-22 03:04:52.102306 | debian-bookworm -> localhost | changed 2026-05-22 03:04:52.120950 | 2026-05-22 03:04:52.121070 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-22 03:04:52.419628 | debian-bookworm -> localhost | ok 2026-05-22 03:04:52.425476 | 2026-05-22 03:04:52.425571 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-22 03:04:52.456057 | debian-bookworm | ok 2026-05-22 03:04:52.471824 | debian-bookworm | included: /var/lib/zuul/builds/f9ba024687bd4801ba217b23b1808674/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-22 03:04:52.477862 | 2026-05-22 03:04:52.477944 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-22 03:04:53.780438 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-22 03:04:53.780624 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f9ba024687bd4801ba217b23b1808674/work/f9ba024687bd4801ba217b23b1808674_id_rsa 2026-05-22 03:04:53.780660 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f9ba024687bd4801ba217b23b1808674/work/f9ba024687bd4801ba217b23b1808674_id_rsa.pub 2026-05-22 03:04:53.780687 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-22 03:04:53.780710 | debian-bookworm -> localhost | SHA256:61C1DfP3/nf1xla9RSukhTlyIF0njWl/zZFfMNPR9MY zuul-build-sshkey 2026-05-22 03:04:53.780733 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-22 03:04:53.780768 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-22 03:04:53.780790 | debian-bookworm -> localhost | | . .o+.+==| 2026-05-22 03:04:53.780811 | debian-bookworm -> localhost | | . o +o. *=| 2026-05-22 03:04:53.780832 | debian-bookworm -> localhost | | . * + .E| 2026-05-22 03:04:53.780852 | debian-bookworm -> localhost | | o @ + o=| 2026-05-22 03:04:53.780871 | debian-bookworm -> localhost | | S + B o.o| 2026-05-22 03:04:53.780896 | debian-bookworm -> localhost | | . . . o o=| 2026-05-22 03:04:53.780916 | debian-bookworm -> localhost | | . . ..B| 2026-05-22 03:04:53.780935 | debian-bookworm -> localhost | | o oB| 2026-05-22 03:04:53.780956 | debian-bookworm -> localhost | | . o*| 2026-05-22 03:04:53.780977 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-22 03:04:53.781031 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.817395 2026-05-22 03:04:53.787111 | 2026-05-22 03:04:53.787211 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-22 03:04:53.814862 | debian-bookworm | ok 2026-05-22 03:04:53.833443 | debian-bookworm | included: /var/lib/zuul/builds/f9ba024687bd4801ba217b23b1808674/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-22 03:04:53.852052 | 2026-05-22 03:04:53.852161 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-22 03:04:53.865465 | debian-bookworm | skipping: Conditional result was False 2026-05-22 03:04:53.871221 | 2026-05-22 03:04:53.871352 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-22 03:04:54.560000 | debian-bookworm | changed 2026-05-22 03:04:54.565431 | 2026-05-22 03:04:54.565529 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-22 03:04:54.842136 | debian-bookworm | ok 2026-05-22 03:04:54.847749 | 2026-05-22 03:04:54.847844 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-22 03:04:55.522648 | debian-bookworm | changed 2026-05-22 03:04:55.535181 | 2026-05-22 03:04:55.535290 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-22 03:04:56.335257 | debian-bookworm | changed 2026-05-22 03:04:56.346649 | 2026-05-22 03:04:56.346789 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-22 03:04:56.375657 | debian-bookworm | skipping: Conditional result was False 2026-05-22 03:04:56.382579 | 2026-05-22 03:04:56.382703 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-22 03:04:57.969490 | debian-bookworm -> localhost | changed 2026-05-22 03:04:58.003074 | 2026-05-22 03:04:58.003238 | TASK [add-build-sshkey : Add back temp key] 2026-05-22 03:04:58.746969 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f9ba024687bd4801ba217b23b1808674/work/f9ba024687bd4801ba217b23b1808674_id_rsa (zuul-build-sshkey) 2026-05-22 03:04:58.747266 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012528 2026-05-22 03:04:58.755735 | 2026-05-22 03:04:58.755861 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-22 03:04:59.166620 | debian-bookworm | ok 2026-05-22 03:04:59.173055 | 2026-05-22 03:04:59.173174 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-22 03:04:59.197936 | debian-bookworm | skipping: Conditional result was False 2026-05-22 03:04:59.207932 | 2026-05-22 03:04:59.208037 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-22 03:04:59.619651 | debian-bookworm | ok 2026-05-22 03:04:59.639186 | 2026-05-22 03:04:59.639324 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-22 03:04:59.687124 | debian-bookworm | ok 2026-05-22 03:04:59.692010 | 2026-05-22 03:04:59.692120 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-22 03:05:00.109611 | debian-bookworm -> localhost | ok 2026-05-22 03:05:00.116168 | 2026-05-22 03:05:00.116251 | TASK [validate-host : Collect information about the host] 2026-05-22 03:05:01.339369 | debian-bookworm | ok 2026-05-22 03:05:01.352610 | 2026-05-22 03:05:01.352727 | TASK [validate-host : Sanitize hostname] 2026-05-22 03:05:01.442344 | debian-bookworm | ok 2026-05-22 03:05:01.477238 | 2026-05-22 03:05:01.477339 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-22 03:05:02.083595 | debian-bookworm -> localhost | changed 2026-05-22 03:05:02.090408 | 2026-05-22 03:05:02.090530 | TASK [validate-host : Collect information about zuul worker] 2026-05-22 03:05:02.566907 | debian-bookworm | ok 2026-05-22 03:05:02.581827 | 2026-05-22 03:05:02.581970 | TASK [validate-host : Write out all zuul information for each host] 2026-05-22 03:05:03.287102 | debian-bookworm -> localhost | changed 2026-05-22 03:05:03.310548 | 2026-05-22 03:05:03.310906 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-22 03:05:03.707192 | debian-bookworm | ok 2026-05-22 03:05:03.713447 | 2026-05-22 03:05:03.713566 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-22 03:05:04.803766 | debian-bookworm | changed: 2026-05-22 03:05:04.803976 | debian-bookworm | cd+++++++++ src/ 2026-05-22 03:05:04.804013 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-22 03:05:04.804038 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-22 03:05:04.804081 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-05-22 03:05:04.804101 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/f9ba024687bd4801ba217b23b1808674/work/logs" 2026-05-22 03:05:32.336709 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f9ba024687bd4801ba217b23b1808674/work/artifacts" 2026-05-22 03:05:32.697379 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f9ba024687bd4801ba217b23b1808674/work/docs" 2026-05-22 03:05:32.716005 | 2026-05-22 03:05:32.716147 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-22 03:05:33.595646 | debian-bookworm | changed: 2026-05-22 03:05:33.596111 | debian-bookworm | .d..t...... ./ 2026-05-22 03:05:33.596194 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-22 03:05:33.596231 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-22 03:05:33.596261 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-22 03:05:33.597607 | debian-bookworm | changed: All items complete 2026-05-22 03:05:33.597710 | 2026-05-22 03:05:34.180073 | debian-bookworm | changed: .d..t...... ./ 2026-05-22 03:05:34.834368 | debian-bookworm | changed: .d..t...... ./ 2026-05-22 03:05:34.868247 | 2026-05-22 03:05:34.868402 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-22 03:05:34.900383 | debian-bookworm | skipping: Conditional result was False 2026-05-22 03:05:34.906709 | debian-bookworm | skipping: Conditional result was False 2026-05-22 03:05:34.920385 | 2026-05-22 03:05:34.920472 | PLAY RECAP 2026-05-22 03:05:34.920526 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-22 03:05:34.920550 | 2026-05-22 03:05:35.220454 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-22 03:05:35.221325 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-22 03:05:36.488363 | 2026-05-22 03:05:36.488536 | PLAY [Base post] 2026-05-22 03:05:36.516557 | 2026-05-22 03:05:36.516734 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-22 03:05:37.149511 | debian-bookworm | changed 2026-05-22 03:05:37.161570 | 2026-05-22 03:05:37.161770 | PLAY RECAP 2026-05-22 03:05:37.161917 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-22 03:05:37.161994 | 2026-05-22 03:05:37.339244 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-22 03:05:37.340095 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-22 03:05:38.337528 | 2026-05-22 03:05:38.337711 | PLAY [Base post-logs] 2026-05-22 03:05:38.353496 | 2026-05-22 03:05:38.353654 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-22 03:05:39.287672 | localhost | changed 2026-05-22 03:05:39.301468 | 2026-05-22 03:05:39.301652 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-22 03:05:39.353328 | localhost | ok 2026-05-22 03:05:39.356545 | 2026-05-22 03:05:39.356650 | TASK [Set zuul-log-path fact] 2026-05-22 03:05:39.382388 | localhost | ok 2026-05-22 03:05:39.393965 | 2026-05-22 03:05:39.394112 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-22 03:05:39.445700 | localhost | ok 2026-05-22 03:05:39.449651 | 2026-05-22 03:05:39.449820 | TASK [upload-logs : Create log directories] 2026-05-22 03:05:40.691682 | localhost | changed 2026-05-22 03:05:40.699946 | 2026-05-22 03:05:40.700135 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-22 03:05:42.371596 | localhost -> localhost | ok: Runtime: 0:00:00.038294 2026-05-22 03:05:42.376120 | 2026-05-22 03:05:42.376250 | TASK [upload-logs : Upload logs to log server] 2026-05-22 03:05:44.103148 | localhost | Output suppressed because no_log was given 2026-05-22 03:05:44.104489 | 2026-05-22 03:05:44.104558 | LOOP [upload-logs : Compress console log and json output] 2026-05-22 03:05:44.197521 | localhost | skipping: Conditional result was False 2026-05-22 03:05:44.212554 | localhost | skipping: Conditional result was False 2026-05-22 03:05:44.221008 | 2026-05-22 03:05:44.221116 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-22 03:05:44.345396 | localhost | skipping: Conditional result was False 2026-05-22 03:05:44.345638 | 2026-05-22 03:05:44.368149 | localhost | skipping: Conditional result was False 2026-05-22 03:05:44.371218 | 2026-05-22 03:05:44.371331 | LOOP [upload-logs : Upload console log and json output]