2026-05-28 19:11:57.614355 | Job console starting 2026-05-28 19:11:57.646996 | Updating git repos 2026-05-28 19:11:57.689783 | Cloning repos into workspace 2026-05-28 19:11:57.757861 | Restoring repo states 2026-05-28 19:11:57.772709 | Merging changes 2026-05-28 19:11:58.382370 | Checking out repos 2026-05-28 19:11:58.420831 | Preparing playbooks 2026-05-28 19:11:59.394150 | Running Ansible setup 2026-05-28 19:12:04.291146 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-28 19:12:05.104588 | 2026-05-28 19:12:05.104780 | PLAY [Base pre] 2026-05-28 19:12:05.141829 | 2026-05-28 19:12:05.142043 | TASK [Setup log path fact] 2026-05-28 19:12:05.172487 | debian-bookworm | ok 2026-05-28 19:12:05.195111 | 2026-05-28 19:12:05.195319 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 19:12:05.224885 | debian-bookworm | ok 2026-05-28 19:12:05.235278 | 2026-05-28 19:12:05.235428 | TASK [emit-job-header : Print job information] 2026-05-28 19:12:05.276168 | # Job Information 2026-05-28 19:12:05.276377 | Ansible Version: 2.16.14 2026-05-28 19:12:05.276413 | Job: flake8 2026-05-28 19:12:05.276444 | Pipeline: check 2026-05-28 19:12:05.276468 | Executor: 521e9411259a 2026-05-28 19:12:05.276489 | Triggered by: https://github.com/osism/openstack-image-manager/pull/944 2026-05-28 19:12:05.276511 | Event ID: 122d21b0-5ac9-11f1-812d-f278dd7a4d3b 2026-05-28 19:12:05.281725 | 2026-05-28 19:12:05.281870 | LOOP [emit-job-header : Print node information] 2026-05-28 19:12:05.415847 | debian-bookworm | ok: 2026-05-28 19:12:05.416072 | debian-bookworm | # Node Information 2026-05-28 19:12:05.416110 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-28 19:12:05.416137 | debian-bookworm | Hostname: debian 2026-05-28 19:12:05.416160 | debian-bookworm | Username: zuul 2026-05-28 19:12:05.416181 | debian-bookworm | Distro: Debian 12.14 2026-05-28 19:12:05.416204 | debian-bookworm | Provider: regiocloud-a 2026-05-28 19:12:05.416225 | debian-bookworm | Region: 2026-05-28 19:12:05.416246 | debian-bookworm | Label: debian-bookworm 2026-05-28 19:12:05.416265 | debian-bookworm | Product Name: OpenStack Nova 2026-05-28 19:12:05.416285 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb9:c76 2026-05-28 19:12:05.429775 | 2026-05-28 19:12:05.429919 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-28 19:12:06.275637 | debian-bookworm -> localhost | changed 2026-05-28 19:12:06.286275 | 2026-05-28 19:12:06.286439 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-28 19:12:07.828362 | debian-bookworm -> localhost | changed 2026-05-28 19:12:07.840573 | 2026-05-28 19:12:07.840714 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-28 19:12:08.221812 | debian-bookworm -> localhost | ok 2026-05-28 19:12:08.228508 | 2026-05-28 19:12:08.228653 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-28 19:12:08.259811 | debian-bookworm | ok 2026-05-28 19:12:08.292124 | debian-bookworm | included: /var/lib/zuul/builds/d1de4a20315e4e1e92792e3f3c5a15d5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-28 19:12:08.307415 | 2026-05-28 19:12:08.307568 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-28 19:12:10.255460 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-28 19:12:10.255691 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d1de4a20315e4e1e92792e3f3c5a15d5/work/d1de4a20315e4e1e92792e3f3c5a15d5_id_rsa 2026-05-28 19:12:10.255728 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d1de4a20315e4e1e92792e3f3c5a15d5/work/d1de4a20315e4e1e92792e3f3c5a15d5_id_rsa.pub 2026-05-28 19:12:10.255754 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-28 19:12:10.255777 | debian-bookworm -> localhost | SHA256:exsdn6Io8h0kiEjFbCmiHEpocyl+Esi7MRaMzhSO9+w zuul-build-sshkey 2026-05-28 19:12:10.255800 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-28 19:12:10.255831 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-28 19:12:10.255853 | debian-bookworm -> localhost | |*.+.o | 2026-05-28 19:12:10.255874 | debian-bookworm -> localhost | |B&.B | 2026-05-28 19:12:10.255895 | debian-bookworm -> localhost | |&o% | 2026-05-28 19:12:10.255914 | debian-bookworm -> localhost | |+& = . | 2026-05-28 19:12:10.255933 | debian-bookworm -> localhost | |o B + . S . | 2026-05-28 19:12:10.255995 | debian-bookworm -> localhost | | . . o . . o . | 2026-05-28 19:12:10.256017 | debian-bookworm -> localhost | | E o o o o | 2026-05-28 19:12:10.256037 | debian-bookworm -> localhost | | . .. + + . | 2026-05-28 19:12:10.256058 | debian-bookworm -> localhost | | o..o o | 2026-05-28 19:12:10.256078 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-28 19:12:10.256131 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.326542 2026-05-28 19:12:10.262751 | 2026-05-28 19:12:10.262935 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-28 19:12:10.297933 | debian-bookworm | ok 2026-05-28 19:12:10.316774 | debian-bookworm | included: /var/lib/zuul/builds/d1de4a20315e4e1e92792e3f3c5a15d5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-28 19:12:10.328325 | 2026-05-28 19:12:10.328433 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-28 19:12:10.342544 | debian-bookworm | skipping: Conditional result was False 2026-05-28 19:12:10.349088 | 2026-05-28 19:12:10.349192 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-28 19:12:10.960744 | debian-bookworm | changed 2026-05-28 19:12:10.966498 | 2026-05-28 19:12:10.966592 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-28 19:12:11.207408 | debian-bookworm | ok 2026-05-28 19:12:11.216684 | 2026-05-28 19:12:11.216795 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-28 19:12:11.841472 | debian-bookworm | changed 2026-05-28 19:12:11.853380 | 2026-05-28 19:12:11.853528 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-28 19:12:12.505097 | debian-bookworm | changed 2026-05-28 19:12:12.511793 | 2026-05-28 19:12:12.511896 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-28 19:12:12.535311 | debian-bookworm | skipping: Conditional result was False 2026-05-28 19:12:12.541292 | 2026-05-28 19:12:12.542071 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-28 19:12:12.923193 | debian-bookworm -> localhost | changed 2026-05-28 19:12:12.933774 | 2026-05-28 19:12:12.933896 | TASK [add-build-sshkey : Add back temp key] 2026-05-28 19:12:13.232040 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d1de4a20315e4e1e92792e3f3c5a15d5/work/d1de4a20315e4e1e92792e3f3c5a15d5_id_rsa (zuul-build-sshkey) 2026-05-28 19:12:13.232261 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019500 2026-05-28 19:12:13.239801 | 2026-05-28 19:12:13.239895 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-28 19:12:13.633864 | debian-bookworm | ok 2026-05-28 19:12:13.638993 | 2026-05-28 19:12:13.639086 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-28 19:12:13.661852 | debian-bookworm | skipping: Conditional result was False 2026-05-28 19:12:13.671910 | 2026-05-28 19:12:13.672028 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-28 19:12:14.104005 | debian-bookworm | ok 2026-05-28 19:12:14.117732 | 2026-05-28 19:12:14.117838 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-28 19:12:14.165769 | debian-bookworm | ok 2026-05-28 19:12:14.170668 | 2026-05-28 19:12:14.170761 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-28 19:12:14.546695 | debian-bookworm -> localhost | ok 2026-05-28 19:12:14.553883 | 2026-05-28 19:12:14.554023 | TASK [validate-host : Collect information about the host] 2026-05-28 19:12:15.671845 | debian-bookworm | ok 2026-05-28 19:12:15.682755 | 2026-05-28 19:12:15.682964 | TASK [validate-host : Sanitize hostname] 2026-05-28 19:12:15.816827 | debian-bookworm | ok 2026-05-28 19:12:15.876629 | 2026-05-28 19:12:15.876816 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-28 19:12:16.477416 | debian-bookworm -> localhost | changed 2026-05-28 19:12:16.485178 | 2026-05-28 19:12:16.485334 | TASK [validate-host : Collect information about zuul worker] 2026-05-28 19:12:16.927463 | debian-bookworm | ok 2026-05-28 19:12:16.932492 | 2026-05-28 19:12:16.932627 | TASK [validate-host : Write out all zuul information for each host] 2026-05-28 19:12:17.611371 | debian-bookworm -> localhost | changed 2026-05-28 19:12:17.622049 | 2026-05-28 19:12:17.622188 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-28 19:12:17.912015 | debian-bookworm | ok 2026-05-28 19:12:17.918041 | 2026-05-28 19:12:17.918166 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-28 19:12:18.764549 | debian-bookworm | changed: 2026-05-28 19:12:18.764762 | debian-bookworm | cd+++++++++ src/ 2026-05-28 19:12:18.764796 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-28 19:12:18.764819 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-28 19:12:18.764840 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-28 19:12:18.764859 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/d1de4a20315e4e1e92792e3f3c5a15d5/work/logs" 2026-05-28 19:12:46.478432 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d1de4a20315e4e1e92792e3f3c5a15d5/work/artifacts" 2026-05-28 19:12:46.752353 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d1de4a20315e4e1e92792e3f3c5a15d5/work/docs" 2026-05-28 19:12:46.773642 | 2026-05-28 19:12:46.773796 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-28 19:12:47.582707 | debian-bookworm | changed: 2026-05-28 19:12:47.583104 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-28 19:12:47.583148 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-28 19:12:47.583178 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-28 19:12:47.583229 | debian-bookworm | changed: All items complete 2026-05-28 19:12:47.583257 | 2026-05-28 19:12:48.228638 | debian-bookworm | changed: .d..t...... ./ 2026-05-28 19:12:48.790581 | debian-bookworm | changed: .d..t...... ./ 2026-05-28 19:12:48.814090 | 2026-05-28 19:12:48.814266 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-28 19:12:49.480884 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.014055 2026-05-28 19:12:49.977751 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.027651 2026-05-28 19:12:49.989216 | 2026-05-28 19:12:49.989348 | PLAY RECAP 2026-05-28 19:12:49.989403 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-28 19:12:49.989429 | 2026-05-28 19:12:50.182947 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-28 19:12:50.183827 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 19:12:50.940449 | 2026-05-28 19:12:50.940623 | PLAY [Base post] 2026-05-28 19:12:50.961421 | 2026-05-28 19:12:50.961589 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-28 19:12:51.540726 | debian-bookworm | changed 2026-05-28 19:12:51.548498 | 2026-05-28 19:12:51.548619 | PLAY RECAP 2026-05-28 19:12:51.548683 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-28 19:12:51.548746 | 2026-05-28 19:12:51.683211 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 19:12:51.684094 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-28 19:12:52.575030 | 2026-05-28 19:12:52.575688 | PLAY [Base post-logs] 2026-05-28 19:12:52.589811 | 2026-05-28 19:12:52.589983 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-28 19:12:53.109636 | localhost | changed 2026-05-28 19:12:53.129632 | 2026-05-28 19:12:53.129978 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-28 19:12:53.171957 | localhost | ok 2026-05-28 19:12:53.177987 | 2026-05-28 19:12:53.178174 | TASK [Set zuul-log-path fact] 2026-05-28 19:12:53.197918 | localhost | ok 2026-05-28 19:12:53.209993 | 2026-05-28 19:12:53.210168 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 19:12:53.241213 | localhost | ok 2026-05-28 19:12:53.248889 | 2026-05-28 19:12:53.249114 | TASK [upload-logs : Create log directories] 2026-05-28 19:12:53.769067 | localhost | changed 2026-05-28 19:12:53.772269 | 2026-05-28 19:12:53.772384 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-28 19:12:54.361831 | localhost -> localhost | ok: Runtime: 0:00:00.008101 2026-05-28 19:12:54.368792 | 2026-05-28 19:12:54.368984 | TASK [upload-logs : Upload logs to log server] 2026-05-28 19:12:54.989667 | localhost | Output suppressed because no_log was given 2026-05-28 19:12:54.992474 | 2026-05-28 19:12:54.992616 | LOOP [upload-logs : Compress console log and json output] 2026-05-28 19:12:55.059979 | localhost | skipping: Conditional result was False 2026-05-28 19:12:55.071472 | localhost | skipping: Conditional result was False 2026-05-28 19:12:55.089287 | 2026-05-28 19:12:55.089599 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-28 19:12:55.145069 | localhost | skipping: Conditional result was False 2026-05-28 19:12:55.145494 | 2026-05-28 19:12:55.149832 | localhost | skipping: Conditional result was False 2026-05-28 19:12:55.160470 | 2026-05-28 19:12:55.160613 | LOOP [upload-logs : Upload console log and json output]