2026-08-27 15:15:55.632177 | Job console starting 2026-08-27 15:15:55.681331 | Updating git repos 2026-08-27 15:15:55.787237 | Cloning repos into workspace 2026-08-27 15:15:55.904878 | Restoring repo states 2026-08-27 15:15:55.924881 | Merging changes 2026-08-27 15:15:57.040779 | Checking out repos 2026-08-27 15:15:57.285968 | Preparing playbooks 2026-08-27 15:15:59.613893 | Running Ansible setup 2026-08-27 15:16:05.410197 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-27 15:16:06.957101 | 2026-08-27 15:16:06.957266 | PLAY [Base pre] 2026-08-27 15:16:06.988346 | 2026-08-27 15:16:06.988484 | TASK [Setup log path fact] 2026-08-27 15:16:07.017083 | debian-bookworm | ok 2026-08-27 15:16:07.045767 | 2026-08-27 15:16:07.045909 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-27 15:16:07.100322 | debian-bookworm | ok 2026-08-27 15:16:07.123794 | 2026-08-27 15:16:07.123926 | TASK [emit-job-header : Print job information] 2026-08-27 15:16:07.162212 | # Job Information 2026-08-27 15:16:07.162388 | Ansible Version: 2.16.14 2026-08-27 15:16:07.162425 | Job: python-osism-test-setup 2026-08-27 15:16:07.162458 | Pipeline: check 2026-08-27 15:16:07.162481 | Executor: 521e9411259a 2026-08-27 15:16:07.162502 | Triggered by: https://github.com/osism/python-osism/pull/2633 2026-08-27 15:16:07.162524 | Event ID: 2b75c2a0-a22a-11f1-8e5f-ba3b55eb4da2 2026-08-27 15:16:07.167593 | 2026-08-27 15:16:07.167688 | LOOP [emit-job-header : Print node information] 2026-08-27 15:16:07.337885 | debian-bookworm | ok: 2026-08-27 15:16:07.338099 | debian-bookworm | # Node Information 2026-08-27 15:16:07.338133 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-27 15:16:07.338158 | debian-bookworm | Hostname: debian 2026-08-27 15:16:07.338180 | debian-bookworm | Username: zuul 2026-08-27 15:16:07.338201 | debian-bookworm | Distro: Debian 12.15 2026-08-27 15:16:07.338224 | debian-bookworm | Provider: regiocloud-a 2026-08-27 15:16:07.338258 | debian-bookworm | Region: 2026-08-27 15:16:07.338280 | debian-bookworm | Label: debian-bookworm 2026-08-27 15:16:07.338300 | debian-bookworm | Product Name: OpenStack Nova 2026-08-27 15:16:07.338320 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6b:3898 2026-08-27 15:16:07.354747 | 2026-08-27 15:16:07.359544 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-27 15:16:08.102574 | debian-bookworm -> localhost | changed 2026-08-27 15:16:08.109908 | 2026-08-27 15:16:08.110011 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-27 15:16:09.704056 | debian-bookworm -> localhost | changed 2026-08-27 15:16:09.713100 | 2026-08-27 15:16:09.713195 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-27 15:16:10.388165 | debian-bookworm -> localhost | ok 2026-08-27 15:16:10.393400 | 2026-08-27 15:16:10.393618 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-27 15:16:10.451272 | debian-bookworm | ok 2026-08-27 15:16:10.463625 | debian-bookworm | included: /var/lib/zuul/builds/2ff64b1867704e6683144a95af0f7c98/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-27 15:16:10.478560 | 2026-08-27 15:16:10.478630 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-27 15:16:12.386048 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-27 15:16:12.386296 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2ff64b1867704e6683144a95af0f7c98/work/2ff64b1867704e6683144a95af0f7c98_id_rsa 2026-08-27 15:16:12.386337 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2ff64b1867704e6683144a95af0f7c98/work/2ff64b1867704e6683144a95af0f7c98_id_rsa.pub 2026-08-27 15:16:12.386364 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-27 15:16:12.386390 | debian-bookworm -> localhost | SHA256:WaQn9Rw4THH2h1b4yXLneOq6qMUtKzvd33/7NhxKTIk zuul-build-sshkey 2026-08-27 15:16:12.386412 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-27 15:16:12.386443 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-27 15:16:12.386464 | debian-bookworm -> localhost | | o=o+ ..| 2026-08-27 15:16:12.386485 | debian-bookworm -> localhost | | ++= o.o | 2026-08-27 15:16:12.386505 | debian-bookworm -> localhost | | o o.+ *.o| 2026-08-27 15:16:12.386525 | debian-bookworm -> localhost | | = E = =o| 2026-08-27 15:16:12.386545 | debian-bookworm -> localhost | | S o oo.| 2026-08-27 15:16:12.386575 | debian-bookworm -> localhost | | . . o..o| 2026-08-27 15:16:12.386596 | debian-bookworm -> localhost | | .+.o oo.| 2026-08-27 15:16:12.386616 | debian-bookworm -> localhost | | o..+...+o| 2026-08-27 15:16:12.386636 | debian-bookworm -> localhost | | o=o o=ooX| 2026-08-27 15:16:12.386656 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-27 15:16:12.386709 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.820337 2026-08-27 15:16:12.393116 | 2026-08-27 15:16:12.393217 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-27 15:16:12.421770 | debian-bookworm | ok 2026-08-27 15:16:12.434570 | debian-bookworm | included: /var/lib/zuul/builds/2ff64b1867704e6683144a95af0f7c98/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-27 15:16:12.449784 | 2026-08-27 15:16:12.449890 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-27 15:16:12.485126 | debian-bookworm | skipping: Conditional result was False 2026-08-27 15:16:12.492038 | 2026-08-27 15:16:12.492303 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-27 15:16:13.260834 | debian-bookworm | changed 2026-08-27 15:16:13.267063 | 2026-08-27 15:16:13.267192 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-27 15:16:13.522215 | debian-bookworm | ok 2026-08-27 15:16:13.532777 | 2026-08-27 15:16:13.532881 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-27 15:16:14.280606 | debian-bookworm | changed 2026-08-27 15:16:14.306983 | 2026-08-27 15:16:14.307127 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-27 15:16:15.120444 | debian-bookworm | changed 2026-08-27 15:16:15.129605 | 2026-08-27 15:16:15.130730 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-27 15:16:15.184223 | debian-bookworm | skipping: Conditional result was False 2026-08-27 15:16:15.205182 | 2026-08-27 15:16:15.205318 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-27 15:16:16.450421 | debian-bookworm -> localhost | changed 2026-08-27 15:16:16.472293 | 2026-08-27 15:16:16.472459 | TASK [add-build-sshkey : Add back temp key] 2026-08-27 15:16:17.230897 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2ff64b1867704e6683144a95af0f7c98/work/2ff64b1867704e6683144a95af0f7c98_id_rsa (zuul-build-sshkey) 2026-08-27 15:16:17.231139 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010008 2026-08-27 15:16:17.239271 | 2026-08-27 15:16:17.239385 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-27 15:16:17.641907 | debian-bookworm | ok 2026-08-27 15:16:17.647338 | 2026-08-27 15:16:17.647441 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-27 15:16:17.675780 | debian-bookworm | skipping: Conditional result was False 2026-08-27 15:16:17.691832 | 2026-08-27 15:16:17.691936 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-27 15:16:18.276069 | debian-bookworm | ok 2026-08-27 15:16:18.304639 | 2026-08-27 15:16:18.304768 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-27 15:16:18.383681 | debian-bookworm | ok 2026-08-27 15:16:18.395749 | 2026-08-27 15:16:18.395864 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-27 15:16:18.962030 | debian-bookworm -> localhost | ok 2026-08-27 15:16:18.968755 | 2026-08-27 15:16:18.968857 | TASK [validate-host : Collect information about the host] 2026-08-27 15:16:20.159206 | debian-bookworm | ok 2026-08-27 15:16:20.195959 | 2026-08-27 15:16:20.196080 | TASK [validate-host : Sanitize hostname] 2026-08-27 15:16:20.377495 | debian-bookworm | ok 2026-08-27 15:16:20.381985 | 2026-08-27 15:16:20.382082 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-27 15:16:21.475078 | debian-bookworm -> localhost | changed 2026-08-27 15:16:21.480104 | 2026-08-27 15:16:21.480196 | TASK [validate-host : Collect information about zuul worker] 2026-08-27 15:16:21.892852 | debian-bookworm | ok 2026-08-27 15:16:21.896842 | 2026-08-27 15:16:21.896928 | TASK [validate-host : Write out all zuul information for each host] 2026-08-27 15:16:23.103666 | debian-bookworm -> localhost | changed 2026-08-27 15:16:23.124173 | 2026-08-27 15:16:23.124325 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-27 15:16:23.406104 | debian-bookworm | ok 2026-08-27 15:16:23.411688 | 2026-08-27 15:16:23.411790 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-27 15:16:25.656325 | debian-bookworm | changed: 2026-08-27 15:16:25.656505 | debian-bookworm | cd+++++++++ src/ 2026-08-27 15:16:25.656541 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-27 15:16:25.656565 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-27 15:16:25.656586 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-27 15:16:25.656608 | debian-bookworm | Containerfile 2026-08-27 15:16:25.656740 | debian-bookworm | Containerfile 2026-08-27 15:16:25.664121 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/2ff64b1867704e6683144a95af0f7c98/work/logs" 2026-08-27 15:19:08.763532 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2ff64b1867704e6683144a95af0f7c98/work/artifacts" 2026-08-27 15:19:09.042496 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2ff64b1867704e6683144a95af0f7c98/work/docs" 2026-08-27 15:19:09.061736 | 2026-08-27 15:19:09.061913 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-27 15:19:09.955963 | debian-bookworm | changed: 2026-08-27 15:19:09.956329 | debian-bookworm | .d..t...... ./ 2026-08-27 15:19:09.956385 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-27 15:19:09.956420 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-27 15:19:09.956451 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-27 15:19:09.956481 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-27 15:19:09.956510 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-27 15:19:09.956630 | debian-bookworm | changed: All items complete 2026-08-27 15:19:09.956670 | 2026-08-27 15:19:10.565814 | debian-bookworm | changed: .d..t...... ./ 2026-08-27 15:19:11.201218 | debian-bookworm | changed: .d..t...... ./ 2026-08-27 15:19:11.217591 | 2026-08-27 15:19:11.217726 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-27 15:19:11.614329 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009226 2026-08-27 15:19:11.946975 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.012055 2026-08-27 15:19:11.964379 | 2026-08-27 15:19:11.964627 | PLAY RECAP 2026-08-27 15:19:11.964694 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-27 15:19:11.964721 | 2026-08-27 15:19:12.129555 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-27 15:19:12.131160 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-27 15:19:12.890097 | 2026-08-27 15:19:12.890297 | PLAY [Base post] 2026-08-27 15:19:12.904879 | 2026-08-27 15:19:12.905033 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-27 15:19:13.755362 | debian-bookworm | changed 2026-08-27 15:19:13.764903 | 2026-08-27 15:19:13.765034 | PLAY RECAP 2026-08-27 15:19:13.765114 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-27 15:19:13.765197 | 2026-08-27 15:19:13.904198 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-27 15:19:13.906378 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-27 15:19:14.834249 | 2026-08-27 15:19:14.834471 | PLAY [Base post-logs] 2026-08-27 15:19:14.845644 | 2026-08-27 15:19:14.845796 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-27 15:19:15.406411 | localhost | changed 2026-08-27 15:19:15.417742 | 2026-08-27 15:19:15.417921 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-27 15:19:15.455412 | localhost | ok 2026-08-27 15:19:15.458862 | 2026-08-27 15:19:15.458971 | TASK [Set zuul-log-path fact] 2026-08-27 15:19:15.474587 | localhost | ok 2026-08-27 15:19:15.483046 | 2026-08-27 15:19:15.483157 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-27 15:19:15.508753 | localhost | ok 2026-08-27 15:19:15.512050 | 2026-08-27 15:19:15.512171 | TASK [upload-logs : Create log directories] 2026-08-27 15:19:16.101689 | localhost | changed 2026-08-27 15:19:16.105488 | 2026-08-27 15:19:16.105615 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-27 15:19:16.735669 | localhost -> localhost | ok: Runtime: 0:00:00.006965 2026-08-27 15:19:16.741610 | 2026-08-27 15:19:16.741755 | TASK [upload-logs : Upload logs to log server] 2026-08-27 15:19:17.350370 | localhost | Output suppressed because no_log was given 2026-08-27 15:19:17.355176 | 2026-08-27 15:19:17.355471 | LOOP [upload-logs : Compress console log and json output] 2026-08-27 15:19:17.423903 | localhost | skipping: Conditional result was False 2026-08-27 15:19:17.429953 | localhost | skipping: Conditional result was False 2026-08-27 15:19:17.441881 | 2026-08-27 15:19:17.442045 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-27 15:19:17.493047 | localhost | skipping: Conditional result was False 2026-08-27 15:19:17.493449 | 2026-08-27 15:19:17.498110 | localhost | skipping: Conditional result was False 2026-08-27 15:19:17.513291 | 2026-08-27 15:19:17.513630 | LOOP [upload-logs : Upload console log and json output]