2026-04-30 03:17:29.341081 | Job console starting 2026-04-30 03:17:29.355040 | Updating git repos 2026-04-30 03:17:29.392503 | Cloning repos into workspace 2026-04-30 03:17:29.452496 | Restoring repo states 2026-04-30 03:17:29.468212 | Merging changes 2026-04-30 03:17:29.468229 | Checking out repos 2026-04-30 03:17:29.591767 | Preparing playbooks 2026-04-30 03:17:30.240341 | Running Ansible setup 2026-04-30 03:17:34.535346 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-30 03:17:35.356114 | 2026-04-30 03:17:35.356255 | PLAY [Base pre] 2026-04-30 03:17:35.372212 | 2026-04-30 03:17:35.372344 | TASK [Setup log path fact] 2026-04-30 03:17:35.401642 | debian-bookworm | ok 2026-04-30 03:17:35.417826 | 2026-04-30 03:17:35.417959 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-30 03:17:35.447029 | debian-bookworm | ok 2026-04-30 03:17:35.459629 | 2026-04-30 03:17:35.459745 | TASK [emit-job-header : Print job information] 2026-04-30 03:17:35.502011 | # Job Information 2026-04-30 03:17:35.502233 | Ansible Version: 2.16.14 2026-04-30 03:17:35.502283 | Job: python-black 2026-04-30 03:17:35.502329 | Pipeline: periodic-daily 2026-04-30 03:17:35.502362 | Executor: 521e9411259a 2026-04-30 03:17:35.502392 | Triggered by: https://github.com/osism/ansible-collection-services 2026-04-30 03:17:35.502424 | Event ID: 3b918c59d32644f4b2414bec3b3ca398 2026-04-30 03:17:35.508634 | 2026-04-30 03:17:35.508753 | LOOP [emit-job-header : Print node information] 2026-04-30 03:17:35.614924 | debian-bookworm | ok: 2026-04-30 03:17:35.615356 | debian-bookworm | # Node Information 2026-04-30 03:17:35.615422 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-04-30 03:17:35.615463 | debian-bookworm | Hostname: debian 2026-04-30 03:17:35.615499 | debian-bookworm | Username: zuul 2026-04-30 03:17:35.615532 | debian-bookworm | Distro: Debian 12.13 2026-04-30 03:17:35.615573 | debian-bookworm | Provider: regiocloud-a 2026-04-30 03:17:35.615625 | debian-bookworm | Region: 2026-04-30 03:17:35.615659 | debian-bookworm | Label: debian-bookworm 2026-04-30 03:17:35.615691 | debian-bookworm | Product Name: OpenStack Nova 2026-04-30 03:17:35.615722 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec4:2ead 2026-04-30 03:17:35.642371 | 2026-04-30 03:17:35.642507 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-30 03:17:36.113536 | debian-bookworm -> localhost | changed 2026-04-30 03:17:36.125506 | 2026-04-30 03:17:36.125691 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-30 03:17:37.104212 | debian-bookworm -> localhost | changed 2026-04-30 03:17:37.114947 | 2026-04-30 03:17:37.115059 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-30 03:17:37.384736 | debian-bookworm -> localhost | ok 2026-04-30 03:17:37.392910 | 2026-04-30 03:17:37.393050 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-30 03:17:37.427579 | debian-bookworm | ok 2026-04-30 03:17:37.462899 | debian-bookworm | included: /var/lib/zuul/builds/24d28853d99145c9bb9a55311b065506/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-30 03:17:37.470530 | 2026-04-30 03:17:37.470675 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-30 03:17:38.461889 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-04-30 03:17:38.462098 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/24d28853d99145c9bb9a55311b065506/work/24d28853d99145c9bb9a55311b065506_id_rsa 2026-04-30 03:17:38.462133 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/24d28853d99145c9bb9a55311b065506/work/24d28853d99145c9bb9a55311b065506_id_rsa.pub 2026-04-30 03:17:38.462159 | debian-bookworm -> localhost | The key fingerprint is: 2026-04-30 03:17:38.462183 | debian-bookworm -> localhost | SHA256:yRTpsvg+j5vjJDjW+A1kngtUBMvb3ECheXYAx0WUN5o zuul-build-sshkey 2026-04-30 03:17:38.462206 | debian-bookworm -> localhost | The key's randomart image is: 2026-04-30 03:17:38.462242 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-04-30 03:17:38.462264 | debian-bookworm -> localhost | | o+*=+... | 2026-04-30 03:17:38.462285 | debian-bookworm -> localhost | | . B... +. | 2026-04-30 03:17:38.462305 | debian-bookworm -> localhost | | = = .=.. | 2026-04-30 03:17:38.462324 | debian-bookworm -> localhost | | B +Eo.. | 2026-04-30 03:17:38.462343 | debian-bookworm -> localhost | | o =..oS | 2026-04-30 03:17:38.462373 | debian-bookworm -> localhost | | . B... | 2026-04-30 03:17:38.462393 | debian-bookworm -> localhost | | * *.. | 2026-04-30 03:17:38.462413 | debian-bookworm -> localhost | | . + *+o | 2026-04-30 03:17:38.462433 | debian-bookworm -> localhost | | ooB=. | 2026-04-30 03:17:38.462452 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-04-30 03:17:38.462507 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.434817 2026-04-30 03:17:38.469038 | 2026-04-30 03:17:38.469141 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-30 03:17:38.503180 | debian-bookworm | ok 2026-04-30 03:17:38.516135 | debian-bookworm | included: /var/lib/zuul/builds/24d28853d99145c9bb9a55311b065506/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-30 03:17:38.526190 | 2026-04-30 03:17:38.526288 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-30 03:17:38.559656 | debian-bookworm | skipping: Conditional result was False 2026-04-30 03:17:38.573317 | 2026-04-30 03:17:38.573474 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-30 03:17:39.260534 | debian-bookworm | changed 2026-04-30 03:17:39.267686 | 2026-04-30 03:17:39.267781 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-30 03:17:39.542421 | debian-bookworm | ok 2026-04-30 03:17:39.549080 | 2026-04-30 03:17:39.549188 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-30 03:17:40.299054 | debian-bookworm | changed 2026-04-30 03:17:40.307213 | 2026-04-30 03:17:40.307407 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-30 03:17:41.084123 | debian-bookworm | changed 2026-04-30 03:17:41.099676 | 2026-04-30 03:17:41.101516 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-30 03:17:41.140255 | debian-bookworm | skipping: Conditional result was False 2026-04-30 03:17:41.162468 | 2026-04-30 03:17:41.162582 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-30 03:17:41.915697 | debian-bookworm -> localhost | changed 2026-04-30 03:17:41.926507 | 2026-04-30 03:17:41.926643 | TASK [add-build-sshkey : Add back temp key] 2026-04-30 03:17:42.263796 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/24d28853d99145c9bb9a55311b065506/work/24d28853d99145c9bb9a55311b065506_id_rsa (zuul-build-sshkey) 2026-04-30 03:17:42.264115 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012752 2026-04-30 03:17:42.275802 | 2026-04-30 03:17:42.275923 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-30 03:17:42.679836 | debian-bookworm | ok 2026-04-30 03:17:42.684807 | 2026-04-30 03:17:42.684895 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-30 03:17:42.718134 | debian-bookworm | skipping: Conditional result was False 2026-04-30 03:17:42.728572 | 2026-04-30 03:17:42.728698 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-30 03:17:43.231015 | debian-bookworm | ok 2026-04-30 03:17:43.244934 | 2026-04-30 03:17:43.245052 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-30 03:17:43.299647 | debian-bookworm | ok 2026-04-30 03:17:43.304774 | 2026-04-30 03:17:43.304889 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-30 03:17:43.777732 | debian-bookworm -> localhost | ok 2026-04-30 03:17:43.787127 | 2026-04-30 03:17:43.787240 | TASK [validate-host : Collect information about the host] 2026-04-30 03:17:45.043986 | debian-bookworm | ok 2026-04-30 03:17:45.054482 | 2026-04-30 03:17:45.054597 | TASK [validate-host : Sanitize hostname] 2026-04-30 03:17:45.154542 | debian-bookworm | ok 2026-04-30 03:17:45.188360 | 2026-04-30 03:17:45.188468 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-30 03:17:45.946874 | debian-bookworm -> localhost | changed 2026-04-30 03:17:45.952327 | 2026-04-30 03:17:45.952429 | TASK [validate-host : Collect information about zuul worker] 2026-04-30 03:17:46.454524 | debian-bookworm | ok 2026-04-30 03:17:46.467668 | 2026-04-30 03:17:46.467786 | TASK [validate-host : Write out all zuul information for each host] 2026-04-30 03:17:47.375980 | debian-bookworm -> localhost | changed 2026-04-30 03:17:47.387280 | 2026-04-30 03:17:47.387379 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-30 03:17:47.711036 | debian-bookworm | ok 2026-04-30 03:17:47.717406 | 2026-04-30 03:17:47.717508 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-30 03:17:49.367338 | debian-bookworm | changed: 2026-04-30 03:17:49.367545 | debian-bookworm | cd+++++++++ src/ 2026-04-30 03:17:49.367583 | debian-bookworm | cd+++++++++ src/github.com/ 2026-04-30 03:17:49.367646 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-04-30 03:17:49.367679 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2026-04-30 03:17:49.367699 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/24d28853d99145c9bb9a55311b065506/work/logs" 2026-04-30 03:18:18.921446 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/24d28853d99145c9bb9a55311b065506/work/artifacts" 2026-04-30 03:18:19.631443 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/24d28853d99145c9bb9a55311b065506/work/docs" 2026-04-30 03:18:19.652875 | 2026-04-30 03:18:19.653287 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-30 03:18:21.157399 | debian-bookworm | changed: 2026-04-30 03:18:21.158655 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-04-30 03:18:21.158731 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-04-30 03:18:21.158764 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-04-30 03:18:21.158816 | debian-bookworm | changed: All items complete 2026-04-30 03:18:21.158897 | 2026-04-30 03:18:22.213184 | debian-bookworm | changed: .d..t...... ./ 2026-04-30 03:18:23.078319 | debian-bookworm | changed: .d..t...... ./ 2026-04-30 03:18:23.100442 | 2026-04-30 03:18:23.100554 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-30 03:18:23.129244 | debian-bookworm | skipping: Conditional result was False 2026-04-30 03:18:23.132305 | debian-bookworm | skipping: Conditional result was False 2026-04-30 03:18:23.141117 | 2026-04-30 03:18:23.141193 | PLAY RECAP 2026-04-30 03:18:23.141241 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-04-30 03:18:23.141266 | 2026-04-30 03:18:23.409895 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-04-30 03:18:23.411566 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-30 03:18:24.490580 | 2026-04-30 03:18:24.490828 | PLAY [Base post] 2026-04-30 03:18:24.506280 | 2026-04-30 03:18:24.506451 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-30 03:18:25.375260 | debian-bookworm | changed 2026-04-30 03:18:25.384235 | 2026-04-30 03:18:25.384340 | PLAY RECAP 2026-04-30 03:18:25.384403 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-30 03:18:25.384464 | 2026-04-30 03:18:25.512271 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-30 03:18:25.512927 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-30 03:18:26.629614 | 2026-04-30 03:18:26.629760 | PLAY [Base post-logs] 2026-04-30 03:18:26.640110 | 2026-04-30 03:18:26.640228 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-30 03:18:27.752842 | localhost | changed 2026-04-30 03:18:27.786387 | 2026-04-30 03:18:27.786542 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-30 03:18:27.840822 | localhost | ok 2026-04-30 03:18:27.844964 | 2026-04-30 03:18:27.845058 | TASK [Set zuul-log-path fact] 2026-04-30 03:18:27.863852 | localhost | ok 2026-04-30 03:18:27.885018 | 2026-04-30 03:18:27.885632 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-30 03:18:27.934651 | localhost | ok 2026-04-30 03:18:27.938443 | 2026-04-30 03:18:27.938539 | TASK [upload-logs : Create log directories] 2026-04-30 03:18:28.795975 | localhost | changed 2026-04-30 03:18:28.801077 | 2026-04-30 03:18:28.801190 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-30 03:18:29.717440 | localhost -> localhost | ok: Runtime: 0:00:00.020313 2026-04-30 03:18:29.724266 | 2026-04-30 03:18:29.724361 | TASK [upload-logs : Upload logs to log server] 2026-04-30 03:18:30.737387 | localhost | Output suppressed because no_log was given 2026-04-30 03:18:30.738755 | 2026-04-30 03:18:30.738828 | LOOP [upload-logs : Compress console log and json output] 2026-04-30 03:18:30.823025 | localhost | skipping: Conditional result was False 2026-04-30 03:18:30.836182 | localhost | skipping: Conditional result was False 2026-04-30 03:18:30.845704 | 2026-04-30 03:18:30.845803 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-30 03:18:30.921717 | localhost | skipping: Conditional result was False 2026-04-30 03:18:30.921931 | 2026-04-30 03:18:30.927683 | localhost | skipping: Conditional result was False 2026-04-30 03:18:30.931739 | 2026-04-30 03:18:30.931841 | LOOP [upload-logs : Upload console log and json output]