2026-07-13 03:26:09.403632 | Job console starting 2026-07-13 03:26:09.418376 | Updating git repos 2026-07-13 03:26:09.468734 | Cloning repos into workspace 2026-07-13 03:26:09.633713 | Restoring repo states 2026-07-13 03:26:09.656654 | Merging changes 2026-07-13 03:26:09.656676 | Checking out repos 2026-07-13 03:26:09.875115 | Preparing playbooks 2026-07-13 03:26:11.319058 | Running Ansible setup 2026-07-13 03:26:17.406106 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-13 03:26:18.362663 | 2026-07-13 03:26:18.374456 | PLAY [Base pre] 2026-07-13 03:26:18.405063 | 2026-07-13 03:26:18.405279 | TASK [Setup log path fact] 2026-07-13 03:26:18.445882 | debian-bookworm | ok 2026-07-13 03:26:18.462944 | 2026-07-13 03:26:18.463133 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-13 03:26:18.493598 | debian-bookworm | ok 2026-07-13 03:26:18.504781 | 2026-07-13 03:26:18.504925 | TASK [emit-job-header : Print job information] 2026-07-13 03:26:18.548048 | # Job Information 2026-07-13 03:26:18.548306 | Ansible Version: 2.16.14 2026-07-13 03:26:18.548348 | Job: python-black 2026-07-13 03:26:18.548382 | Pipeline: periodic-daily 2026-07-13 03:26:18.548405 | Executor: 521e9411259a 2026-07-13 03:26:18.548426 | Triggered by: https://github.com/osism/testbed 2026-07-13 03:26:18.548447 | Event ID: 7979bfe02e1b4d07bc35ced6e631cc5c 2026-07-13 03:26:18.553761 | 2026-07-13 03:26:18.553872 | LOOP [emit-job-header : Print node information] 2026-07-13 03:26:18.672946 | debian-bookworm | ok: 2026-07-13 03:26:18.673322 | debian-bookworm | # Node Information 2026-07-13 03:26:18.673376 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-13 03:26:18.673403 | debian-bookworm | Hostname: debian 2026-07-13 03:26:18.673427 | debian-bookworm | Username: zuul 2026-07-13 03:26:18.673449 | debian-bookworm | Distro: Debian 12.15 2026-07-13 03:26:18.673473 | debian-bookworm | Provider: regiocloud-a 2026-07-13 03:26:18.673494 | debian-bookworm | Region: 2026-07-13 03:26:18.673516 | debian-bookworm | Label: debian-bookworm 2026-07-13 03:26:18.673536 | debian-bookworm | Product Name: OpenStack Nova 2026-07-13 03:26:18.673556 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef8:3a7c 2026-07-13 03:26:18.693351 | 2026-07-13 03:26:18.693510 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-13 03:26:19.248554 | debian-bookworm -> localhost | changed 2026-07-13 03:26:19.263702 | 2026-07-13 03:26:19.263880 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-13 03:26:20.786631 | debian-bookworm -> localhost | changed 2026-07-13 03:26:20.801518 | 2026-07-13 03:26:20.801677 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-13 03:26:21.075826 | debian-bookworm -> localhost | ok 2026-07-13 03:26:21.087087 | 2026-07-13 03:26:21.087253 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-13 03:26:21.119509 | debian-bookworm | ok 2026-07-13 03:26:21.147815 | debian-bookworm | included: /var/lib/zuul/builds/40773129ab634b7b8e47f1108272b332/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-13 03:26:21.156390 | 2026-07-13 03:26:21.156523 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-13 03:26:22.710848 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-13 03:26:22.712178 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/40773129ab634b7b8e47f1108272b332/work/40773129ab634b7b8e47f1108272b332_id_rsa 2026-07-13 03:26:22.712522 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/40773129ab634b7b8e47f1108272b332/work/40773129ab634b7b8e47f1108272b332_id_rsa.pub 2026-07-13 03:26:22.712563 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-13 03:26:22.712590 | debian-bookworm -> localhost | SHA256:/p8L/M+/QdonVgBVmochrsNk6wIY5UZoggHMbkmaqk4 zuul-build-sshkey 2026-07-13 03:26:22.712615 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-13 03:26:22.712649 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-13 03:26:22.712672 | debian-bookworm -> localhost | |*o .o o.o..| 2026-07-13 03:26:22.712694 | debian-bookworm -> localhost | |.+. o+ . o = | 2026-07-13 03:26:22.712715 | debian-bookworm -> localhost | |+..o. o o . = .| 2026-07-13 03:26:22.712735 | debian-bookworm -> localhost | |o+ + + o o | 2026-07-13 03:26:22.712755 | debian-bookworm -> localhost | |o . . S = ..| 2026-07-13 03:26:22.712788 | debian-bookworm -> localhost | |. o o . +. | 2026-07-13 03:26:22.712809 | debian-bookworm -> localhost | |.E o + .oo.| 2026-07-13 03:26:22.712829 | debian-bookworm -> localhost | |o o o + .o| 2026-07-13 03:26:22.712850 | debian-bookworm -> localhost | |.. ..=oooo| 2026-07-13 03:26:22.712871 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-13 03:26:22.712931 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.722576 2026-07-13 03:26:22.733932 | 2026-07-13 03:26:22.735680 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-13 03:26:22.803907 | debian-bookworm | ok 2026-07-13 03:26:22.839958 | debian-bookworm | included: /var/lib/zuul/builds/40773129ab634b7b8e47f1108272b332/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-13 03:26:22.849448 | 2026-07-13 03:26:22.849605 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-13 03:26:22.923937 | debian-bookworm | skipping: Conditional result was False 2026-07-13 03:26:22.933087 | 2026-07-13 03:26:22.933263 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-13 03:26:23.968066 | debian-bookworm | changed 2026-07-13 03:26:23.978984 | 2026-07-13 03:26:23.979141 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-13 03:26:24.247665 | debian-bookworm | ok 2026-07-13 03:26:24.256594 | 2026-07-13 03:26:24.256737 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-13 03:26:24.929478 | debian-bookworm | changed 2026-07-13 03:26:24.936591 | 2026-07-13 03:26:24.936732 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-13 03:26:25.660174 | debian-bookworm | changed 2026-07-13 03:26:25.666938 | 2026-07-13 03:26:25.667065 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-13 03:26:25.693490 | debian-bookworm | skipping: Conditional result was False 2026-07-13 03:26:25.701623 | 2026-07-13 03:26:25.701770 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-13 03:26:26.551253 | debian-bookworm -> localhost | changed 2026-07-13 03:26:26.563252 | 2026-07-13 03:26:26.563408 | TASK [add-build-sshkey : Add back temp key] 2026-07-13 03:26:26.974801 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/40773129ab634b7b8e47f1108272b332/work/40773129ab634b7b8e47f1108272b332_id_rsa (zuul-build-sshkey) 2026-07-13 03:26:26.975431 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021124 2026-07-13 03:26:26.991303 | 2026-07-13 03:26:26.991433 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-13 03:26:27.459569 | debian-bookworm | ok 2026-07-13 03:26:27.468932 | 2026-07-13 03:26:27.469080 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-13 03:26:27.516404 | debian-bookworm | skipping: Conditional result was False 2026-07-13 03:26:27.539116 | 2026-07-13 03:26:27.539427 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-13 03:26:28.012480 | debian-bookworm | ok 2026-07-13 03:26:28.027028 | 2026-07-13 03:26:28.027373 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-13 03:26:28.057641 | debian-bookworm | ok 2026-07-13 03:26:28.063726 | 2026-07-13 03:26:28.063830 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-13 03:26:28.371650 | debian-bookworm -> localhost | ok 2026-07-13 03:26:28.379046 | 2026-07-13 03:26:28.379161 | TASK [validate-host : Collect information about the host] 2026-07-13 03:26:29.644795 | debian-bookworm | ok 2026-07-13 03:26:29.664412 | 2026-07-13 03:26:29.664630 | TASK [validate-host : Sanitize hostname] 2026-07-13 03:26:29.821150 | debian-bookworm | ok 2026-07-13 03:26:29.826256 | 2026-07-13 03:26:29.826386 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-13 03:26:30.374871 | debian-bookworm -> localhost | changed 2026-07-13 03:26:30.381534 | 2026-07-13 03:26:30.381651 | TASK [validate-host : Collect information about zuul worker] 2026-07-13 03:26:30.816890 | debian-bookworm | ok 2026-07-13 03:26:30.828066 | 2026-07-13 03:26:30.828196 | TASK [validate-host : Write out all zuul information for each host] 2026-07-13 03:26:31.444893 | debian-bookworm -> localhost | changed 2026-07-13 03:26:31.455960 | 2026-07-13 03:26:31.456102 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-13 03:26:31.750348 | debian-bookworm | ok 2026-07-13 03:26:31.771794 | 2026-07-13 03:26:31.771963 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-13 03:26:33.410117 | debian-bookworm | changed: 2026-07-13 03:26:33.410370 | debian-bookworm | cd+++++++++ src/ 2026-07-13 03:26:33.410409 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-13 03:26:33.410434 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-13 03:26:33.410457 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-07-13 03:26:33.410480 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/40773129ab634b7b8e47f1108272b332/work/logs" 2026-07-13 03:27:36.891836 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/40773129ab634b7b8e47f1108272b332/work/artifacts" 2026-07-13 03:27:37.207773 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/40773129ab634b7b8e47f1108272b332/work/docs" 2026-07-13 03:27:37.220394 | 2026-07-13 03:27:37.220564 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-13 03:27:38.040826 | debian-bookworm | changed: 2026-07-13 03:27:38.041150 | debian-bookworm | .d..t...... ./ 2026-07-13 03:27:38.041201 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-13 03:27:38.041226 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-13 03:27:38.041248 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-13 03:27:38.041272 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-13 03:27:38.041293 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-13 03:27:38.041339 | debian-bookworm | changed: All items complete 2026-07-13 03:27:38.041362 | 2026-07-13 03:27:38.663455 | debian-bookworm | changed: .d..t...... ./ 2026-07-13 03:27:39.213676 | debian-bookworm | changed: .d..t...... ./ 2026-07-13 03:27:39.229479 | 2026-07-13 03:27:39.229622 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-13 03:27:39.256456 | debian-bookworm | skipping: Conditional result was False 2026-07-13 03:27:39.260250 | debian-bookworm | skipping: Conditional result was False 2026-07-13 03:27:39.272113 | 2026-07-13 03:27:39.272207 | PLAY RECAP 2026-07-13 03:27:39.272261 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-13 03:27:39.272285 | 2026-07-13 03:27:39.432901 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-13 03:27:39.433850 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-13 03:27:40.261853 | 2026-07-13 03:27:40.262031 | PLAY [Base post] 2026-07-13 03:27:40.276340 | 2026-07-13 03:27:40.276476 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-13 03:27:40.894151 | debian-bookworm | changed 2026-07-13 03:27:40.904531 | 2026-07-13 03:27:40.904667 | PLAY RECAP 2026-07-13 03:27:40.904743 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-13 03:27:40.904817 | 2026-07-13 03:27:41.052775 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-13 03:27:41.055149 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-13 03:27:41.906817 | 2026-07-13 03:27:41.907039 | PLAY [Base post-logs] 2026-07-13 03:27:41.918738 | 2026-07-13 03:27:41.918982 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-13 03:27:42.405326 | localhost | changed 2026-07-13 03:27:42.422535 | 2026-07-13 03:27:42.422724 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-13 03:27:42.462642 | localhost | ok 2026-07-13 03:27:42.469708 | 2026-07-13 03:27:42.469885 | TASK [Set zuul-log-path fact] 2026-07-13 03:27:42.488307 | localhost | ok 2026-07-13 03:27:42.500002 | 2026-07-13 03:27:42.500145 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-13 03:27:42.538110 | localhost | ok 2026-07-13 03:27:42.546431 | 2026-07-13 03:27:42.546673 | TASK [upload-logs : Create log directories] 2026-07-13 03:27:43.112018 | localhost | changed 2026-07-13 03:27:43.115209 | 2026-07-13 03:27:43.115334 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-13 03:27:43.681517 | localhost -> localhost | ok: Runtime: 0:00:00.008903 2026-07-13 03:27:43.690936 | 2026-07-13 03:27:43.691160 | TASK [upload-logs : Upload logs to log server] 2026-07-13 03:27:44.301968 | localhost | Output suppressed because no_log was given 2026-07-13 03:27:44.306169 | 2026-07-13 03:27:44.306357 | LOOP [upload-logs : Compress console log and json output] 2026-07-13 03:27:44.365347 | localhost | skipping: Conditional result was False 2026-07-13 03:27:44.371178 | localhost | skipping: Conditional result was False 2026-07-13 03:27:44.378752 | 2026-07-13 03:27:44.378901 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-13 03:27:44.448686 | localhost | skipping: Conditional result was False 2026-07-13 03:27:44.449376 | 2026-07-13 03:27:44.453993 | localhost | skipping: Conditional result was False 2026-07-13 03:27:44.470930 | 2026-07-13 03:27:44.471298 | LOOP [upload-logs : Upload console log and json output]