2026-06-01 17:54:44.183632 | Job console starting 2026-06-01 17:54:44.219417 | Updating git repos 2026-06-01 17:54:44.289907 | Cloning repos into workspace 2026-06-01 17:54:44.392680 | Restoring repo states 2026-06-01 17:54:44.425172 | Merging changes 2026-06-01 17:54:45.008672 | Checking out repos 2026-06-01 17:54:45.113060 | Preparing playbooks 2026-06-01 17:54:46.453080 | Running Ansible setup 2026-06-01 17:54:51.694402 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-01 17:54:52.637691 | 2026-06-01 17:54:52.637860 | PLAY [Base pre] 2026-06-01 17:54:52.669940 | 2026-06-01 17:54:52.670113 | TASK [Setup log path fact] 2026-06-01 17:54:52.722320 | debian-bookworm | ok 2026-06-01 17:54:52.763696 | 2026-06-01 17:54:52.763885 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-01 17:54:52.793226 | debian-bookworm | ok 2026-06-01 17:54:52.827106 | 2026-06-01 17:54:52.827284 | TASK [emit-job-header : Print job information] 2026-06-01 17:54:52.906750 | # Job Information 2026-06-01 17:54:52.906999 | Ansible Version: 2.16.14 2026-06-01 17:54:52.907038 | Job: python-black 2026-06-01 17:54:52.907072 | Pipeline: check 2026-06-01 17:54:52.907095 | Executor: 521e9411259a 2026-06-01 17:54:52.907116 | Triggered by: https://github.com/osism/ansible-collection-services/pull/2090 2026-06-01 17:54:52.907138 | Event ID: f2cd7820-5de2-11f1-8a38-5c4230027845 2026-06-01 17:54:52.919418 | 2026-06-01 17:54:52.919573 | LOOP [emit-job-header : Print node information] 2026-06-01 17:54:53.139727 | debian-bookworm | ok: 2026-06-01 17:54:53.139990 | debian-bookworm | # Node Information 2026-06-01 17:54:53.140103 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-01 17:54:53.140135 | debian-bookworm | Hostname: debian 2026-06-01 17:54:53.140158 | debian-bookworm | Username: zuul 2026-06-01 17:54:53.140180 | debian-bookworm | Distro: Debian 12.14 2026-06-01 17:54:53.140249 | debian-bookworm | Provider: regiocloud-a 2026-06-01 17:54:53.140280 | debian-bookworm | Region: 2026-06-01 17:54:53.140302 | debian-bookworm | Label: debian-bookworm 2026-06-01 17:54:53.140323 | debian-bookworm | Product Name: OpenStack Nova 2026-06-01 17:54:53.140343 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7e:27d8 2026-06-01 17:54:53.159265 | 2026-06-01 17:54:53.159420 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-01 17:54:54.012461 | debian-bookworm -> localhost | changed 2026-06-01 17:54:54.020025 | 2026-06-01 17:54:54.020161 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-01 17:54:55.352890 | debian-bookworm -> localhost | changed 2026-06-01 17:54:55.363239 | 2026-06-01 17:54:55.363346 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-01 17:54:55.721972 | debian-bookworm -> localhost | ok 2026-06-01 17:54:55.727030 | 2026-06-01 17:54:55.727124 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-01 17:54:55.756790 | debian-bookworm | ok 2026-06-01 17:54:55.778797 | debian-bookworm | included: /var/lib/zuul/builds/6dd361234ac54ae6885e889369e2e03f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-01 17:54:55.784660 | 2026-06-01 17:54:55.784741 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-01 17:54:57.046015 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-01 17:54:57.046185 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6dd361234ac54ae6885e889369e2e03f/work/6dd361234ac54ae6885e889369e2e03f_id_rsa 2026-06-01 17:54:57.046237 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6dd361234ac54ae6885e889369e2e03f/work/6dd361234ac54ae6885e889369e2e03f_id_rsa.pub 2026-06-01 17:54:57.046260 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-01 17:54:57.046280 | debian-bookworm -> localhost | SHA256:oFe7mVwnQTZyFoGpyKYqdcp/u7zWzrrMgf1PyiL6ItY zuul-build-sshkey 2026-06-01 17:54:57.046299 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-01 17:54:57.046328 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-01 17:54:57.046346 | debian-bookworm -> localhost | | .oOo | 2026-06-01 17:54:57.046364 | debian-bookworm -> localhost | | o* . | 2026-06-01 17:54:57.046381 | debian-bookworm -> localhost | | . .... . | 2026-06-01 17:54:57.046397 | debian-bookworm -> localhost | | +..o . . | 2026-06-01 17:54:57.046413 | debian-bookworm -> localhost | | o. . S o . | 2026-06-01 17:54:57.046434 | debian-bookworm -> localhost | | o .+ . = o | 2026-06-01 17:54:57.046451 | debian-bookworm -> localhost | | +.o. o.= . | 2026-06-01 17:54:57.046467 | debian-bookworm -> localhost | |+.+E.++=.o | 2026-06-01 17:54:57.046484 | debian-bookworm -> localhost | |o..=o+XO*.. | 2026-06-01 17:54:57.046501 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-01 17:54:57.046544 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.658609 2026-06-01 17:54:57.051685 | 2026-06-01 17:54:57.051771 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-01 17:54:57.088925 | debian-bookworm | ok 2026-06-01 17:54:57.096331 | debian-bookworm | included: /var/lib/zuul/builds/6dd361234ac54ae6885e889369e2e03f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-01 17:54:57.114335 | 2026-06-01 17:54:57.114414 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-01 17:54:57.143244 | debian-bookworm | skipping: Conditional result was False 2026-06-01 17:54:57.148957 | 2026-06-01 17:54:57.149062 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-01 17:54:57.964188 | debian-bookworm | changed 2026-06-01 17:54:57.968834 | 2026-06-01 17:54:57.968905 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-01 17:54:58.236944 | debian-bookworm | ok 2026-06-01 17:54:58.242407 | 2026-06-01 17:54:58.242489 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-01 17:54:58.906828 | debian-bookworm | changed 2026-06-01 17:54:58.919622 | 2026-06-01 17:54:58.919769 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-01 17:54:59.569045 | debian-bookworm | changed 2026-06-01 17:54:59.575472 | 2026-06-01 17:54:59.575571 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-01 17:54:59.598826 | debian-bookworm | skipping: Conditional result was False 2026-06-01 17:54:59.612135 | 2026-06-01 17:54:59.612441 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-01 17:55:00.064578 | debian-bookworm -> localhost | changed 2026-06-01 17:55:00.079717 | 2026-06-01 17:55:00.079834 | TASK [add-build-sshkey : Add back temp key] 2026-06-01 17:55:00.422145 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6dd361234ac54ae6885e889369e2e03f/work/6dd361234ac54ae6885e889369e2e03f_id_rsa (zuul-build-sshkey) 2026-06-01 17:55:00.422374 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009376 2026-06-01 17:55:00.432417 | 2026-06-01 17:55:00.432522 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-01 17:55:00.805878 | debian-bookworm | ok 2026-06-01 17:55:00.810797 | 2026-06-01 17:55:00.814938 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-01 17:55:00.848094 | debian-bookworm | skipping: Conditional result was False 2026-06-01 17:55:00.862121 | 2026-06-01 17:55:00.862247 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-01 17:55:01.242900 | debian-bookworm | ok 2026-06-01 17:55:01.267484 | 2026-06-01 17:55:01.267591 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-01 17:55:01.315718 | debian-bookworm | ok 2026-06-01 17:55:01.320659 | 2026-06-01 17:55:01.320753 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-01 17:55:01.599501 | debian-bookworm -> localhost | ok 2026-06-01 17:55:01.605931 | 2026-06-01 17:55:01.606014 | TASK [validate-host : Collect information about the host] 2026-06-01 17:55:02.756172 | debian-bookworm | ok 2026-06-01 17:55:02.765853 | 2026-06-01 17:55:02.765940 | TASK [validate-host : Sanitize hostname] 2026-06-01 17:55:02.872594 | debian-bookworm | ok 2026-06-01 17:55:02.905400 | 2026-06-01 17:55:02.905503 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-01 17:55:03.500861 | debian-bookworm -> localhost | changed 2026-06-01 17:55:03.506435 | 2026-06-01 17:55:03.506533 | TASK [validate-host : Collect information about zuul worker] 2026-06-01 17:55:03.957604 | debian-bookworm | ok 2026-06-01 17:55:03.963903 | 2026-06-01 17:55:03.963996 | TASK [validate-host : Write out all zuul information for each host] 2026-06-01 17:55:04.538325 | debian-bookworm -> localhost | changed 2026-06-01 17:55:04.547469 | 2026-06-01 17:55:04.547559 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-01 17:55:04.835102 | debian-bookworm | ok 2026-06-01 17:55:04.840519 | 2026-06-01 17:55:04.840613 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-01 17:55:06.196894 | debian-bookworm | changed: 2026-06-01 17:55:06.197130 | debian-bookworm | cd+++++++++ src/ 2026-06-01 17:55:06.197165 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-01 17:55:06.197226 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-01 17:55:06.197253 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2026-06-01 17:55:06.197274 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/6dd361234ac54ae6885e889369e2e03f/work/logs" 2026-06-01 17:55:32.729123 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6dd361234ac54ae6885e889369e2e03f/work/artifacts" 2026-06-01 17:55:33.021144 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6dd361234ac54ae6885e889369e2e03f/work/docs" 2026-06-01 17:55:33.055156 | 2026-06-01 17:55:33.055351 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-01 17:55:33.939309 | debian-bookworm | changed: 2026-06-01 17:55:33.939555 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-01 17:55:33.939592 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-01 17:55:33.939623 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-01 17:55:33.939674 | debian-bookworm | changed: All items complete 2026-06-01 17:55:33.939705 | 2026-06-01 17:55:34.523010 | debian-bookworm | changed: .d..t...... ./ 2026-06-01 17:55:35.138507 | debian-bookworm | changed: .d..t...... ./ 2026-06-01 17:55:35.160220 | 2026-06-01 17:55:35.160362 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-01 17:55:35.675714 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006280 2026-06-01 17:55:35.973426 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010314 2026-06-01 17:55:35.981842 | 2026-06-01 17:55:35.981926 | PLAY RECAP 2026-06-01 17:55:35.981977 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-01 17:55:35.982002 | 2026-06-01 17:55:36.122746 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-01 17:55:36.124453 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-01 17:55:36.924327 | 2026-06-01 17:55:36.924558 | PLAY [Base post] 2026-06-01 17:55:36.940028 | 2026-06-01 17:55:36.940196 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-01 17:55:37.529956 | debian-bookworm | changed 2026-06-01 17:55:37.537927 | 2026-06-01 17:55:37.538061 | PLAY RECAP 2026-06-01 17:55:37.538133 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-01 17:55:37.538229 | 2026-06-01 17:55:37.667596 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-01 17:55:37.669849 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-01 17:55:38.475583 | 2026-06-01 17:55:38.475756 | PLAY [Base post-logs] 2026-06-01 17:55:38.486380 | 2026-06-01 17:55:38.486520 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-01 17:55:38.932624 | localhost | changed 2026-06-01 17:55:38.945307 | 2026-06-01 17:55:38.945552 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-01 17:55:38.983641 | localhost | ok 2026-06-01 17:55:38.987313 | 2026-06-01 17:55:38.987435 | TASK [Set zuul-log-path fact] 2026-06-01 17:55:39.024916 | localhost | ok 2026-06-01 17:55:39.034158 | 2026-06-01 17:55:39.034340 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-01 17:55:39.063782 | localhost | ok 2026-06-01 17:55:39.071019 | 2026-06-01 17:55:39.071251 | TASK [upload-logs : Create log directories] 2026-06-01 17:55:39.609245 | localhost | changed 2026-06-01 17:55:39.616374 | 2026-06-01 17:55:39.616556 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-01 17:55:40.115617 | localhost -> localhost | ok: Runtime: 0:00:00.008297 2026-06-01 17:55:40.124427 | 2026-06-01 17:55:40.124643 | TASK [upload-logs : Upload logs to log server] 2026-06-01 17:55:40.725040 | localhost | Output suppressed because no_log was given 2026-06-01 17:55:40.728267 | 2026-06-01 17:55:40.728377 | LOOP [upload-logs : Compress console log and json output] 2026-06-01 17:55:40.789880 | localhost | skipping: Conditional result was False 2026-06-01 17:55:40.795133 | localhost | skipping: Conditional result was False 2026-06-01 17:55:40.809403 | 2026-06-01 17:55:40.809649 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-01 17:55:40.861271 | localhost | skipping: Conditional result was False 2026-06-01 17:55:40.861860 | 2026-06-01 17:55:40.866415 | localhost | skipping: Conditional result was False 2026-06-01 17:55:40.873195 | 2026-06-01 17:55:40.873391 | LOOP [upload-logs : Upload console log and json output]