2026-05-18 03:01:53.776951 | Job console starting 2026-05-18 03:01:53.784106 | Updating git repos 2026-05-18 03:01:53.817972 | Cloning repos into workspace 2026-05-18 03:01:54.060570 | Restoring repo states 2026-05-18 03:01:54.087018 | Merging changes 2026-05-18 03:01:54.087062 | Checking out repos 2026-05-18 03:01:54.196023 | Preparing playbooks 2026-05-18 03:01:55.340547 | Running Ansible setup 2026-05-18 03:02:02.801747 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-18 03:02:04.554939 | 2026-05-18 03:02:04.555171 | PLAY [Base pre] 2026-05-18 03:02:04.586436 | 2026-05-18 03:02:04.586664 | TASK [Setup log path fact] 2026-05-18 03:02:04.606103 | debian-bookworm | ok 2026-05-18 03:02:04.634859 | 2026-05-18 03:02:04.634996 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 03:02:04.685455 | debian-bookworm | ok 2026-05-18 03:02:04.695591 | 2026-05-18 03:02:04.695693 | TASK [emit-job-header : Print job information] 2026-05-18 03:02:04.768294 | # Job Information 2026-05-18 03:02:04.768460 | Ansible Version: 2.16.14 2026-05-18 03:02:04.768496 | Job: flake8 2026-05-18 03:02:04.768530 | Pipeline: periodic-daily 2026-05-18 03:02:04.768554 | Executor: 521e9411259a 2026-05-18 03:02:04.768576 | Triggered by: https://github.com/osism/openstack-image-manager 2026-05-18 03:02:04.768599 | Event ID: 8672d863767d4aa78a1277547960fa70 2026-05-18 03:02:04.773381 | 2026-05-18 03:02:04.773473 | LOOP [emit-job-header : Print node information] 2026-05-18 03:02:04.957036 | debian-bookworm | ok: 2026-05-18 03:02:04.957277 | debian-bookworm | # Node Information 2026-05-18 03:02:04.957317 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-18 03:02:04.957343 | debian-bookworm | Hostname: debian 2026-05-18 03:02:04.957366 | debian-bookworm | Username: zuul 2026-05-18 03:02:04.957387 | debian-bookworm | Distro: Debian 12.14 2026-05-18 03:02:04.957416 | debian-bookworm | Provider: regiocloud-a 2026-05-18 03:02:04.957442 | debian-bookworm | Region: 2026-05-18 03:02:04.957463 | debian-bookworm | Label: debian-bookworm 2026-05-18 03:02:04.957483 | debian-bookworm | Product Name: OpenStack Nova 2026-05-18 03:02:04.957502 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0e:d921 2026-05-18 03:02:04.975801 | 2026-05-18 03:02:04.975912 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-18 03:02:06.418417 | debian-bookworm -> localhost | changed 2026-05-18 03:02:06.427276 | 2026-05-18 03:02:06.427419 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-18 03:02:09.848309 | debian-bookworm -> localhost | changed 2026-05-18 03:02:09.868396 | 2026-05-18 03:02:09.868563 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-18 03:02:10.958229 | debian-bookworm -> localhost | ok 2026-05-18 03:02:10.964835 | 2026-05-18 03:02:10.964967 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-18 03:02:11.013694 | debian-bookworm | ok 2026-05-18 03:02:11.098309 | debian-bookworm | included: /var/lib/zuul/builds/eecd879140f3479782aa8631fc932984/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-18 03:02:11.141181 | 2026-05-18 03:02:11.141339 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-18 03:02:13.888021 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-18 03:02:13.888231 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/eecd879140f3479782aa8631fc932984/work/eecd879140f3479782aa8631fc932984_id_rsa 2026-05-18 03:02:13.888270 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/eecd879140f3479782aa8631fc932984/work/eecd879140f3479782aa8631fc932984_id_rsa.pub 2026-05-18 03:02:13.888297 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-18 03:02:13.888322 | debian-bookworm -> localhost | SHA256:vTGzA7AkoiKLtdHgn7dzDLLy0cV2ADFV3BpfN4JGoLQ zuul-build-sshkey 2026-05-18 03:02:13.888344 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-18 03:02:13.888378 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-18 03:02:13.888401 | debian-bookworm -> localhost | | ++.++o. | 2026-05-18 03:02:13.888423 | debian-bookworm -> localhost | | .oo oo.....| 2026-05-18 03:02:13.888443 | debian-bookworm -> localhost | | o . oE. .+ ....| 2026-05-18 03:02:13.888463 | debian-bookworm -> localhost | | o + o + o. . | 2026-05-18 03:02:13.888482 | debian-bookworm -> localhost | |+ + . . S * | 2026-05-18 03:02:13.888504 | debian-bookworm -> localhost | |+o +.o.o o * | 2026-05-18 03:02:13.888525 | debian-bookworm -> localhost | |o . +ooo + | 2026-05-18 03:02:13.888545 | debian-bookworm -> localhost | | . .o..o . | 2026-05-18 03:02:13.888566 | debian-bookworm -> localhost | | o. .o | 2026-05-18 03:02:13.888587 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-18 03:02:13.888639 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.156653 2026-05-18 03:02:13.894909 | 2026-05-18 03:02:13.895009 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-18 03:02:13.952037 | debian-bookworm | ok 2026-05-18 03:02:13.976200 | debian-bookworm | included: /var/lib/zuul/builds/eecd879140f3479782aa8631fc932984/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-18 03:02:13.996413 | 2026-05-18 03:02:13.996525 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-18 03:02:14.019651 | debian-bookworm | skipping: Conditional result was False 2026-05-18 03:02:14.025567 | 2026-05-18 03:02:14.025727 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-18 03:02:15.085110 | debian-bookworm | changed 2026-05-18 03:02:15.089535 | 2026-05-18 03:02:15.089606 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-18 03:02:15.425279 | debian-bookworm | ok 2026-05-18 03:02:15.430041 | 2026-05-18 03:02:15.430128 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-18 03:02:16.331393 | debian-bookworm | changed 2026-05-18 03:02:16.337258 | 2026-05-18 03:02:16.339208 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-18 03:02:17.153007 | debian-bookworm | changed 2026-05-18 03:02:17.157697 | 2026-05-18 03:02:17.157781 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-18 03:02:17.246772 | debian-bookworm | skipping: Conditional result was False 2026-05-18 03:02:17.251826 | 2026-05-18 03:02:17.251916 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-18 03:02:17.851937 | debian-bookworm -> localhost | changed 2026-05-18 03:02:17.860654 | 2026-05-18 03:02:17.860743 | TASK [add-build-sshkey : Add back temp key] 2026-05-18 03:02:18.529502 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/eecd879140f3479782aa8631fc932984/work/eecd879140f3479782aa8631fc932984_id_rsa (zuul-build-sshkey) 2026-05-18 03:02:18.529706 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.044237 2026-05-18 03:02:18.536575 | 2026-05-18 03:02:18.536678 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-18 03:02:19.324436 | debian-bookworm | ok 2026-05-18 03:02:19.328793 | 2026-05-18 03:02:19.328896 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-18 03:02:19.373299 | debian-bookworm | skipping: Conditional result was False 2026-05-18 03:02:19.381844 | 2026-05-18 03:02:19.381931 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-18 03:02:20.111384 | debian-bookworm | ok 2026-05-18 03:02:20.132679 | 2026-05-18 03:02:20.132779 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-18 03:02:20.183727 | debian-bookworm | ok 2026-05-18 03:02:20.187747 | 2026-05-18 03:02:20.187829 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-18 03:02:20.920798 | debian-bookworm -> localhost | ok 2026-05-18 03:02:20.926136 | 2026-05-18 03:02:20.926223 | TASK [validate-host : Collect information about the host] 2026-05-18 03:02:22.677660 | debian-bookworm | ok 2026-05-18 03:02:22.695555 | 2026-05-18 03:02:22.695654 | TASK [validate-host : Sanitize hostname] 2026-05-18 03:02:23.029126 | debian-bookworm | ok 2026-05-18 03:02:23.155129 | 2026-05-18 03:02:23.155243 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-18 03:02:24.882268 | debian-bookworm -> localhost | changed 2026-05-18 03:02:24.887007 | 2026-05-18 03:02:24.887116 | TASK [validate-host : Collect information about zuul worker] 2026-05-18 03:02:25.763116 | debian-bookworm | ok 2026-05-18 03:02:25.766928 | 2026-05-18 03:02:25.767008 | TASK [validate-host : Write out all zuul information for each host] 2026-05-18 03:02:27.212903 | debian-bookworm -> localhost | changed 2026-05-18 03:02:27.222936 | 2026-05-18 03:02:27.223036 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-18 03:02:27.562367 | debian-bookworm | ok 2026-05-18 03:02:27.567674 | 2026-05-18 03:02:27.567768 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-18 03:02:28.786256 | debian-bookworm | changed: 2026-05-18 03:02:28.786471 | debian-bookworm | cd+++++++++ src/ 2026-05-18 03:02:28.786505 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-18 03:02:28.786529 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-18 03:02:28.786551 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-18 03:02:28.786572 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/eecd879140f3479782aa8631fc932984/work/logs" 2026-05-18 03:03:03.438812 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/eecd879140f3479782aa8631fc932984/work/artifacts" 2026-05-18 03:03:03.947964 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/eecd879140f3479782aa8631fc932984/work/docs" 2026-05-18 03:03:03.958015 | 2026-05-18 03:03:03.958146 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-18 03:03:05.136554 | debian-bookworm | changed: 2026-05-18 03:03:05.136729 | debian-bookworm | .d..t...... ./ 2026-05-18 03:03:05.136762 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-18 03:03:05.136787 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-18 03:03:05.136809 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-18 03:03:05.136841 | debian-bookworm | changed: All items complete 2026-05-18 03:03:05.136862 | 2026-05-18 03:03:05.957969 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 03:03:06.929227 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 03:03:06.960880 | 2026-05-18 03:03:06.960993 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-18 03:03:07.009773 | debian-bookworm | skipping: Conditional result was False 2026-05-18 03:03:07.013850 | debian-bookworm | skipping: Conditional result was False 2026-05-18 03:03:07.024647 | 2026-05-18 03:03:07.024722 | PLAY RECAP 2026-05-18 03:03:07.024769 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-18 03:03:07.024791 | 2026-05-18 03:03:07.173615 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-18 03:03:07.174281 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 03:03:08.255236 | 2026-05-18 03:03:08.255349 | PLAY [Base post] 2026-05-18 03:03:08.266089 | 2026-05-18 03:03:08.266194 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-18 03:03:08.877000 | debian-bookworm | changed 2026-05-18 03:03:08.881829 | 2026-05-18 03:03:08.881899 | PLAY RECAP 2026-05-18 03:03:08.881950 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-18 03:03:08.882000 | 2026-05-18 03:03:09.003322 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 03:03:09.003937 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-18 03:03:09.964434 | 2026-05-18 03:03:09.965589 | PLAY [Base post-logs] 2026-05-18 03:03:10.007048 | 2026-05-18 03:03:10.007206 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-18 03:03:10.673340 | localhost | changed 2026-05-18 03:03:10.680844 | 2026-05-18 03:03:10.680960 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-18 03:03:10.740408 | localhost | ok 2026-05-18 03:03:10.742760 | 2026-05-18 03:03:10.742902 | TASK [Set zuul-log-path fact] 2026-05-18 03:03:10.767515 | localhost | ok 2026-05-18 03:03:10.774187 | 2026-05-18 03:03:10.774272 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 03:03:10.823122 | localhost | ok 2026-05-18 03:03:10.825928 | 2026-05-18 03:03:10.826020 | TASK [upload-logs : Create log directories] 2026-05-18 03:03:11.754748 | localhost | changed 2026-05-18 03:03:11.756916 | 2026-05-18 03:03:11.756992 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-18 03:03:12.376900 | localhost -> localhost | ok: Runtime: 0:00:00.004049 2026-05-18 03:03:12.380593 | 2026-05-18 03:03:12.380686 | TASK [upload-logs : Upload logs to log server] 2026-05-18 03:03:12.980176 | localhost | Output suppressed because no_log was given 2026-05-18 03:03:12.981918 | 2026-05-18 03:03:12.982014 | LOOP [upload-logs : Compress console log and json output] 2026-05-18 03:03:13.044492 | localhost | skipping: Conditional result was False 2026-05-18 03:03:13.049117 | localhost | skipping: Conditional result was False 2026-05-18 03:03:13.059127 | 2026-05-18 03:03:13.059255 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-18 03:03:13.107763 | localhost | skipping: Conditional result was False 2026-05-18 03:03:13.108088 | 2026-05-18 03:03:13.115050 | localhost | skipping: Conditional result was False 2026-05-18 03:03:13.125836 | 2026-05-18 03:03:13.125953 | LOOP [upload-logs : Upload console log and json output]