2026-08-12 03:19:13.310043 | Job console starting 2026-08-12 03:19:13.323590 | Updating git repos 2026-08-12 03:19:13.374562 | Cloning repos into workspace 2026-08-12 03:19:13.469326 | Restoring repo states 2026-08-12 03:19:13.485427 | Merging changes 2026-08-12 03:19:13.485455 | Checking out repos 2026-08-12 03:19:13.536239 | Preparing playbooks 2026-08-12 03:19:14.701647 | Running Ansible setup 2026-08-12 03:19:19.730156 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-12 03:19:20.751288 | 2026-08-12 03:19:20.751541 | PLAY [Base pre] 2026-08-12 03:19:20.780415 | 2026-08-12 03:19:20.780586 | TASK [Setup log path fact] 2026-08-12 03:19:20.812391 | debian-bookworm | ok 2026-08-12 03:19:20.847462 | 2026-08-12 03:19:20.850037 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-12 03:19:20.892490 | debian-bookworm | ok 2026-08-12 03:19:20.905381 | 2026-08-12 03:19:20.905530 | TASK [emit-job-header : Print job information] 2026-08-12 03:19:20.956757 | # Job Information 2026-08-12 03:19:20.957023 | Ansible Version: 2.16.14 2026-08-12 03:19:20.957060 | Job: python-black 2026-08-12 03:19:20.957094 | Pipeline: periodic-daily 2026-08-12 03:19:20.957117 | Executor: 521e9411259a 2026-08-12 03:19:20.957138 | Triggered by: https://github.com/osism/openstack-image-manager 2026-08-12 03:19:20.957160 | Event ID: 9a5907dedfc240b387d407910f26d1f9 2026-08-12 03:19:20.963476 | 2026-08-12 03:19:20.963604 | LOOP [emit-job-header : Print node information] 2026-08-12 03:19:21.096489 | debian-bookworm | ok: 2026-08-12 03:19:21.096721 | debian-bookworm | # Node Information 2026-08-12 03:19:21.096756 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-12 03:19:21.096781 | debian-bookworm | Hostname: debian 2026-08-12 03:19:21.096822 | debian-bookworm | Username: zuul 2026-08-12 03:19:21.096844 | debian-bookworm | Distro: Debian 12.15 2026-08-12 03:19:21.096868 | debian-bookworm | Provider: regiocloud-a 2026-08-12 03:19:21.096889 | debian-bookworm | Region: 2026-08-12 03:19:21.096909 | debian-bookworm | Label: debian-bookworm 2026-08-12 03:19:21.096929 | debian-bookworm | Product Name: OpenStack Nova 2026-08-12 03:19:21.096947 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef9:e51e 2026-08-12 03:19:21.122102 | 2026-08-12 03:19:21.122272 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-12 03:19:21.749236 | debian-bookworm -> localhost | changed 2026-08-12 03:19:21.760548 | 2026-08-12 03:19:21.760691 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-12 03:19:23.233206 | debian-bookworm -> localhost | changed 2026-08-12 03:19:23.259164 | 2026-08-12 03:19:23.259419 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-12 03:19:23.651468 | debian-bookworm -> localhost | ok 2026-08-12 03:19:23.658412 | 2026-08-12 03:19:23.658552 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-12 03:19:23.693633 | debian-bookworm | ok 2026-08-12 03:19:23.711597 | debian-bookworm | included: /var/lib/zuul/builds/5449218117f74e818391c64e34d5dc34/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-12 03:19:23.718462 | 2026-08-12 03:19:23.718579 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-12 03:19:25.309122 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-12 03:19:25.309411 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5449218117f74e818391c64e34d5dc34/work/5449218117f74e818391c64e34d5dc34_id_rsa 2026-08-12 03:19:25.309519 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5449218117f74e818391c64e34d5dc34/work/5449218117f74e818391c64e34d5dc34_id_rsa.pub 2026-08-12 03:19:25.309547 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-12 03:19:25.309572 | debian-bookworm -> localhost | SHA256:h0tCXSVSdKaYnlQ80FbK5/Nw0Xpemkr8pZGL/4QqsAs zuul-build-sshkey 2026-08-12 03:19:25.309594 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-12 03:19:25.309720 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-12 03:19:25.309746 | debian-bookworm -> localhost | | o**o= | 2026-08-12 03:19:25.309768 | debian-bookworm -> localhost | | . B=* . | 2026-08-12 03:19:25.309789 | debian-bookworm -> localhost | | . =.+.. . .| 2026-08-12 03:19:25.309826 | debian-bookworm -> localhost | | . o o o o | 2026-08-12 03:19:25.309847 | debian-bookworm -> localhost | | . S . + o o| 2026-08-12 03:19:25.309875 | debian-bookworm -> localhost | | o.o . = B.| 2026-08-12 03:19:25.309896 | debian-bookworm -> localhost | | E .o o B +| 2026-08-12 03:19:25.309917 | debian-bookworm -> localhost | | .. .. = * | 2026-08-12 03:19:25.309938 | debian-bookworm -> localhost | | .. .+.=..| 2026-08-12 03:19:25.309958 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-12 03:19:25.310023 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.785160 2026-08-12 03:19:25.318641 | 2026-08-12 03:19:25.322983 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-12 03:19:25.368594 | debian-bookworm | ok 2026-08-12 03:19:25.399851 | debian-bookworm | included: /var/lib/zuul/builds/5449218117f74e818391c64e34d5dc34/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-12 03:19:25.426161 | 2026-08-12 03:19:25.426314 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-12 03:19:25.489132 | debian-bookworm | skipping: Conditional result was False 2026-08-12 03:19:25.499726 | 2026-08-12 03:19:25.499907 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-12 03:19:26.274074 | debian-bookworm | changed 2026-08-12 03:19:26.287764 | 2026-08-12 03:19:26.287974 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-12 03:19:26.569028 | debian-bookworm | ok 2026-08-12 03:19:26.587839 | 2026-08-12 03:19:26.596210 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-12 03:19:27.325407 | debian-bookworm | changed 2026-08-12 03:19:27.346479 | 2026-08-12 03:19:27.346646 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-12 03:19:28.068200 | debian-bookworm | changed 2026-08-12 03:19:28.074245 | 2026-08-12 03:19:28.074370 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-12 03:19:28.100941 | debian-bookworm | skipping: Conditional result was False 2026-08-12 03:19:28.112001 | 2026-08-12 03:19:28.112192 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-12 03:19:28.817659 | debian-bookworm -> localhost | changed 2026-08-12 03:19:28.835571 | 2026-08-12 03:19:28.835707 | TASK [add-build-sshkey : Add back temp key] 2026-08-12 03:19:29.373003 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5449218117f74e818391c64e34d5dc34/work/5449218117f74e818391c64e34d5dc34_id_rsa (zuul-build-sshkey) 2026-08-12 03:19:29.373340 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016638 2026-08-12 03:19:29.382172 | 2026-08-12 03:19:29.382415 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-12 03:19:29.920119 | debian-bookworm | ok 2026-08-12 03:19:29.930014 | 2026-08-12 03:19:29.930137 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-12 03:19:29.964097 | debian-bookworm | skipping: Conditional result was False 2026-08-12 03:19:29.978433 | 2026-08-12 03:19:29.978573 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-12 03:19:30.466703 | debian-bookworm | ok 2026-08-12 03:19:30.482452 | 2026-08-12 03:19:30.482635 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-12 03:19:30.526449 | debian-bookworm | ok 2026-08-12 03:19:30.540777 | 2026-08-12 03:19:30.541041 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-12 03:19:30.837003 | debian-bookworm -> localhost | ok 2026-08-12 03:19:30.852409 | 2026-08-12 03:19:30.852602 | TASK [validate-host : Collect information about the host] 2026-08-12 03:19:32.053478 | debian-bookworm | ok 2026-08-12 03:19:32.066463 | 2026-08-12 03:19:32.066601 | TASK [validate-host : Sanitize hostname] 2026-08-12 03:19:32.246191 | debian-bookworm | ok 2026-08-12 03:19:32.251286 | 2026-08-12 03:19:32.251481 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-12 03:19:32.871712 | debian-bookworm -> localhost | changed 2026-08-12 03:19:32.896583 | 2026-08-12 03:19:32.896762 | TASK [validate-host : Collect information about zuul worker] 2026-08-12 03:19:33.315531 | debian-bookworm | ok 2026-08-12 03:19:33.321687 | 2026-08-12 03:19:33.321846 | TASK [validate-host : Write out all zuul information for each host] 2026-08-12 03:19:33.940589 | debian-bookworm -> localhost | changed 2026-08-12 03:19:33.968584 | 2026-08-12 03:19:33.968746 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-12 03:19:34.243607 | debian-bookworm | ok 2026-08-12 03:19:34.253215 | 2026-08-12 03:19:34.253350 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-12 03:19:35.388979 | debian-bookworm | changed: 2026-08-12 03:19:35.389211 | debian-bookworm | cd+++++++++ src/ 2026-08-12 03:19:35.389247 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-12 03:19:35.389272 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-12 03:19:35.389293 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-08-12 03:19:35.389314 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/5449218117f74e818391c64e34d5dc34/work/logs" 2026-08-12 03:20:36.198172 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5449218117f74e818391c64e34d5dc34/work/artifacts" 2026-08-12 03:20:36.485138 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5449218117f74e818391c64e34d5dc34/work/docs" 2026-08-12 03:20:36.504367 | 2026-08-12 03:20:36.504529 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-12 03:20:37.484005 | debian-bookworm | changed: 2026-08-12 03:20:37.484507 | debian-bookworm | .d..t...... ./ 2026-08-12 03:20:37.484606 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-12 03:20:37.484679 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-12 03:20:37.484741 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-12 03:20:37.484876 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-12 03:20:37.484942 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-12 03:20:37.485049 | debian-bookworm | changed: All items complete 2026-08-12 03:20:37.485114 | 2026-08-12 03:20:38.113193 | debian-bookworm | changed: .d..t...... ./ 2026-08-12 03:20:38.808288 | debian-bookworm | changed: .d..t...... ./ 2026-08-12 03:20:38.832669 | 2026-08-12 03:20:38.832873 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-12 03:20:38.874735 | debian-bookworm | skipping: Conditional result was False 2026-08-12 03:20:38.888244 | debian-bookworm | skipping: Conditional result was False 2026-08-12 03:20:38.908000 | 2026-08-12 03:20:38.908157 | PLAY RECAP 2026-08-12 03:20:38.908238 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-12 03:20:38.908274 | 2026-08-12 03:20:39.086382 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-12 03:20:39.088452 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-12 03:20:39.858154 | 2026-08-12 03:20:39.858364 | PLAY [Base post] 2026-08-12 03:20:39.874227 | 2026-08-12 03:20:39.874406 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-12 03:20:40.451482 | debian-bookworm | changed 2026-08-12 03:20:40.458206 | 2026-08-12 03:20:40.458333 | PLAY RECAP 2026-08-12 03:20:40.458400 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-12 03:20:40.458460 | 2026-08-12 03:20:40.607468 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-12 03:20:40.608852 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-12 03:20:41.568200 | 2026-08-12 03:20:41.568414 | PLAY [Base post-logs] 2026-08-12 03:20:41.580629 | 2026-08-12 03:20:41.580826 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-12 03:20:42.092132 | localhost | changed 2026-08-12 03:20:42.104996 | 2026-08-12 03:20:42.105159 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-12 03:20:42.141250 | localhost | ok 2026-08-12 03:20:42.144801 | 2026-08-12 03:20:42.144916 | TASK [Set zuul-log-path fact] 2026-08-12 03:20:42.174031 | localhost | ok 2026-08-12 03:20:42.190312 | 2026-08-12 03:20:42.190465 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-12 03:20:42.229881 | localhost | ok 2026-08-12 03:20:42.236312 | 2026-08-12 03:20:42.236486 | TASK [upload-logs : Create log directories] 2026-08-12 03:20:42.847541 | localhost | changed 2026-08-12 03:20:42.850653 | 2026-08-12 03:20:42.850807 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-12 03:20:43.415878 | localhost -> localhost | ok: Runtime: 0:00:00.005150 2026-08-12 03:20:43.420708 | 2026-08-12 03:20:43.420867 | TASK [upload-logs : Upload logs to log server] 2026-08-12 03:20:44.011931 | localhost | Output suppressed because no_log was given 2026-08-12 03:20:44.013975 | 2026-08-12 03:20:44.014077 | LOOP [upload-logs : Compress console log and json output] 2026-08-12 03:20:44.085660 | localhost | skipping: Conditional result was False 2026-08-12 03:20:44.092640 | localhost | skipping: Conditional result was False 2026-08-12 03:20:44.096829 | 2026-08-12 03:20:44.096981 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-12 03:20:44.157665 | localhost | skipping: Conditional result was False 2026-08-12 03:20:44.158030 | 2026-08-12 03:20:44.165643 | localhost | skipping: Conditional result was False 2026-08-12 03:20:44.177198 | 2026-08-12 03:20:44.177347 | LOOP [upload-logs : Upload console log and json output]