2026-05-13 03:06:27.696152 | Job console starting 2026-05-13 03:06:27.717670 | Updating git repos 2026-05-13 03:06:27.782164 | Cloning repos into workspace 2026-05-13 03:06:27.852319 | Restoring repo states 2026-05-13 03:06:27.881522 | Merging changes 2026-05-13 03:06:27.881539 | Checking out repos 2026-05-13 03:06:27.932170 | Preparing playbooks 2026-05-13 03:06:28.690881 | Running Ansible setup 2026-05-13 03:06:33.593682 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-13 03:06:34.350697 | 2026-05-13 03:06:34.350887 | PLAY [Base pre] 2026-05-13 03:06:34.379777 | 2026-05-13 03:06:34.379950 | TASK [Setup log path fact] 2026-05-13 03:06:34.397358 | debian-bookworm | ok 2026-05-13 03:06:34.412230 | 2026-05-13 03:06:34.412346 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-13 03:06:34.441886 | debian-bookworm | ok 2026-05-13 03:06:34.454795 | 2026-05-13 03:06:34.455040 | TASK [emit-job-header : Print job information] 2026-05-13 03:06:34.494378 | # Job Information 2026-05-13 03:06:34.494530 | Ansible Version: 2.16.14 2026-05-13 03:06:34.494559 | Job: python-black 2026-05-13 03:06:34.494607 | Pipeline: periodic-daily 2026-05-13 03:06:34.494629 | Executor: 521e9411259a 2026-05-13 03:06:34.494646 | Triggered by: https://github.com/osism/generics 2026-05-13 03:06:34.494664 | Event ID: d9ae1020cd224495b020872cb3ec555b 2026-05-13 03:06:34.499604 | 2026-05-13 03:06:34.499706 | LOOP [emit-job-header : Print node information] 2026-05-13 03:06:34.608995 | debian-bookworm | ok: 2026-05-13 03:06:34.609181 | debian-bookworm | # Node Information 2026-05-13 03:06:34.609210 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-13 03:06:34.609232 | debian-bookworm | Hostname: debian 2026-05-13 03:06:34.609252 | debian-bookworm | Username: zuul 2026-05-13 03:06:34.609269 | debian-bookworm | Distro: Debian 12.13 2026-05-13 03:06:34.609289 | debian-bookworm | Provider: regiocloud-a 2026-05-13 03:06:34.609309 | debian-bookworm | Region: 2026-05-13 03:06:34.609335 | debian-bookworm | Label: debian-bookworm 2026-05-13 03:06:34.609362 | debian-bookworm | Product Name: OpenStack Nova 2026-05-13 03:06:34.609384 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5c:e210 2026-05-13 03:06:34.620510 | 2026-05-13 03:06:34.620646 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-13 03:06:35.013406 | debian-bookworm -> localhost | changed 2026-05-13 03:06:35.019381 | 2026-05-13 03:06:35.019522 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-13 03:06:36.324562 | debian-bookworm -> localhost | changed 2026-05-13 03:06:36.337421 | 2026-05-13 03:06:36.337520 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-13 03:06:36.675123 | debian-bookworm -> localhost | ok 2026-05-13 03:06:36.681892 | 2026-05-13 03:06:36.681996 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-13 03:06:36.704282 | debian-bookworm | ok 2026-05-13 03:06:36.721767 | debian-bookworm | included: /var/lib/zuul/builds/ca222502c9b34ee6a742213835bd8695/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-13 03:06:36.727166 | 2026-05-13 03:06:36.727249 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-13 03:06:39.320308 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-13 03:06:39.320535 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ca222502c9b34ee6a742213835bd8695/work/ca222502c9b34ee6a742213835bd8695_id_rsa 2026-05-13 03:06:39.320573 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ca222502c9b34ee6a742213835bd8695/work/ca222502c9b34ee6a742213835bd8695_id_rsa.pub 2026-05-13 03:06:39.320633 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-13 03:06:39.320658 | debian-bookworm -> localhost | SHA256:jxle8EZRGfv0VAdyJNW7Ov/M0jzrI1xr1cDtnrtDoSg zuul-build-sshkey 2026-05-13 03:06:39.320680 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-13 03:06:39.320712 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-13 03:06:39.320734 | debian-bookworm -> localhost | | ..===oo| 2026-05-13 03:06:39.320756 | debian-bookworm -> localhost | | ..= +| 2026-05-13 03:06:39.320777 | debian-bookworm -> localhost | | . . ....o| 2026-05-13 03:06:39.320797 | debian-bookworm -> localhost | | + oo=.| 2026-05-13 03:06:39.320817 | debian-bookworm -> localhost | | S + . oo=| 2026-05-13 03:06:39.320840 | debian-bookworm -> localhost | | . E . . ++| 2026-05-13 03:06:39.320860 | debian-bookworm -> localhost | | + o . +++| 2026-05-13 03:06:39.320880 | debian-bookworm -> localhost | | =.X+| 2026-05-13 03:06:39.320901 | debian-bookworm -> localhost | | *B%| 2026-05-13 03:06:39.320922 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-13 03:06:39.320978 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.877611 2026-05-13 03:06:39.328076 | 2026-05-13 03:06:39.328244 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-13 03:06:39.357331 | debian-bookworm | ok 2026-05-13 03:06:39.374060 | debian-bookworm | included: /var/lib/zuul/builds/ca222502c9b34ee6a742213835bd8695/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-13 03:06:39.395936 | 2026-05-13 03:06:39.396044 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-13 03:06:39.432830 | debian-bookworm | skipping: Conditional result was False 2026-05-13 03:06:39.439791 | 2026-05-13 03:06:39.439900 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-13 03:06:40.258419 | debian-bookworm | changed 2026-05-13 03:06:40.272585 | 2026-05-13 03:06:40.272692 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-13 03:06:40.579366 | debian-bookworm | ok 2026-05-13 03:06:40.592615 | 2026-05-13 03:06:40.592733 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-13 03:06:41.339837 | debian-bookworm | changed 2026-05-13 03:06:41.345371 | 2026-05-13 03:06:41.345455 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-13 03:06:42.061030 | debian-bookworm | changed 2026-05-13 03:06:42.065375 | 2026-05-13 03:06:42.065452 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-13 03:06:42.102401 | debian-bookworm | skipping: Conditional result was False 2026-05-13 03:06:42.107846 | 2026-05-13 03:06:42.107935 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-13 03:06:42.619256 | debian-bookworm -> localhost | changed 2026-05-13 03:06:42.628028 | 2026-05-13 03:06:42.628132 | TASK [add-build-sshkey : Add back temp key] 2026-05-13 03:06:43.318212 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ca222502c9b34ee6a742213835bd8695/work/ca222502c9b34ee6a742213835bd8695_id_rsa (zuul-build-sshkey) 2026-05-13 03:06:43.318407 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020661 2026-05-13 03:06:43.325340 | 2026-05-13 03:06:43.325435 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-13 03:06:43.797819 | debian-bookworm | ok 2026-05-13 03:06:43.802097 | 2026-05-13 03:06:43.802185 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-13 03:06:43.851459 | debian-bookworm | skipping: Conditional result was False 2026-05-13 03:06:43.860275 | 2026-05-13 03:06:43.860367 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-13 03:06:44.361253 | debian-bookworm | ok 2026-05-13 03:06:44.380185 | 2026-05-13 03:06:44.380764 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-13 03:06:44.414958 | debian-bookworm | ok 2026-05-13 03:06:44.421268 | 2026-05-13 03:06:44.422406 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-13 03:06:44.943526 | debian-bookworm -> localhost | ok 2026-05-13 03:06:44.958087 | 2026-05-13 03:06:44.958192 | TASK [validate-host : Collect information about the host] 2026-05-13 03:06:46.413192 | debian-bookworm | ok 2026-05-13 03:06:46.434225 | 2026-05-13 03:06:46.434331 | TASK [validate-host : Sanitize hostname] 2026-05-13 03:06:46.554136 | debian-bookworm | ok 2026-05-13 03:06:46.599820 | 2026-05-13 03:06:46.599931 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-13 03:06:47.728816 | debian-bookworm -> localhost | changed 2026-05-13 03:06:47.734912 | 2026-05-13 03:06:47.735016 | TASK [validate-host : Collect information about zuul worker] 2026-05-13 03:06:48.533289 | debian-bookworm | ok 2026-05-13 03:06:48.544360 | 2026-05-13 03:06:48.544466 | TASK [validate-host : Write out all zuul information for each host] 2026-05-13 03:06:49.805673 | debian-bookworm -> localhost | changed 2026-05-13 03:06:49.815762 | 2026-05-13 03:06:49.815865 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-13 03:06:50.129179 | debian-bookworm | ok 2026-05-13 03:06:50.140163 | 2026-05-13 03:06:50.140272 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-13 03:06:51.230122 | debian-bookworm | changed: 2026-05-13 03:06:51.230301 | debian-bookworm | cd+++++++++ src/ 2026-05-13 03:06:51.230335 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-13 03:06:51.230360 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-13 03:06:51.230382 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-05-13 03:06:51.230402 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/ca222502c9b34ee6a742213835bd8695/work/logs" 2026-05-13 03:07:19.004145 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ca222502c9b34ee6a742213835bd8695/work/artifacts" 2026-05-13 03:07:19.334920 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ca222502c9b34ee6a742213835bd8695/work/docs" 2026-05-13 03:07:19.355845 | 2026-05-13 03:07:19.356031 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-13 03:07:20.177578 | debian-bookworm | changed: 2026-05-13 03:07:20.177822 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-13 03:07:20.177857 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-13 03:07:20.177887 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-13 03:07:20.177936 | debian-bookworm | changed: All items complete 2026-05-13 03:07:20.177963 | 2026-05-13 03:07:20.842215 | debian-bookworm | changed: .d..t...... ./ 2026-05-13 03:07:21.448631 | debian-bookworm | changed: .d..t...... ./ 2026-05-13 03:07:21.469208 | 2026-05-13 03:07:21.469355 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-13 03:07:21.509784 | debian-bookworm | skipping: Conditional result was False 2026-05-13 03:07:21.519438 | debian-bookworm | skipping: Conditional result was False 2026-05-13 03:07:21.541864 | 2026-05-13 03:07:21.542009 | PLAY RECAP 2026-05-13 03:07:21.542090 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-13 03:07:21.542132 | 2026-05-13 03:07:21.702415 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-13 03:07:21.705021 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-13 03:07:22.539491 | 2026-05-13 03:07:22.539693 | PLAY [Base post] 2026-05-13 03:07:22.555176 | 2026-05-13 03:07:22.555334 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-13 03:07:23.172718 | debian-bookworm | changed 2026-05-13 03:07:23.183211 | 2026-05-13 03:07:23.183341 | PLAY RECAP 2026-05-13 03:07:23.183416 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-13 03:07:23.183484 | 2026-05-13 03:07:23.326585 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-13 03:07:23.327493 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-13 03:07:24.231873 | 2026-05-13 03:07:24.232054 | PLAY [Base post-logs] 2026-05-13 03:07:24.244029 | 2026-05-13 03:07:24.244198 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-13 03:07:24.969286 | localhost | changed 2026-05-13 03:07:25.001978 | 2026-05-13 03:07:25.003122 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-13 03:07:25.097924 | localhost | ok 2026-05-13 03:07:25.112142 | 2026-05-13 03:07:25.112335 | TASK [Set zuul-log-path fact] 2026-05-13 03:07:25.139873 | localhost | ok 2026-05-13 03:07:25.153859 | 2026-05-13 03:07:25.154016 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-13 03:07:25.193757 | localhost | ok 2026-05-13 03:07:25.197684 | 2026-05-13 03:07:25.197806 | TASK [upload-logs : Create log directories] 2026-05-13 03:07:26.455337 | localhost | changed 2026-05-13 03:07:26.461934 | 2026-05-13 03:07:26.463233 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-13 03:07:27.856434 | localhost -> localhost | ok: Runtime: 0:00:00.020612 2026-05-13 03:07:27.862584 | 2026-05-13 03:07:27.862803 | TASK [upload-logs : Upload logs to log server] 2026-05-13 03:07:28.993013 | localhost | Output suppressed because no_log was given 2026-05-13 03:07:28.995287 | 2026-05-13 03:07:28.995401 | LOOP [upload-logs : Compress console log and json output] 2026-05-13 03:07:29.073155 | localhost | skipping: Conditional result was False 2026-05-13 03:07:29.080430 | localhost | skipping: Conditional result was False 2026-05-13 03:07:29.093513 | 2026-05-13 03:07:29.093673 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-13 03:07:29.154270 | localhost | skipping: Conditional result was False 2026-05-13 03:07:29.154615 | 2026-05-13 03:07:29.161186 | localhost | skipping: Conditional result was False 2026-05-13 03:07:29.165232 | 2026-05-13 03:07:29.165364 | LOOP [upload-logs : Upload console log and json output]