2026-07-13 20:38:32.331480 | Job console starting 2026-07-13 20:38:32.346663 | Updating git repos 2026-07-13 20:38:32.488176 | Cloning repos into workspace 2026-07-13 20:38:32.671360 | Restoring repo states 2026-07-13 20:38:32.727244 | Merging changes 2026-07-13 20:38:34.269569 | Checking out repos 2026-07-13 20:38:34.428663 | Preparing playbooks 2026-07-13 20:38:39.339738 | Running Ansible setup 2026-07-13 20:38:47.647404 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-13 20:38:51.043696 | 2026-07-13 20:38:51.043842 | PLAY [Base pre] 2026-07-13 20:38:51.148377 | 2026-07-13 20:38:51.151180 | TASK [Setup log path fact] 2026-07-13 20:38:51.215899 | debian-bookworm | ok 2026-07-13 20:38:51.281411 | 2026-07-13 20:38:51.281570 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-13 20:38:51.327339 | debian-bookworm | ok 2026-07-13 20:38:51.352844 | 2026-07-13 20:38:51.352998 | TASK [emit-job-header : Print job information] 2026-07-13 20:38:51.487043 | # Job Information 2026-07-13 20:38:51.487282 | Ansible Version: 2.16.14 2026-07-13 20:38:51.487321 | Job: python-osism-test-setup 2026-07-13 20:38:51.487359 | Pipeline: check 2026-07-13 20:38:51.487388 | Executor: 521e9411259a 2026-07-13 20:38:51.487409 | Triggered by: https://github.com/osism/python-osism/pull/2458 2026-07-13 20:38:51.487432 | Event ID: c85c6c20-7efa-11f1-9bd7-e269929be516 2026-07-13 20:38:51.507522 | 2026-07-13 20:38:51.512052 | LOOP [emit-job-header : Print node information] 2026-07-13 20:38:52.364581 | debian-bookworm | ok: 2026-07-13 20:38:52.364776 | debian-bookworm | # Node Information 2026-07-13 20:38:52.364814 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-13 20:38:52.364846 | debian-bookworm | Hostname: debian 2026-07-13 20:38:52.364874 | debian-bookworm | Username: zuul 2026-07-13 20:38:52.364901 | debian-bookworm | Distro: Debian 12.15 2026-07-13 20:38:52.364931 | debian-bookworm | Provider: regiocloud-a 2026-07-13 20:38:52.364957 | debian-bookworm | Region: 2026-07-13 20:38:52.366439 | debian-bookworm | Label: debian-bookworm 2026-07-13 20:38:52.366505 | debian-bookworm | Product Name: OpenStack Nova 2026-07-13 20:38:52.366532 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee7:e5e6 2026-07-13 20:38:52.383823 | 2026-07-13 20:38:52.383933 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-13 20:38:53.906880 | debian-bookworm -> localhost | changed 2026-07-13 20:38:53.914607 | 2026-07-13 20:38:53.914705 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-13 20:38:56.665403 | debian-bookworm -> localhost | changed 2026-07-13 20:38:56.684807 | 2026-07-13 20:38:56.685406 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-13 20:38:57.871692 | debian-bookworm -> localhost | ok 2026-07-13 20:38:57.880950 | 2026-07-13 20:38:57.881066 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-13 20:38:57.953704 | debian-bookworm | ok 2026-07-13 20:38:58.007086 | debian-bookworm | included: /var/lib/zuul/builds/10c30a9bba424846a5494963872caa33/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-13 20:38:58.018452 | 2026-07-13 20:38:58.018556 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-13 20:39:02.799268 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-13 20:39:02.799468 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/10c30a9bba424846a5494963872caa33/work/10c30a9bba424846a5494963872caa33_id_rsa 2026-07-13 20:39:02.799506 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/10c30a9bba424846a5494963872caa33/work/10c30a9bba424846a5494963872caa33_id_rsa.pub 2026-07-13 20:39:02.799532 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-13 20:39:02.799557 | debian-bookworm -> localhost | SHA256:DzjF6ej/y8rMl2centDWG+1NZ6FZZvg7nqk4NYhQP+E zuul-build-sshkey 2026-07-13 20:39:02.799578 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-13 20:39:02.799610 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-13 20:39:02.799632 | debian-bookworm -> localhost | | | 2026-07-13 20:39:02.799652 | debian-bookworm -> localhost | | . o . | 2026-07-13 20:39:02.799672 | debian-bookworm -> localhost | | = o . | 2026-07-13 20:39:02.799691 | debian-bookworm -> localhost | | * E . | 2026-07-13 20:39:02.799710 | debian-bookworm -> localhost | | + S . o. = | 2026-07-13 20:39:02.799732 | debian-bookworm -> localhost | | . . + o +B..| 2026-07-13 20:39:02.799752 | debian-bookworm -> localhost | | . o.=o+.=| 2026-07-13 20:39:02.799770 | debian-bookworm -> localhost | | = .o=+o B*| 2026-07-13 20:39:02.799791 | debian-bookworm -> localhost | | *++*=.+=+| 2026-07-13 20:39:02.799810 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-13 20:39:02.799863 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.811129 2026-07-13 20:39:02.807814 | 2026-07-13 20:39:02.807916 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-13 20:39:02.848689 | debian-bookworm | ok 2026-07-13 20:39:02.895166 | debian-bookworm | included: /var/lib/zuul/builds/10c30a9bba424846a5494963872caa33/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-13 20:39:02.939159 | 2026-07-13 20:39:02.939288 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-13 20:39:02.983429 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:39:02.989602 | 2026-07-13 20:39:02.989704 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-13 20:39:03.820276 | debian-bookworm | changed 2026-07-13 20:39:03.825793 | 2026-07-13 20:39:03.825888 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-13 20:39:04.146701 | debian-bookworm | ok 2026-07-13 20:39:04.157538 | 2026-07-13 20:39:04.157648 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-13 20:39:05.046044 | debian-bookworm | changed 2026-07-13 20:39:05.057498 | 2026-07-13 20:39:05.065482 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-13 20:39:06.025511 | debian-bookworm | changed 2026-07-13 20:39:06.033267 | 2026-07-13 20:39:06.033364 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-13 20:39:06.092254 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:39:06.101112 | 2026-07-13 20:39:06.101224 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-13 20:39:07.845507 | debian-bookworm -> localhost | changed 2026-07-13 20:39:07.864730 | 2026-07-13 20:39:07.864850 | TASK [add-build-sshkey : Add back temp key] 2026-07-13 20:39:09.208687 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/10c30a9bba424846a5494963872caa33/work/10c30a9bba424846a5494963872caa33_id_rsa (zuul-build-sshkey) 2026-07-13 20:39:09.209141 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.046292 2026-07-13 20:39:09.220620 | 2026-07-13 20:39:09.220709 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-13 20:39:10.144735 | debian-bookworm | ok 2026-07-13 20:39:10.160996 | 2026-07-13 20:39:10.161114 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-13 20:39:10.249432 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:39:10.268931 | 2026-07-13 20:39:10.271793 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-13 20:39:11.454859 | debian-bookworm | ok 2026-07-13 20:39:11.475065 | 2026-07-13 20:39:11.475203 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-13 20:39:11.505656 | debian-bookworm | ok 2026-07-13 20:39:11.510523 | 2026-07-13 20:39:11.510608 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-13 20:39:12.376695 | debian-bookworm -> localhost | ok 2026-07-13 20:39:12.384301 | 2026-07-13 20:39:12.384421 | TASK [validate-host : Collect information about the host] 2026-07-13 20:39:14.602895 | debian-bookworm | ok 2026-07-13 20:39:14.620624 | 2026-07-13 20:39:14.620721 | TASK [validate-host : Sanitize hostname] 2026-07-13 20:39:15.029464 | debian-bookworm | ok 2026-07-13 20:39:15.036562 | 2026-07-13 20:39:15.036654 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-13 20:39:16.175783 | debian-bookworm -> localhost | changed 2026-07-13 20:39:16.181449 | 2026-07-13 20:39:16.181541 | TASK [validate-host : Collect information about zuul worker] 2026-07-13 20:39:17.010562 | debian-bookworm | ok 2026-07-13 20:39:17.014645 | 2026-07-13 20:39:17.014726 | TASK [validate-host : Write out all zuul information for each host] 2026-07-13 20:39:18.272129 | debian-bookworm -> localhost | changed 2026-07-13 20:39:18.287450 | 2026-07-13 20:39:18.287551 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-13 20:39:18.563213 | debian-bookworm | ok 2026-07-13 20:39:18.569191 | 2026-07-13 20:39:18.569269 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-13 20:39:19.950670 | debian-bookworm | changed: 2026-07-13 20:39:19.951644 | debian-bookworm | cd+++++++++ src/ 2026-07-13 20:39:19.951713 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-13 20:39:19.951746 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-13 20:39:19.951773 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-07-13 20:39:19.951797 | debian-bookworm | Containerfile 2026-07-13 20:39:19.951952 | debian-bookworm | Containerfile 2026-07-13 20:39:19.982238 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/10c30a9bba424846a5494963872caa33/work/logs" 2026-07-13 20:41:55.882616 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/10c30a9bba424846a5494963872caa33/work/artifacts" 2026-07-13 20:41:56.175565 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/10c30a9bba424846a5494963872caa33/work/docs" 2026-07-13 20:41:56.198205 | 2026-07-13 20:41:56.198386 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-13 20:41:57.048366 | debian-bookworm | changed: 2026-07-13 20:41:57.048650 | debian-bookworm | .d..t...... ./ 2026-07-13 20:41:57.048693 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-13 20:41:57.048725 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-13 20:41:57.048752 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-13 20:41:57.048778 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-13 20:41:57.048804 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-13 20:41:57.048860 | debian-bookworm | changed: All items complete 2026-07-13 20:41:57.048893 | 2026-07-13 20:41:57.682422 | debian-bookworm | changed: .d..t...... ./ 2026-07-13 20:41:58.270795 | debian-bookworm | changed: .d..t...... ./ 2026-07-13 20:41:58.296765 | 2026-07-13 20:41:58.296928 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-13 20:41:58.732251 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.014431 2026-07-13 20:41:59.052737 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009485 2026-07-13 20:41:59.076383 | 2026-07-13 20:41:59.076512 | PLAY RECAP 2026-07-13 20:41:59.076571 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-13 20:41:59.076597 | 2026-07-13 20:41:59.245288 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-13 20:41:59.246440 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-13 20:42:00.063178 | 2026-07-13 20:42:00.063378 | PLAY [Base post] 2026-07-13 20:42:00.079633 | 2026-07-13 20:42:00.079779 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-13 20:42:00.927234 | debian-bookworm | changed 2026-07-13 20:42:00.936585 | 2026-07-13 20:42:00.936736 | PLAY RECAP 2026-07-13 20:42:00.936814 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-13 20:42:00.936893 | 2026-07-13 20:42:01.130670 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-13 20:42:01.132063 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-13 20:42:01.963106 | 2026-07-13 20:42:01.963297 | PLAY [Base post-logs] 2026-07-13 20:42:01.974703 | 2026-07-13 20:42:01.974909 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-13 20:42:02.478727 | localhost | changed 2026-07-13 20:42:02.490006 | 2026-07-13 20:42:02.490199 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-13 20:42:02.528919 | localhost | ok 2026-07-13 20:42:02.545173 | 2026-07-13 20:42:02.545350 | TASK [Set zuul-log-path fact] 2026-07-13 20:42:02.567806 | localhost | ok 2026-07-13 20:42:02.579755 | 2026-07-13 20:42:02.579895 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-13 20:42:02.618640 | localhost | ok 2026-07-13 20:42:02.625807 | 2026-07-13 20:42:02.626051 | TASK [upload-logs : Create log directories] 2026-07-13 20:42:03.226589 | localhost | changed 2026-07-13 20:42:03.232090 | 2026-07-13 20:42:03.232275 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-13 20:42:03.770377 | localhost -> localhost | ok: Runtime: 0:00:00.007052 2026-07-13 20:42:03.775103 | 2026-07-13 20:42:03.775231 | TASK [upload-logs : Upload logs to log server] 2026-07-13 20:42:04.427086 | localhost | Output suppressed because no_log was given 2026-07-13 20:42:04.430483 | 2026-07-13 20:42:04.430650 | LOOP [upload-logs : Compress console log and json output] 2026-07-13 20:42:04.491325 | localhost | skipping: Conditional result was False 2026-07-13 20:42:04.495254 | localhost | skipping: Conditional result was False 2026-07-13 20:42:04.504532 | 2026-07-13 20:42:04.504710 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-13 20:42:04.569431 | localhost | skipping: Conditional result was False 2026-07-13 20:42:04.569853 | 2026-07-13 20:42:04.583532 | localhost | skipping: Conditional result was False 2026-07-13 20:42:04.594814 | 2026-07-13 20:42:04.595044 | LOOP [upload-logs : Upload console log and json output]