2026-06-16 22:01:47.301016 | Job console starting 2026-06-16 22:01:47.319643 | Updating git repos 2026-06-16 22:01:47.369388 | Cloning repos into workspace 2026-06-16 22:01:47.456492 | Restoring repo states 2026-06-16 22:01:47.472002 | Merging changes 2026-06-16 22:01:48.347249 | Checking out repos 2026-06-16 22:01:48.501255 | Preparing playbooks 2026-06-16 22:01:51.162093 | Running Ansible setup 2026-06-16 22:01:57.306991 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-16 22:01:59.159024 | 2026-06-16 22:01:59.159173 | PLAY [Base pre] 2026-06-16 22:01:59.178530 | 2026-06-16 22:01:59.178658 | TASK [Setup log path fact] 2026-06-16 22:01:59.208253 | debian-bookworm | ok 2026-06-16 22:01:59.224866 | 2026-06-16 22:01:59.225015 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-16 22:01:59.263359 | debian-bookworm | ok 2026-06-16 22:01:59.273060 | 2026-06-16 22:01:59.273169 | TASK [emit-job-header : Print job information] 2026-06-16 22:01:59.340193 | # Job Information 2026-06-16 22:01:59.340432 | Ansible Version: 2.16.14 2026-06-16 22:01:59.340470 | Job: python-osism-test-setup 2026-06-16 22:01:59.340502 | Pipeline: check 2026-06-16 22:01:59.340525 | Executor: 521e9411259a 2026-06-16 22:01:59.340545 | Triggered by: https://github.com/osism/python-osism/pull/2384 2026-06-16 22:01:59.340568 | Event ID: f1ac5ae0-69ce-11f1-8fea-82669a3ee794 2026-06-16 22:01:59.346356 | 2026-06-16 22:01:59.346477 | LOOP [emit-job-header : Print node information] 2026-06-16 22:01:59.530751 | debian-bookworm | ok: 2026-06-16 22:01:59.530964 | debian-bookworm | # Node Information 2026-06-16 22:01:59.531000 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-16 22:01:59.531026 | debian-bookworm | Hostname: debian 2026-06-16 22:01:59.531048 | debian-bookworm | Username: zuul 2026-06-16 22:01:59.531069 | debian-bookworm | Distro: Debian 12.14 2026-06-16 22:01:59.531092 | debian-bookworm | Provider: regiocloud-a 2026-06-16 22:01:59.531112 | debian-bookworm | Region: 2026-06-16 22:01:59.531134 | debian-bookworm | Label: debian-bookworm 2026-06-16 22:01:59.531154 | debian-bookworm | Product Name: OpenStack Nova 2026-06-16 22:01:59.531174 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe37:c6c 2026-06-16 22:01:59.551721 | 2026-06-16 22:01:59.551876 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-16 22:02:00.410926 | debian-bookworm -> localhost | changed 2026-06-16 22:02:00.417073 | 2026-06-16 22:02:00.417170 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-16 22:02:02.299410 | debian-bookworm -> localhost | changed 2026-06-16 22:02:02.308548 | 2026-06-16 22:02:02.308653 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-16 22:02:02.690877 | debian-bookworm -> localhost | ok 2026-06-16 22:02:02.695916 | 2026-06-16 22:02:02.696011 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-16 22:02:02.734772 | debian-bookworm | ok 2026-06-16 22:02:02.757412 | debian-bookworm | included: /var/lib/zuul/builds/08d9931765ca40beb87284f4e4a881cf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-16 22:02:02.762430 | 2026-06-16 22:02:02.762519 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-16 22:02:04.035148 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-16 22:02:04.035340 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/08d9931765ca40beb87284f4e4a881cf/work/08d9931765ca40beb87284f4e4a881cf_id_rsa 2026-06-16 22:02:04.035371 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/08d9931765ca40beb87284f4e4a881cf/work/08d9931765ca40beb87284f4e4a881cf_id_rsa.pub 2026-06-16 22:02:04.035393 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-16 22:02:04.035413 | debian-bookworm -> localhost | SHA256:FNJ8AfWMs/IxAzz3MIqTdJ+UNo3LHXjbGjrpWjmyhTE zuul-build-sshkey 2026-06-16 22:02:04.035432 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-16 22:02:04.035460 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-16 22:02:04.035478 | debian-bookworm -> localhost | | .oooo. | 2026-06-16 22:02:04.035495 | debian-bookworm -> localhost | | oo..O | 2026-06-16 22:02:04.035511 | debian-bookworm -> localhost | | . *.& * | 2026-06-16 22:02:04.035528 | debian-bookworm -> localhost | | . = X % + | 2026-06-16 22:02:04.035543 | debian-bookworm -> localhost | | + E X = . | 2026-06-16 22:02:04.035563 | debian-bookworm -> localhost | | . * B o | 2026-06-16 22:02:04.035579 | debian-bookworm -> localhost | | o X . | 2026-06-16 22:02:04.035595 | debian-bookworm -> localhost | | * o | 2026-06-16 22:02:04.035612 | debian-bookworm -> localhost | | o.. | 2026-06-16 22:02:04.035628 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-16 22:02:04.035668 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.499382 2026-06-16 22:02:04.040965 | 2026-06-16 22:02:04.041041 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-16 22:02:04.058109 | debian-bookworm | ok 2026-06-16 22:02:04.066254 | debian-bookworm | included: /var/lib/zuul/builds/08d9931765ca40beb87284f4e4a881cf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-16 22:02:04.073562 | 2026-06-16 22:02:04.073641 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-16 22:02:04.086366 | debian-bookworm | skipping: Conditional result was False 2026-06-16 22:02:04.091184 | 2026-06-16 22:02:04.091264 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-16 22:02:04.723244 | debian-bookworm | changed 2026-06-16 22:02:04.727758 | 2026-06-16 22:02:04.727851 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-16 22:02:04.994397 | debian-bookworm | ok 2026-06-16 22:02:05.002585 | 2026-06-16 22:02:05.002792 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-16 22:02:05.692003 | debian-bookworm | changed 2026-06-16 22:02:05.697393 | 2026-06-16 22:02:05.697478 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-16 22:02:06.296769 | debian-bookworm | changed 2026-06-16 22:02:06.310373 | 2026-06-16 22:02:06.310496 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-16 22:02:06.338972 | debian-bookworm | skipping: Conditional result was False 2026-06-16 22:02:06.349002 | 2026-06-16 22:02:06.349131 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-16 22:02:07.047862 | debian-bookworm -> localhost | changed 2026-06-16 22:02:07.058371 | 2026-06-16 22:02:07.058472 | TASK [add-build-sshkey : Add back temp key] 2026-06-16 22:02:07.465546 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/08d9931765ca40beb87284f4e4a881cf/work/08d9931765ca40beb87284f4e4a881cf_id_rsa (zuul-build-sshkey) 2026-06-16 22:02:07.465791 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011238 2026-06-16 22:02:07.473603 | 2026-06-16 22:02:07.473708 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-16 22:02:07.885986 | debian-bookworm | ok 2026-06-16 22:02:07.891352 | 2026-06-16 22:02:07.891455 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-16 22:02:07.933719 | debian-bookworm | skipping: Conditional result was False 2026-06-16 22:02:07.944337 | 2026-06-16 22:02:07.944462 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-16 22:02:08.425675 | debian-bookworm | ok 2026-06-16 22:02:08.436543 | 2026-06-16 22:02:08.436656 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-16 22:02:08.486222 | debian-bookworm | ok 2026-06-16 22:02:08.491421 | 2026-06-16 22:02:08.491519 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-16 22:02:09.009600 | debian-bookworm -> localhost | ok 2026-06-16 22:02:09.016047 | 2026-06-16 22:02:09.016146 | TASK [validate-host : Collect information about the host] 2026-06-16 22:02:10.290625 | debian-bookworm | ok 2026-06-16 22:02:10.306189 | 2026-06-16 22:02:10.306302 | TASK [validate-host : Sanitize hostname] 2026-06-16 22:02:10.485408 | debian-bookworm | ok 2026-06-16 22:02:10.489918 | 2026-06-16 22:02:10.490010 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-16 22:02:11.427647 | debian-bookworm -> localhost | changed 2026-06-16 22:02:11.436874 | 2026-06-16 22:02:11.436996 | TASK [validate-host : Collect information about zuul worker] 2026-06-16 22:02:11.981886 | debian-bookworm | ok 2026-06-16 22:02:11.987357 | 2026-06-16 22:02:11.987459 | TASK [validate-host : Write out all zuul information for each host] 2026-06-16 22:02:12.559390 | debian-bookworm -> localhost | changed 2026-06-16 22:02:12.570244 | 2026-06-16 22:02:12.570346 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-16 22:02:12.871617 | debian-bookworm | ok 2026-06-16 22:02:12.891271 | 2026-06-16 22:02:12.891395 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-16 22:02:13.993251 | debian-bookworm | changed: 2026-06-16 22:02:13.993521 | debian-bookworm | cd+++++++++ src/ 2026-06-16 22:02:13.993556 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-16 22:02:13.993581 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-16 22:02:13.993603 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-06-16 22:02:13.993624 | debian-bookworm | Containerfile 2026-06-16 22:02:13.993754 | debian-bookworm | Containerfile 2026-06-16 22:02:14.022440 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/08d9931765ca40beb87284f4e4a881cf/work/logs" 2026-06-16 22:04:54.754329 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/08d9931765ca40beb87284f4e4a881cf/work/artifacts" 2026-06-16 22:04:55.096326 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/08d9931765ca40beb87284f4e4a881cf/work/docs" 2026-06-16 22:04:55.108871 | 2026-06-16 22:04:55.109042 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-16 22:04:55.954829 | debian-bookworm | changed: 2026-06-16 22:04:55.955150 | debian-bookworm | .d..t...... ./ 2026-06-16 22:04:55.955285 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-16 22:04:55.955321 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-16 22:04:55.955349 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-16 22:04:55.955376 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-16 22:04:55.955403 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-16 22:04:55.955465 | debian-bookworm | changed: All items complete 2026-06-16 22:04:55.955501 | 2026-06-16 22:04:56.567978 | debian-bookworm | changed: .d..t...... ./ 2026-06-16 22:04:57.171656 | debian-bookworm | changed: .d..t...... ./ 2026-06-16 22:04:57.201688 | 2026-06-16 22:04:57.201872 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-16 22:04:57.579001 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.010644 2026-06-16 22:04:57.862211 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010752 2026-06-16 22:04:57.881448 | 2026-06-16 22:04:57.881678 | PLAY RECAP 2026-06-16 22:04:57.881769 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-16 22:04:57.881806 | 2026-06-16 22:04:58.038705 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-16 22:04:58.041157 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-16 22:04:58.883626 | 2026-06-16 22:04:58.883820 | PLAY [Base post] 2026-06-16 22:04:58.898406 | 2026-06-16 22:04:58.898605 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-16 22:04:59.747486 | debian-bookworm | changed 2026-06-16 22:04:59.757278 | 2026-06-16 22:04:59.757405 | PLAY RECAP 2026-06-16 22:04:59.757485 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-16 22:04:59.757594 | 2026-06-16 22:04:59.930097 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-16 22:04:59.932513 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-16 22:05:00.760480 | 2026-06-16 22:05:00.760719 | PLAY [Base post-logs] 2026-06-16 22:05:00.772468 | 2026-06-16 22:05:00.772660 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-16 22:05:01.307520 | localhost | changed 2026-06-16 22:05:01.329202 | 2026-06-16 22:05:01.329467 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-16 22:05:01.370211 | localhost | ok 2026-06-16 22:05:01.376743 | 2026-06-16 22:05:01.376901 | TASK [Set zuul-log-path fact] 2026-06-16 22:05:01.394750 | localhost | ok 2026-06-16 22:05:01.406166 | 2026-06-16 22:05:01.406301 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-16 22:05:01.432209 | localhost | ok 2026-06-16 22:05:01.436202 | 2026-06-16 22:05:01.436329 | TASK [upload-logs : Create log directories] 2026-06-16 22:05:02.005187 | localhost | changed 2026-06-16 22:05:02.009168 | 2026-06-16 22:05:02.009312 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-16 22:05:02.574402 | localhost -> localhost | ok: Runtime: 0:00:00.009387 2026-06-16 22:05:02.579315 | 2026-06-16 22:05:02.579456 | TASK [upload-logs : Upload logs to log server] 2026-06-16 22:05:03.254653 | localhost | Output suppressed because no_log was given 2026-06-16 22:05:03.258029 | 2026-06-16 22:05:03.258204 | LOOP [upload-logs : Compress console log and json output] 2026-06-16 22:05:03.323053 | localhost | skipping: Conditional result was False 2026-06-16 22:05:03.329281 | localhost | skipping: Conditional result was False 2026-06-16 22:05:03.343466 | 2026-06-16 22:05:03.343870 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-16 22:05:03.400683 | localhost | skipping: Conditional result was False 2026-06-16 22:05:03.401342 | 2026-06-16 22:05:03.404846 | localhost | skipping: Conditional result was False 2026-06-16 22:05:03.418059 | 2026-06-16 22:05:03.418284 | LOOP [upload-logs : Upload console log and json output]