2026-08-27 13:57:22.603701 | Job console starting 2026-08-27 13:57:22.611792 | Updating git repos 2026-08-27 13:57:22.658045 | Cloning repos into workspace 2026-08-27 13:57:22.731280 | Restoring repo states 2026-08-27 13:57:22.765534 | Merging changes 2026-08-27 13:57:23.745614 | Checking out repos 2026-08-27 13:57:23.833118 | Preparing playbooks 2026-08-27 13:57:25.669722 | Running Ansible setup 2026-08-27 13:57:30.249418 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-27 13:57:31.118316 | 2026-08-27 13:57:31.118558 | PLAY [Base pre] 2026-08-27 13:57:31.137691 | 2026-08-27 13:57:31.137857 | TASK [Setup log path fact] 2026-08-27 13:57:31.168008 | debian-bookworm | ok 2026-08-27 13:57:31.186075 | 2026-08-27 13:57:31.186249 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-27 13:57:31.236990 | debian-bookworm | ok 2026-08-27 13:57:31.258826 | 2026-08-27 13:57:31.259015 | TASK [emit-job-header : Print job information] 2026-08-27 13:57:31.314621 | # Job Information 2026-08-27 13:57:31.314828 | Ansible Version: 2.16.14 2026-08-27 13:57:31.315159 | Job: python-osism-test-setup 2026-08-27 13:57:31.315196 | Pipeline: check 2026-08-27 13:57:31.315219 | Executor: 521e9411259a 2026-08-27 13:57:31.315240 | Triggered by: https://github.com/osism/python-osism/pull/2634 2026-08-27 13:57:31.315263 | Event ID: d6287410-a21e-11f1-9f7f-57bf5d208a06 2026-08-27 13:57:31.320796 | 2026-08-27 13:57:31.320920 | LOOP [emit-job-header : Print node information] 2026-08-27 13:57:31.471932 | debian-bookworm | ok: 2026-08-27 13:57:31.472226 | debian-bookworm | # Node Information 2026-08-27 13:57:31.472264 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-27 13:57:31.472290 | debian-bookworm | Hostname: debian 2026-08-27 13:57:31.472311 | debian-bookworm | Username: zuul 2026-08-27 13:57:31.472348 | debian-bookworm | Distro: Debian 12.15 2026-08-27 13:57:31.472372 | debian-bookworm | Provider: regiocloud-a 2026-08-27 13:57:31.472393 | debian-bookworm | Region: 2026-08-27 13:57:31.472415 | debian-bookworm | Label: debian-bookworm 2026-08-27 13:57:31.472435 | debian-bookworm | Product Name: OpenStack Nova 2026-08-27 13:57:31.472455 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe64:5531 2026-08-27 13:57:31.498413 | 2026-08-27 13:57:31.498705 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-27 13:57:32.138034 | debian-bookworm -> localhost | changed 2026-08-27 13:57:32.151122 | 2026-08-27 13:57:32.153298 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-27 13:57:34.675466 | debian-bookworm -> localhost | changed 2026-08-27 13:57:34.707550 | 2026-08-27 13:57:34.707717 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-27 13:57:35.318610 | debian-bookworm -> localhost | ok 2026-08-27 13:57:35.326152 | 2026-08-27 13:57:35.326319 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-27 13:57:35.384882 | debian-bookworm | ok 2026-08-27 13:57:35.408598 | debian-bookworm | included: /var/lib/zuul/builds/cf22a197a5f64a5dacc522e635683b55/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-27 13:57:35.429518 | 2026-08-27 13:57:35.429655 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-27 13:57:37.155983 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-27 13:57:37.156190 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/cf22a197a5f64a5dacc522e635683b55/work/cf22a197a5f64a5dacc522e635683b55_id_rsa 2026-08-27 13:57:37.156227 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/cf22a197a5f64a5dacc522e635683b55/work/cf22a197a5f64a5dacc522e635683b55_id_rsa.pub 2026-08-27 13:57:37.156252 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-27 13:57:37.156276 | debian-bookworm -> localhost | SHA256:PWsZA5QrQ+52yARtxXCqphXJgbU1SMDEIs/aZwxqvRY zuul-build-sshkey 2026-08-27 13:57:37.156299 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-27 13:57:37.156353 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-27 13:57:37.156382 | debian-bookworm -> localhost | | +o=+o+++. | 2026-08-27 13:57:37.156404 | debian-bookworm -> localhost | |o +.o=+=o | 2026-08-27 13:57:37.156424 | debian-bookworm -> localhost | |.+ ==. .. | 2026-08-27 13:57:37.156443 | debian-bookworm -> localhost | | + o= .o | 2026-08-27 13:57:37.156463 | debian-bookworm -> localhost | | +.o++ +S = | 2026-08-27 13:57:37.156488 | debian-bookworm -> localhost | |o..E+ = . * | 2026-08-27 13:57:37.156509 | debian-bookworm -> localhost | |. .oo. . + | 2026-08-27 13:57:37.156529 | debian-bookworm -> localhost | | o . | 2026-08-27 13:57:37.156549 | debian-bookworm -> localhost | | . | 2026-08-27 13:57:37.156569 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-27 13:57:37.156620 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.757607 2026-08-27 13:57:37.163069 | 2026-08-27 13:57:37.163172 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-27 13:57:37.183506 | debian-bookworm | ok 2026-08-27 13:57:37.193688 | debian-bookworm | included: /var/lib/zuul/builds/cf22a197a5f64a5dacc522e635683b55/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-27 13:57:37.203461 | 2026-08-27 13:57:37.203569 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-27 13:57:37.231056 | debian-bookworm | skipping: Conditional result was False 2026-08-27 13:57:37.236011 | 2026-08-27 13:57:37.236100 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-27 13:57:37.877758 | debian-bookworm | changed 2026-08-27 13:57:37.885081 | 2026-08-27 13:57:37.885189 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-27 13:57:38.159152 | debian-bookworm | ok 2026-08-27 13:57:38.165918 | 2026-08-27 13:57:38.166034 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-27 13:57:38.824873 | debian-bookworm | changed 2026-08-27 13:57:38.834187 | 2026-08-27 13:57:38.834377 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-27 13:57:39.497479 | debian-bookworm | changed 2026-08-27 13:57:39.504211 | 2026-08-27 13:57:39.504309 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-27 13:57:39.518302 | debian-bookworm | skipping: Conditional result was False 2026-08-27 13:57:39.524978 | 2026-08-27 13:57:39.525067 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-27 13:57:39.957189 | debian-bookworm -> localhost | changed 2026-08-27 13:57:39.967772 | 2026-08-27 13:57:39.967862 | TASK [add-build-sshkey : Add back temp key] 2026-08-27 13:57:40.359914 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/cf22a197a5f64a5dacc522e635683b55/work/cf22a197a5f64a5dacc522e635683b55_id_rsa (zuul-build-sshkey) 2026-08-27 13:57:40.360164 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015524 2026-08-27 13:57:40.367674 | 2026-08-27 13:57:40.368462 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-27 13:57:40.770313 | debian-bookworm | ok 2026-08-27 13:57:40.779093 | 2026-08-27 13:57:40.779193 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-27 13:57:40.827188 | debian-bookworm | skipping: Conditional result was False 2026-08-27 13:57:40.839001 | 2026-08-27 13:57:40.839113 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-27 13:57:41.271590 | debian-bookworm | ok 2026-08-27 13:57:41.297483 | 2026-08-27 13:57:41.297610 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-27 13:57:41.326309 | debian-bookworm | ok 2026-08-27 13:57:41.331984 | 2026-08-27 13:57:41.332140 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-27 13:57:41.625501 | debian-bookworm -> localhost | ok 2026-08-27 13:57:41.632170 | 2026-08-27 13:57:41.632266 | TASK [validate-host : Collect information about the host] 2026-08-27 13:57:42.797198 | debian-bookworm | ok 2026-08-27 13:57:42.815432 | 2026-08-27 13:57:42.815552 | TASK [validate-host : Sanitize hostname] 2026-08-27 13:57:42.951862 | debian-bookworm | ok 2026-08-27 13:57:42.957239 | 2026-08-27 13:57:42.957364 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-27 13:57:43.497872 | debian-bookworm -> localhost | changed 2026-08-27 13:57:43.503694 | 2026-08-27 13:57:43.503786 | TASK [validate-host : Collect information about zuul worker] 2026-08-27 13:57:43.944838 | debian-bookworm | ok 2026-08-27 13:57:43.954220 | 2026-08-27 13:57:43.954490 | TASK [validate-host : Write out all zuul information for each host] 2026-08-27 13:57:44.747671 | debian-bookworm -> localhost | changed 2026-08-27 13:57:44.759109 | 2026-08-27 13:57:44.759232 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-27 13:57:45.041894 | debian-bookworm | ok 2026-08-27 13:57:45.049229 | 2026-08-27 13:57:45.049378 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-27 13:57:47.878918 | debian-bookworm | changed: 2026-08-27 13:57:47.879181 | debian-bookworm | cd+++++++++ src/ 2026-08-27 13:57:47.879220 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-27 13:57:47.879246 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-27 13:57:47.879268 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-27 13:57:47.879288 | debian-bookworm | Containerfile 2026-08-27 13:57:47.879483 | debian-bookworm | Containerfile 2026-08-27 13:57:47.935908 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/cf22a197a5f64a5dacc522e635683b55/work/logs" 2026-08-27 14:00:28.205410 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/cf22a197a5f64a5dacc522e635683b55/work/artifacts" 2026-08-27 14:00:28.519823 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/cf22a197a5f64a5dacc522e635683b55/work/docs" 2026-08-27 14:00:28.537929 | 2026-08-27 14:00:28.538172 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-27 14:00:29.401887 | debian-bookworm | changed: 2026-08-27 14:00:29.402310 | debian-bookworm | .d..t...... ./ 2026-08-27 14:00:29.402381 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-27 14:00:29.402426 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-27 14:00:29.402466 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-27 14:00:29.402521 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-27 14:00:29.402569 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-27 14:00:29.402664 | debian-bookworm | changed: All items complete 2026-08-27 14:00:29.402726 | 2026-08-27 14:00:29.989491 | debian-bookworm | changed: .d..t...... ./ 2026-08-27 14:00:30.549227 | debian-bookworm | changed: .d..t...... ./ 2026-08-27 14:00:30.572930 | 2026-08-27 14:00:30.573117 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-27 14:00:30.941939 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.007514 2026-08-27 14:00:31.253170 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.007928 2026-08-27 14:00:31.271317 | 2026-08-27 14:00:31.271447 | PLAY RECAP 2026-08-27 14:00:31.271513 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-27 14:00:31.271544 | 2026-08-27 14:00:31.452878 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-27 14:00:31.453924 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-27 14:00:32.267379 | 2026-08-27 14:00:32.267590 | PLAY [Base post] 2026-08-27 14:00:32.282876 | 2026-08-27 14:00:32.283041 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-27 14:00:33.136638 | debian-bookworm | changed 2026-08-27 14:00:33.146157 | 2026-08-27 14:00:33.146338 | PLAY RECAP 2026-08-27 14:00:33.146425 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-27 14:00:33.146510 | 2026-08-27 14:00:33.314933 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-27 14:00:33.316076 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-27 14:00:34.248067 | 2026-08-27 14:00:34.248267 | PLAY [Base post-logs] 2026-08-27 14:00:34.259400 | 2026-08-27 14:00:34.259558 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-27 14:00:34.777960 | localhost | changed 2026-08-27 14:00:34.794455 | 2026-08-27 14:00:34.794635 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-27 14:00:34.831551 | localhost | ok 2026-08-27 14:00:34.837365 | 2026-08-27 14:00:34.837528 | TASK [Set zuul-log-path fact] 2026-08-27 14:00:34.855658 | localhost | ok 2026-08-27 14:00:34.873556 | 2026-08-27 14:00:34.873699 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-27 14:00:34.911865 | localhost | ok 2026-08-27 14:00:34.919883 | 2026-08-27 14:00:34.920069 | TASK [upload-logs : Create log directories] 2026-08-27 14:00:35.487080 | localhost | changed 2026-08-27 14:00:35.494892 | 2026-08-27 14:00:35.495054 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-27 14:00:36.029738 | localhost -> localhost | ok: Runtime: 0:00:00.008429 2026-08-27 14:00:36.034188 | 2026-08-27 14:00:36.034354 | TASK [upload-logs : Upload logs to log server] 2026-08-27 14:00:36.656372 | localhost | Output suppressed because no_log was given 2026-08-27 14:00:36.660699 | 2026-08-27 14:00:36.660885 | LOOP [upload-logs : Compress console log and json output] 2026-08-27 14:00:36.735855 | localhost | skipping: Conditional result was False 2026-08-27 14:00:36.751900 | localhost | skipping: Conditional result was False 2026-08-27 14:00:36.762160 | 2026-08-27 14:00:36.762326 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-27 14:00:36.820412 | localhost | skipping: Conditional result was False 2026-08-27 14:00:36.821001 | 2026-08-27 14:00:36.824730 | localhost | skipping: Conditional result was False 2026-08-27 14:00:36.832604 | 2026-08-27 14:00:36.832795 | LOOP [upload-logs : Upload console log and json output]