2026-06-03 10:58:34.040508 | Job console starting 2026-06-03 10:58:34.072649 | Updating git repos 2026-06-03 10:58:34.139806 | Cloning repos into workspace 2026-06-03 10:58:34.194562 | Restoring repo states 2026-06-03 10:58:34.209193 | Merging changes 2026-06-03 10:58:34.742733 | Checking out repos 2026-06-03 10:58:34.812297 | Preparing playbooks 2026-06-03 10:58:36.092110 | Running Ansible setup 2026-06-03 10:58:40.736026 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-03 10:58:41.712461 | 2026-06-03 10:58:41.712631 | PLAY [Base pre] 2026-06-03 10:58:41.730441 | 2026-06-03 10:58:41.730602 | TASK [Setup log path fact] 2026-06-03 10:58:41.761389 | debian-bookworm | ok 2026-06-03 10:58:41.778289 | 2026-06-03 10:58:41.778503 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-03 10:58:41.808754 | debian-bookworm | ok 2026-06-03 10:58:41.819176 | 2026-06-03 10:58:41.819304 | TASK [emit-job-header : Print job information] 2026-06-03 10:58:41.859313 | # Job Information 2026-06-03 10:58:41.859538 | Ansible Version: 2.16.14 2026-06-03 10:58:41.859573 | Job: python-black 2026-06-03 10:58:41.859606 | Pipeline: check 2026-06-03 10:58:41.859629 | Executor: 521e9411259a 2026-06-03 10:58:41.859650 | Triggered by: https://github.com/osism/openstack-project-manager/pull/287 2026-06-03 10:58:41.859672 | Event ID: 245f71a0-5f3b-11f1-92a2-8c8fedd8163a 2026-06-03 10:58:41.871719 | 2026-06-03 10:58:41.871878 | LOOP [emit-job-header : Print node information] 2026-06-03 10:58:42.003556 | debian-bookworm | ok: 2026-06-03 10:58:42.003815 | debian-bookworm | # Node Information 2026-06-03 10:58:42.003856 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-03 10:58:42.003883 | debian-bookworm | Hostname: debian 2026-06-03 10:58:42.003906 | debian-bookworm | Username: zuul 2026-06-03 10:58:42.003928 | debian-bookworm | Distro: Debian 12.14 2026-06-03 10:58:42.003952 | debian-bookworm | Provider: regiocloud-a 2026-06-03 10:58:42.003973 | debian-bookworm | Region: 2026-06-03 10:58:42.003995 | debian-bookworm | Label: debian-bookworm 2026-06-03 10:58:42.004015 | debian-bookworm | Product Name: OpenStack Nova 2026-06-03 10:58:42.004035 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe36:5642 2026-06-03 10:58:42.025490 | 2026-06-03 10:58:42.025631 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-03 10:58:42.654780 | debian-bookworm -> localhost | changed 2026-06-03 10:58:42.662230 | 2026-06-03 10:58:42.662396 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-03 10:58:43.872260 | debian-bookworm -> localhost | changed 2026-06-03 10:58:43.882232 | 2026-06-03 10:58:43.882340 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-03 10:58:44.401489 | debian-bookworm -> localhost | ok 2026-06-03 10:58:44.407243 | 2026-06-03 10:58:44.407347 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-03 10:58:44.436350 | debian-bookworm | ok 2026-06-03 10:58:44.462099 | debian-bookworm | included: /var/lib/zuul/builds/e0191102b9834e8fb4519aee34e6345f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-03 10:58:44.476726 | 2026-06-03 10:58:44.476805 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-03 10:58:45.923015 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-03 10:58:45.923388 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e0191102b9834e8fb4519aee34e6345f/work/e0191102b9834e8fb4519aee34e6345f_id_rsa 2026-06-03 10:58:45.923472 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e0191102b9834e8fb4519aee34e6345f/work/e0191102b9834e8fb4519aee34e6345f_id_rsa.pub 2026-06-03 10:58:45.923532 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-03 10:58:45.923584 | debian-bookworm -> localhost | SHA256:6yTrBn7tXD126ZQ7CS5yG0pbe7rbDlFFRHxiooBOPQ0 zuul-build-sshkey 2026-06-03 10:58:45.923631 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-03 10:58:45.923691 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-03 10:58:45.923737 | debian-bookworm -> localhost | | oEo == | 2026-06-03 10:58:45.923781 | debian-bookworm -> localhost | | o + . ..+ .| 2026-06-03 10:58:45.923823 | debian-bookworm -> localhost | | o o ..o o | 2026-06-03 10:58:45.923863 | debian-bookworm -> localhost | | . .. | 2026-06-03 10:58:45.923903 | debian-bookworm -> localhost | | S . | 2026-06-03 10:58:45.923950 | debian-bookworm -> localhost | | . . o. o | 2026-06-03 10:58:45.923992 | debian-bookworm -> localhost | | . ...+ =.+.=. | 2026-06-03 10:58:45.924033 | debian-bookworm -> localhost | | . oBo=o*o=o. | 2026-06-03 10:58:45.924076 | debian-bookworm -> localhost | | +o.*o*Oo o. | 2026-06-03 10:58:45.924119 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-03 10:58:45.924224 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.790004 2026-06-03 10:58:45.935358 | 2026-06-03 10:58:45.935461 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-03 10:58:45.965635 | debian-bookworm | ok 2026-06-03 10:58:45.974818 | debian-bookworm | included: /var/lib/zuul/builds/e0191102b9834e8fb4519aee34e6345f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-03 10:58:45.983495 | 2026-06-03 10:58:45.983576 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-03 10:58:46.006653 | debian-bookworm | skipping: Conditional result was False 2026-06-03 10:58:46.012412 | 2026-06-03 10:58:46.012503 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-03 10:58:46.671965 | debian-bookworm | changed 2026-06-03 10:58:46.678443 | 2026-06-03 10:58:46.678544 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-03 10:58:46.930510 | debian-bookworm | ok 2026-06-03 10:58:46.937410 | 2026-06-03 10:58:46.937530 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-03 10:58:47.566102 | debian-bookworm | changed 2026-06-03 10:58:47.571629 | 2026-06-03 10:58:47.571713 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-03 10:58:48.261612 | debian-bookworm | changed 2026-06-03 10:58:48.266928 | 2026-06-03 10:58:48.267015 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-03 10:58:48.302010 | debian-bookworm | skipping: Conditional result was False 2026-06-03 10:58:48.307841 | 2026-06-03 10:58:48.307936 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-03 10:58:48.762894 | debian-bookworm -> localhost | changed 2026-06-03 10:58:48.772973 | 2026-06-03 10:58:48.773069 | TASK [add-build-sshkey : Add back temp key] 2026-06-03 10:58:49.116585 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e0191102b9834e8fb4519aee34e6345f/work/e0191102b9834e8fb4519aee34e6345f_id_rsa (zuul-build-sshkey) 2026-06-03 10:58:49.117055 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020895 2026-06-03 10:58:49.134684 | 2026-06-03 10:58:49.134799 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-03 10:58:49.568176 | debian-bookworm | ok 2026-06-03 10:58:49.573525 | 2026-06-03 10:58:49.573658 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-03 10:58:49.611075 | debian-bookworm | skipping: Conditional result was False 2026-06-03 10:58:49.622080 | 2026-06-03 10:58:49.622220 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-03 10:58:50.078732 | debian-bookworm | ok 2026-06-03 10:58:50.089889 | 2026-06-03 10:58:50.090019 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-03 10:58:50.118988 | debian-bookworm | ok 2026-06-03 10:58:50.124145 | 2026-06-03 10:58:50.124254 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-03 10:58:50.432089 | debian-bookworm -> localhost | ok 2026-06-03 10:58:50.439110 | 2026-06-03 10:58:50.439234 | TASK [validate-host : Collect information about the host] 2026-06-03 10:58:51.549780 | debian-bookworm | ok 2026-06-03 10:58:51.562547 | 2026-06-03 10:58:51.562697 | TASK [validate-host : Sanitize hostname] 2026-06-03 10:58:51.722318 | debian-bookworm | ok 2026-06-03 10:58:51.803275 | 2026-06-03 10:58:51.803448 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-03 10:58:52.775529 | debian-bookworm -> localhost | changed 2026-06-03 10:58:52.781861 | 2026-06-03 10:58:52.781981 | TASK [validate-host : Collect information about zuul worker] 2026-06-03 10:58:53.242360 | debian-bookworm | ok 2026-06-03 10:58:53.248643 | 2026-06-03 10:58:53.248772 | TASK [validate-host : Write out all zuul information for each host] 2026-06-03 10:58:53.841515 | debian-bookworm -> localhost | changed 2026-06-03 10:58:53.853662 | 2026-06-03 10:58:53.853799 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-03 10:58:54.140634 | debian-bookworm | ok 2026-06-03 10:58:54.147606 | 2026-06-03 10:58:54.147726 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-03 10:58:54.979624 | debian-bookworm | changed: 2026-06-03 10:58:54.979916 | debian-bookworm | cd+++++++++ src/ 2026-06-03 10:58:54.979971 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-03 10:58:54.980010 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-03 10:58:54.980044 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2026-06-03 10:58:54.980077 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/e0191102b9834e8fb4519aee34e6345f/work/logs" 2026-06-03 10:59:21.116806 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e0191102b9834e8fb4519aee34e6345f/work/artifacts" 2026-06-03 10:59:21.396843 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e0191102b9834e8fb4519aee34e6345f/work/docs" 2026-06-03 10:59:21.420577 | 2026-06-03 10:59:21.420798 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-03 10:59:22.225173 | debian-bookworm | changed: 2026-06-03 10:59:22.225453 | debian-bookworm | .d..t...... ./ 2026-06-03 10:59:22.225492 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-03 10:59:22.225522 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-03 10:59:22.225548 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-03 10:59:22.225590 | debian-bookworm | changed: All items complete 2026-06-03 10:59:22.225617 | 2026-06-03 10:59:22.784672 | debian-bookworm | changed: .d..t...... ./ 2026-06-03 10:59:23.386383 | debian-bookworm | changed: .d..t...... ./ 2026-06-03 10:59:23.409667 | 2026-06-03 10:59:23.409827 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-03 10:59:23.970429 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006394 2026-06-03 10:59:24.233661 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008981 2026-06-03 10:59:24.251299 | 2026-06-03 10:59:24.251489 | PLAY RECAP 2026-06-03 10:59:24.251572 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-03 10:59:24.251614 | 2026-06-03 10:59:24.408052 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-03 10:59:24.409031 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-03 10:59:25.173575 | 2026-06-03 10:59:25.173760 | PLAY [Base post] 2026-06-03 10:59:25.196943 | 2026-06-03 10:59:25.197156 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-03 10:59:25.764524 | debian-bookworm | changed 2026-06-03 10:59:25.771858 | 2026-06-03 10:59:25.771988 | PLAY RECAP 2026-06-03 10:59:25.772055 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-03 10:59:25.772117 | 2026-06-03 10:59:25.940560 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-03 10:59:25.941424 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-03 10:59:26.746202 | 2026-06-03 10:59:26.746409 | PLAY [Base post-logs] 2026-06-03 10:59:26.757725 | 2026-06-03 10:59:26.757889 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-03 10:59:27.259898 | localhost | changed 2026-06-03 10:59:27.270785 | 2026-06-03 10:59:27.270989 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-03 10:59:27.296810 | localhost | ok 2026-06-03 10:59:27.300162 | 2026-06-03 10:59:27.300271 | TASK [Set zuul-log-path fact] 2026-06-03 10:59:27.318020 | localhost | ok 2026-06-03 10:59:27.335489 | 2026-06-03 10:59:27.335628 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-03 10:59:27.367430 | localhost | ok 2026-06-03 10:59:27.370555 | 2026-06-03 10:59:27.370664 | TASK [upload-logs : Create log directories] 2026-06-03 10:59:27.989240 | localhost | changed 2026-06-03 10:59:27.992157 | 2026-06-03 10:59:27.992273 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-03 10:59:28.512477 | localhost -> localhost | ok: Runtime: 0:00:00.006483 2026-06-03 10:59:28.516708 | 2026-06-03 10:59:28.516836 | TASK [upload-logs : Upload logs to log server] 2026-06-03 10:59:29.080826 | localhost | Output suppressed because no_log was given 2026-06-03 10:59:29.084016 | 2026-06-03 10:59:29.087137 | LOOP [upload-logs : Compress console log and json output] 2026-06-03 10:59:29.136055 | localhost | skipping: Conditional result was False 2026-06-03 10:59:29.144259 | localhost | skipping: Conditional result was False 2026-06-03 10:59:29.158065 | 2026-06-03 10:59:29.158266 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-03 10:59:29.219412 | localhost | skipping: Conditional result was False 2026-06-03 10:59:29.219723 | 2026-06-03 10:59:29.224767 | localhost | skipping: Conditional result was False 2026-06-03 10:59:29.238608 | 2026-06-03 10:59:29.238758 | LOOP [upload-logs : Upload console log and json output]