2026-07-13 20:21:34.796537 | Job console starting 2026-07-13 20:21:34.837587 | Updating git repos 2026-07-13 20:21:35.128090 | Cloning repos into workspace 2026-07-13 20:21:35.335587 | Restoring repo states 2026-07-13 20:21:35.379125 | Merging changes 2026-07-13 20:21:36.807411 | Checking out repos 2026-07-13 20:21:36.982784 | Preparing playbooks 2026-07-13 20:21:40.334991 | Running Ansible setup 2026-07-13 20:21:46.136209 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-13 20:21:48.077281 | 2026-07-13 20:21:48.077419 | PLAY [Base pre] 2026-07-13 20:21:48.166009 | 2026-07-13 20:21:48.166167 | TASK [Setup log path fact] 2026-07-13 20:21:48.226526 | debian-bookworm | ok 2026-07-13 20:21:48.260973 | 2026-07-13 20:21:48.261106 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-13 20:21:48.318791 | debian-bookworm | ok 2026-07-13 20:21:48.345252 | 2026-07-13 20:21:48.345373 | TASK [emit-job-header : Print job information] 2026-07-13 20:21:48.466113 | # Job Information 2026-07-13 20:21:48.466357 | Ansible Version: 2.16.14 2026-07-13 20:21:48.466390 | Job: python-osism-test-setup 2026-07-13 20:21:48.466423 | Pipeline: check 2026-07-13 20:21:48.466442 | Executor: 521e9411259a 2026-07-13 20:21:48.466460 | Triggered by: https://github.com/osism/python-osism/pull/2462 2026-07-13 20:21:48.466478 | Event ID: 6a43bf50-7ef8-11f1-97a9-0449111d1410 2026-07-13 20:21:48.475053 | 2026-07-13 20:21:48.475175 | LOOP [emit-job-header : Print node information] 2026-07-13 20:21:48.719271 | debian-bookworm | ok: 2026-07-13 20:21:48.719653 | debian-bookworm | # Node Information 2026-07-13 20:21:48.720840 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-13 20:21:48.720902 | debian-bookworm | Hostname: debian 2026-07-13 20:21:48.720926 | debian-bookworm | Username: zuul 2026-07-13 20:21:48.720946 | debian-bookworm | Distro: Debian 12.15 2026-07-13 20:21:48.720969 | debian-bookworm | Provider: regiocloud-a 2026-07-13 20:21:48.720987 | debian-bookworm | Region: 2026-07-13 20:21:48.721005 | debian-bookworm | Label: debian-bookworm 2026-07-13 20:21:48.721021 | debian-bookworm | Product Name: OpenStack Nova 2026-07-13 20:21:48.721037 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe60:7db7 2026-07-13 20:21:48.734784 | 2026-07-13 20:21:48.734901 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-13 20:21:50.439820 | debian-bookworm -> localhost | changed 2026-07-13 20:21:50.446702 | 2026-07-13 20:21:50.446802 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-13 20:21:55.176174 | debian-bookworm -> localhost | changed 2026-07-13 20:21:55.204194 | 2026-07-13 20:21:55.204320 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-13 20:21:56.290580 | debian-bookworm -> localhost | ok 2026-07-13 20:21:56.296971 | 2026-07-13 20:21:56.297096 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-13 20:21:56.343566 | debian-bookworm | ok 2026-07-13 20:21:56.413631 | debian-bookworm | included: /var/lib/zuul/builds/4e9dce8f6fb748d69012b3a9baccb97a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-13 20:21:56.427388 | 2026-07-13 20:21:56.427498 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-13 20:22:00.724764 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-13 20:22:00.724957 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4e9dce8f6fb748d69012b3a9baccb97a/work/4e9dce8f6fb748d69012b3a9baccb97a_id_rsa 2026-07-13 20:22:00.724988 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4e9dce8f6fb748d69012b3a9baccb97a/work/4e9dce8f6fb748d69012b3a9baccb97a_id_rsa.pub 2026-07-13 20:22:00.725010 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-13 20:22:00.725031 | debian-bookworm -> localhost | SHA256:sDVfUwFXZmHoXxyROyYUgqdsW5a4N/h5B1tYhlPBo6A zuul-build-sshkey 2026-07-13 20:22:00.725050 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-13 20:22:00.725080 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-13 20:22:00.725098 | debian-bookworm -> localhost | | ...oBBO| 2026-07-13 20:22:00.725128 | debian-bookworm -> localhost | | . o.=.O | 2026-07-13 20:22:00.725145 | debian-bookworm -> localhost | | . + = B +.+| 2026-07-13 20:22:00.725162 | debian-bookworm -> localhost | | + E = B *o| 2026-07-13 20:22:00.725178 | debian-bookworm -> localhost | | . S B O o| 2026-07-13 20:22:00.725199 | debian-bookworm -> localhost | | + o o o | 2026-07-13 20:22:00.725216 | debian-bookworm -> localhost | | o o + | 2026-07-13 20:22:00.725232 | debian-bookworm -> localhost | | o o . | 2026-07-13 20:22:00.725249 | debian-bookworm -> localhost | | . . | 2026-07-13 20:22:00.725265 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-13 20:22:00.725306 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.936990 2026-07-13 20:22:00.730688 | 2026-07-13 20:22:00.730781 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-13 20:22:00.791130 | debian-bookworm | ok 2026-07-13 20:22:00.809227 | debian-bookworm | included: /var/lib/zuul/builds/4e9dce8f6fb748d69012b3a9baccb97a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-13 20:22:00.843427 | 2026-07-13 20:22:00.845916 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-13 20:22:00.892912 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:22:00.902940 | 2026-07-13 20:22:00.903049 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-13 20:22:01.872886 | debian-bookworm | changed 2026-07-13 20:22:01.880246 | 2026-07-13 20:22:01.880348 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-13 20:22:02.223513 | debian-bookworm | ok 2026-07-13 20:22:02.228704 | 2026-07-13 20:22:02.228791 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-13 20:22:03.071032 | debian-bookworm | changed 2026-07-13 20:22:03.075538 | 2026-07-13 20:22:03.075634 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-13 20:22:03.920054 | debian-bookworm | changed 2026-07-13 20:22:03.926691 | 2026-07-13 20:22:03.926768 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-13 20:22:03.958280 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:22:03.964547 | 2026-07-13 20:22:03.964817 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-13 20:22:05.387590 | debian-bookworm -> localhost | changed 2026-07-13 20:22:05.401264 | 2026-07-13 20:22:05.401363 | TASK [add-build-sshkey : Add back temp key] 2026-07-13 20:22:06.708615 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4e9dce8f6fb748d69012b3a9baccb97a/work/4e9dce8f6fb748d69012b3a9baccb97a_id_rsa (zuul-build-sshkey) 2026-07-13 20:22:06.708811 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.050171 2026-07-13 20:22:06.715322 | 2026-07-13 20:22:06.715412 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-13 20:22:07.520820 | debian-bookworm | ok 2026-07-13 20:22:07.525957 | 2026-07-13 20:22:07.526396 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-13 20:22:07.595702 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:22:07.611079 | 2026-07-13 20:22:07.611823 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-13 20:22:08.279739 | debian-bookworm | ok 2026-07-13 20:22:08.318539 | 2026-07-13 20:22:08.318657 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-13 20:22:08.399662 | debian-bookworm | ok 2026-07-13 20:22:08.404537 | 2026-07-13 20:22:08.404621 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-13 20:22:09.316610 | debian-bookworm -> localhost | ok 2026-07-13 20:22:09.322230 | 2026-07-13 20:22:09.322315 | TASK [validate-host : Collect information about the host] 2026-07-13 20:22:11.867756 | debian-bookworm | ok 2026-07-13 20:22:11.890496 | 2026-07-13 20:22:11.890602 | TASK [validate-host : Sanitize hostname] 2026-07-13 20:22:12.224949 | debian-bookworm | ok 2026-07-13 20:22:12.242520 | 2026-07-13 20:22:12.242641 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-13 20:22:14.196624 | debian-bookworm -> localhost | changed 2026-07-13 20:22:14.201957 | 2026-07-13 20:22:14.202050 | TASK [validate-host : Collect information about zuul worker] 2026-07-13 20:22:15.033778 | debian-bookworm | ok 2026-07-13 20:22:15.038469 | 2026-07-13 20:22:15.038564 | TASK [validate-host : Write out all zuul information for each host] 2026-07-13 20:22:16.967377 | debian-bookworm -> localhost | changed 2026-07-13 20:22:16.980446 | 2026-07-13 20:22:16.980536 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-13 20:22:17.296909 | debian-bookworm | ok 2026-07-13 20:22:17.303664 | 2026-07-13 20:22:17.303741 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-13 20:22:19.797968 | debian-bookworm | changed: 2026-07-13 20:22:19.798187 | debian-bookworm | cd+++++++++ src/ 2026-07-13 20:22:19.798224 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-13 20:22:19.798249 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-13 20:22:19.798270 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-07-13 20:22:19.798291 | debian-bookworm | Containerfile 2026-07-13 20:22:19.798419 | debian-bookworm | Containerfile 2026-07-13 20:22:19.861476 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/4e9dce8f6fb748d69012b3a9baccb97a/work/logs" 2026-07-13 20:25:05.788502 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/4e9dce8f6fb748d69012b3a9baccb97a/work/artifacts" 2026-07-13 20:25:06.144968 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/4e9dce8f6fb748d69012b3a9baccb97a/work/docs" 2026-07-13 20:25:06.160121 | 2026-07-13 20:25:06.160383 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-13 20:25:07.115233 | debian-bookworm | changed: 2026-07-13 20:25:07.116066 | debian-bookworm | .d..t...... ./ 2026-07-13 20:25:07.116182 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-13 20:25:07.116221 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-13 20:25:07.116252 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-13 20:25:07.116333 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-13 20:25:07.116424 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-13 20:25:07.116737 | debian-bookworm | changed: All items complete 2026-07-13 20:25:07.117089 | 2026-07-13 20:25:08.093725 | debian-bookworm | changed: .d..t...... ./ 2026-07-13 20:25:09.153101 | debian-bookworm | changed: .d..t...... ./ 2026-07-13 20:25:09.178341 | 2026-07-13 20:25:09.178739 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-13 20:25:09.815558 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.034743 2026-07-13 20:25:10.306489 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.023292 2026-07-13 20:25:10.325470 | 2026-07-13 20:25:10.325613 | PLAY RECAP 2026-07-13 20:25:10.325674 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-13 20:25:10.325699 | 2026-07-13 20:25:10.574885 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-13 20:25:10.575863 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-13 20:25:11.542357 | 2026-07-13 20:25:11.542553 | PLAY [Base post] 2026-07-13 20:25:11.563201 | 2026-07-13 20:25:11.564128 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-13 20:25:12.382392 | debian-bookworm | changed 2026-07-13 20:25:12.392384 | 2026-07-13 20:25:12.392511 | PLAY RECAP 2026-07-13 20:25:12.392582 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-13 20:25:12.392649 | 2026-07-13 20:25:12.561367 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-13 20:25:12.562330 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-13 20:25:13.579389 | 2026-07-13 20:25:13.579576 | PLAY [Base post-logs] 2026-07-13 20:25:13.591169 | 2026-07-13 20:25:13.591328 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-13 20:25:14.163958 | localhost | changed 2026-07-13 20:25:14.177136 | 2026-07-13 20:25:14.177332 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-13 20:25:14.235175 | localhost | ok 2026-07-13 20:25:14.242760 | 2026-07-13 20:25:14.242920 | TASK [Set zuul-log-path fact] 2026-07-13 20:25:14.291487 | localhost | ok 2026-07-13 20:25:14.304308 | 2026-07-13 20:25:14.304457 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-13 20:25:14.373862 | localhost | ok 2026-07-13 20:25:14.378093 | 2026-07-13 20:25:14.378255 | TASK [upload-logs : Create log directories] 2026-07-13 20:25:15.270360 | localhost | changed 2026-07-13 20:25:15.273512 | 2026-07-13 20:25:15.273634 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-13 20:25:16.148081 | localhost -> localhost | ok: Runtime: 0:00:00.029900 2026-07-13 20:25:16.153703 | 2026-07-13 20:25:16.153836 | TASK [upload-logs : Upload logs to log server] 2026-07-13 20:25:17.052107 | localhost | Output suppressed because no_log was given 2026-07-13 20:25:17.054140 | 2026-07-13 20:25:17.054269 | LOOP [upload-logs : Compress console log and json output] 2026-07-13 20:25:17.116708 | localhost | skipping: Conditional result was False 2026-07-13 20:25:17.132403 | localhost | skipping: Conditional result was False 2026-07-13 20:25:17.142526 | 2026-07-13 20:25:17.142702 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-13 20:25:17.233147 | localhost | skipping: Conditional result was False 2026-07-13 20:25:17.233488 | 2026-07-13 20:25:17.239219 | localhost | skipping: Conditional result was False 2026-07-13 20:25:17.255859 | 2026-07-13 20:25:17.256084 | LOOP [upload-logs : Upload console log and json output]