2026-09-07 03:05:34.238667 | Job console starting 2026-09-07 03:05:34.252550 | Updating git repos 2026-09-07 03:05:34.271374 | Cloning repos into workspace 2026-09-07 03:05:34.353519 | Restoring repo states 2026-09-07 03:05:34.367218 | Merging changes 2026-09-07 03:05:34.367235 | Checking out repos 2026-09-07 03:05:34.421073 | Preparing playbooks 2026-09-07 03:05:35.122853 | Running Ansible setup 2026-09-07 03:05:39.625854 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-07 03:05:40.454345 | 2026-09-07 03:05:40.454603 | PLAY [Base pre] 2026-09-07 03:05:40.485638 | 2026-09-07 03:05:40.485800 | TASK [Setup log path fact] 2026-09-07 03:05:40.518074 | debian-bookworm | ok 2026-09-07 03:05:40.535553 | 2026-09-07 03:05:40.535718 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-07 03:05:40.586161 | debian-bookworm | ok 2026-09-07 03:05:40.596714 | 2026-09-07 03:05:40.596844 | TASK [emit-job-header : Print job information] 2026-09-07 03:05:40.656205 | # Job Information 2026-09-07 03:05:40.656424 | Ansible Version: 2.16.14 2026-09-07 03:05:40.656498 | Job: python-black 2026-09-07 03:05:40.656533 | Pipeline: periodic-daily 2026-09-07 03:05:40.656556 | Executor: 521e9411259a 2026-09-07 03:05:40.656573 | Triggered by: https://github.com/osism/openstack-sandbox-manager 2026-09-07 03:05:40.656591 | Event ID: e29cf5e728694888b18dffb3ac23b20c 2026-09-07 03:05:40.663205 | 2026-09-07 03:05:40.663319 | LOOP [emit-job-header : Print node information] 2026-09-07 03:05:40.859776 | debian-bookworm | ok: 2026-09-07 03:05:40.859918 | debian-bookworm | # Node Information 2026-09-07 03:05:40.859946 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-07 03:05:40.859967 | debian-bookworm | Hostname: debian 2026-09-07 03:05:40.859985 | debian-bookworm | Username: zuul 2026-09-07 03:05:40.860002 | debian-bookworm | Distro: Debian 12.15 2026-09-07 03:05:40.860035 | debian-bookworm | Provider: regiocloud-a 2026-09-07 03:05:40.860053 | debian-bookworm | Region: 2026-09-07 03:05:40.860069 | debian-bookworm | Label: debian-bookworm 2026-09-07 03:05:40.860086 | debian-bookworm | Product Name: OpenStack Nova 2026-09-07 03:05:40.860102 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0d:7fe2 2026-09-07 03:05:40.871937 | 2026-09-07 03:05:40.872090 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-07 03:05:41.383161 | debian-bookworm -> localhost | changed 2026-09-07 03:05:41.389146 | 2026-09-07 03:05:41.389236 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-07 03:05:42.428262 | debian-bookworm -> localhost | changed 2026-09-07 03:05:42.440980 | 2026-09-07 03:05:42.441082 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-07 03:05:42.696279 | debian-bookworm -> localhost | ok 2026-09-07 03:05:42.702171 | 2026-09-07 03:05:42.702271 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-07 03:05:42.731038 | debian-bookworm | ok 2026-09-07 03:05:42.752057 | debian-bookworm | included: /var/lib/zuul/builds/78f025e1ef6f43768afdc41d5027fe90/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-07 03:05:42.757884 | 2026-09-07 03:05:42.757968 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-07 03:05:44.597187 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-07 03:05:44.597370 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/78f025e1ef6f43768afdc41d5027fe90/work/78f025e1ef6f43768afdc41d5027fe90_id_rsa 2026-09-07 03:05:44.597407 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/78f025e1ef6f43768afdc41d5027fe90/work/78f025e1ef6f43768afdc41d5027fe90_id_rsa.pub 2026-09-07 03:05:44.597446 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-07 03:05:44.597472 | debian-bookworm -> localhost | SHA256:y5b7pDGmc78wTVfJ9zcz+rd6ZUFx+iVT3xB3e9pnqds zuul-build-sshkey 2026-09-07 03:05:44.597494 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-07 03:05:44.597527 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-07 03:05:44.598043 | debian-bookworm -> localhost | | oo*| 2026-09-07 03:05:44.598085 | debian-bookworm -> localhost | | . B*| 2026-09-07 03:05:44.598110 | debian-bookworm -> localhost | | O.*| 2026-09-07 03:05:44.598132 | debian-bookworm -> localhost | | . O=| 2026-09-07 03:05:44.598154 | debian-bookworm -> localhost | | S . . .=O| 2026-09-07 03:05:44.598183 | debian-bookworm -> localhost | | . = . o.O| 2026-09-07 03:05:44.598205 | debian-bookworm -> localhost | | @ o o ..| 2026-09-07 03:05:44.598226 | debian-bookworm -> localhost | | .+.O +..| 2026-09-07 03:05:44.598247 | debian-bookworm -> localhost | | .ooo+. ooEo| 2026-09-07 03:05:44.598268 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-07 03:05:44.598473 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.193912 2026-09-07 03:05:44.609352 | 2026-09-07 03:05:44.609506 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-07 03:05:44.638799 | debian-bookworm | ok 2026-09-07 03:05:44.648473 | debian-bookworm | included: /var/lib/zuul/builds/78f025e1ef6f43768afdc41d5027fe90/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-07 03:05:44.656906 | 2026-09-07 03:05:44.656987 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-07 03:05:44.671512 | debian-bookworm | skipping: Conditional result was False 2026-09-07 03:05:44.677763 | 2026-09-07 03:05:44.677865 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-07 03:05:45.426150 | debian-bookworm | changed 2026-09-07 03:05:45.434660 | 2026-09-07 03:05:45.434748 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-07 03:05:45.754338 | debian-bookworm | ok 2026-09-07 03:05:45.764531 | 2026-09-07 03:05:45.764636 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-07 03:05:46.507564 | debian-bookworm | changed 2026-09-07 03:05:46.514250 | 2026-09-07 03:05:46.514341 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-07 03:05:47.224494 | debian-bookworm | changed 2026-09-07 03:05:47.229314 | 2026-09-07 03:05:47.229394 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-07 03:05:47.264014 | debian-bookworm | skipping: Conditional result was False 2026-09-07 03:05:47.269880 | 2026-09-07 03:05:47.269977 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-07 03:05:48.161613 | debian-bookworm -> localhost | changed 2026-09-07 03:05:48.170665 | 2026-09-07 03:05:48.170754 | TASK [add-build-sshkey : Add back temp key] 2026-09-07 03:05:48.603263 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/78f025e1ef6f43768afdc41d5027fe90/work/78f025e1ef6f43768afdc41d5027fe90_id_rsa (zuul-build-sshkey) 2026-09-07 03:05:48.603481 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013108 2026-09-07 03:05:48.610995 | 2026-09-07 03:05:48.611092 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-07 03:05:49.024698 | debian-bookworm | ok 2026-09-07 03:05:49.028999 | 2026-09-07 03:05:49.029075 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-07 03:05:49.054005 | debian-bookworm | skipping: Conditional result was False 2026-09-07 03:05:49.062464 | 2026-09-07 03:05:49.062544 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-07 03:05:49.488788 | debian-bookworm | ok 2026-09-07 03:05:49.502336 | 2026-09-07 03:05:49.502452 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-07 03:05:49.533743 | debian-bookworm | ok 2026-09-07 03:05:49.542292 | 2026-09-07 03:05:49.542380 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-07 03:05:49.899221 | debian-bookworm -> localhost | ok 2026-09-07 03:05:49.905468 | 2026-09-07 03:05:49.905561 | TASK [validate-host : Collect information about the host] 2026-09-07 03:05:51.093707 | debian-bookworm | ok 2026-09-07 03:05:51.105788 | 2026-09-07 03:05:51.105892 | TASK [validate-host : Sanitize hostname] 2026-09-07 03:05:51.209105 | debian-bookworm | ok 2026-09-07 03:05:51.213322 | 2026-09-07 03:05:51.213405 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-07 03:05:51.801951 | debian-bookworm -> localhost | changed 2026-09-07 03:05:51.807594 | 2026-09-07 03:05:51.807690 | TASK [validate-host : Collect information about zuul worker] 2026-09-07 03:05:52.238060 | debian-bookworm | ok 2026-09-07 03:05:52.242713 | 2026-09-07 03:05:52.242802 | TASK [validate-host : Write out all zuul information for each host] 2026-09-07 03:05:52.771661 | debian-bookworm -> localhost | changed 2026-09-07 03:05:52.781162 | 2026-09-07 03:05:52.781262 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-07 03:05:53.093263 | debian-bookworm | ok 2026-09-07 03:05:53.098774 | 2026-09-07 03:05:53.098878 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-07 03:05:54.047328 | debian-bookworm | changed: 2026-09-07 03:05:54.047495 | debian-bookworm | cd+++++++++ src/ 2026-09-07 03:05:54.047526 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-07 03:05:54.047546 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-07 03:05:54.047563 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2026-09-07 03:05:54.047579 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/78f025e1ef6f43768afdc41d5027fe90/work/logs" 2026-09-07 03:06:50.805849 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/78f025e1ef6f43768afdc41d5027fe90/work/artifacts" 2026-09-07 03:06:51.092150 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/78f025e1ef6f43768afdc41d5027fe90/work/docs" 2026-09-07 03:06:51.108123 | 2026-09-07 03:06:51.108256 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-07 03:06:51.903562 | debian-bookworm | changed: 2026-09-07 03:06:51.903850 | debian-bookworm | .d..t...... ./ 2026-09-07 03:06:51.903959 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-07 03:06:51.903989 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-07 03:06:51.904272 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-07 03:06:51.904315 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-07 03:06:51.904340 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-07 03:06:51.904413 | debian-bookworm | changed: All items complete 2026-09-07 03:06:51.904443 | 2026-09-07 03:06:52.583649 | debian-bookworm | changed: .d..t...... ./ 2026-09-07 03:06:53.417850 | debian-bookworm | changed: .d..t...... ./ 2026-09-07 03:06:53.429535 | 2026-09-07 03:06:53.429626 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-07 03:06:53.448901 | debian-bookworm | skipping: Conditional result was False 2026-09-07 03:06:53.452536 | debian-bookworm | skipping: Conditional result was False 2026-09-07 03:06:53.468574 | 2026-09-07 03:06:53.468644 | PLAY RECAP 2026-09-07 03:06:53.468691 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-09-07 03:06:53.468713 | 2026-09-07 03:06:53.562076 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-07 03:06:53.562818 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-07 03:06:54.270442 | 2026-09-07 03:06:54.270564 | PLAY [Base post] 2026-09-07 03:06:54.282601 | 2026-09-07 03:06:54.282715 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-07 03:06:54.984789 | debian-bookworm | changed 2026-09-07 03:06:54.990695 | 2026-09-07 03:06:54.990785 | PLAY RECAP 2026-09-07 03:06:54.990872 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-07 03:06:54.990945 | 2026-09-07 03:06:55.164804 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-07 03:06:55.165559 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-07 03:06:56.236443 | 2026-09-07 03:06:56.236625 | PLAY [Base post-logs] 2026-09-07 03:06:56.254808 | 2026-09-07 03:06:56.255009 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-07 03:06:56.753612 | localhost | changed 2026-09-07 03:06:56.763995 | 2026-09-07 03:06:56.764152 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-07 03:06:56.810566 | localhost | ok 2026-09-07 03:06:56.813777 | 2026-09-07 03:06:56.813874 | TASK [Set zuul-log-path fact] 2026-09-07 03:06:56.830507 | localhost | ok 2026-09-07 03:06:56.842405 | 2026-09-07 03:06:56.842528 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-07 03:06:56.867797 | localhost | ok 2026-09-07 03:06:56.871318 | 2026-09-07 03:06:56.871461 | TASK [upload-logs : Create log directories] 2026-09-07 03:06:57.759607 | localhost | changed 2026-09-07 03:06:57.762447 | 2026-09-07 03:06:57.762554 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-07 03:06:58.293443 | localhost -> localhost | ok: Runtime: 0:00:00.014449 2026-09-07 03:06:58.297568 | 2026-09-07 03:06:58.297687 | TASK [upload-logs : Upload logs to log server] 2026-09-07 03:06:59.065720 | localhost | Output suppressed because no_log was given 2026-09-07 03:06:59.067295 | 2026-09-07 03:06:59.067388 | LOOP [upload-logs : Compress console log and json output] 2026-09-07 03:06:59.139451 | localhost | skipping: Conditional result was False 2026-09-07 03:06:59.144146 | localhost | skipping: Conditional result was False 2026-09-07 03:06:59.152978 | 2026-09-07 03:06:59.153062 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-07 03:06:59.192777 | localhost | skipping: Conditional result was False 2026-09-07 03:06:59.193038 | 2026-09-07 03:06:59.196600 | localhost | skipping: Conditional result was False 2026-09-07 03:06:59.207884 | 2026-09-07 03:06:59.207970 | LOOP [upload-logs : Upload console log and json output]