2026-07-03 03:20:14.717010 | Job console starting 2026-07-03 03:20:14.728188 | Updating git repos 2026-07-03 03:20:14.788879 | Cloning repos into workspace 2026-07-03 03:20:14.842275 | Restoring repo states 2026-07-03 03:20:14.868496 | Merging changes 2026-07-03 03:20:14.868516 | Checking out repos 2026-07-03 03:20:15.080168 | Preparing playbooks 2026-07-03 03:20:16.213083 | Running Ansible setup 2026-07-03 03:20:22.579729 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-03 03:20:23.794999 | 2026-07-03 03:20:23.795140 | PLAY [Base pre] 2026-07-03 03:20:23.821205 | 2026-07-03 03:20:23.821340 | TASK [Setup log path fact] 2026-07-03 03:20:23.863504 | debian-bookworm | ok 2026-07-03 03:20:23.899335 | 2026-07-03 03:20:23.899591 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-03 03:20:23.953429 | debian-bookworm | ok 2026-07-03 03:20:23.964349 | 2026-07-03 03:20:23.964457 | TASK [emit-job-header : Print job information] 2026-07-03 03:20:24.012140 | # Job Information 2026-07-03 03:20:24.012297 | Ansible Version: 2.16.14 2026-07-03 03:20:24.012325 | Job: python-black 2026-07-03 03:20:24.012353 | Pipeline: periodic-daily 2026-07-03 03:20:24.012372 | Executor: 521e9411259a 2026-07-03 03:20:24.012389 | Triggered by: https://github.com/osism/ansible-collection-services 2026-07-03 03:20:24.012406 | Event ID: 9a5f80c1cdb741b99f68c2d3a9570494 2026-07-03 03:20:24.018923 | 2026-07-03 03:20:24.019145 | LOOP [emit-job-header : Print node information] 2026-07-03 03:20:24.201098 | debian-bookworm | ok: 2026-07-03 03:20:24.201331 | debian-bookworm | # Node Information 2026-07-03 03:20:24.201373 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-03 03:20:24.201399 | debian-bookworm | Hostname: debian 2026-07-03 03:20:24.201421 | debian-bookworm | Username: zuul 2026-07-03 03:20:24.201443 | debian-bookworm | Distro: Debian 12.14 2026-07-03 03:20:24.201516 | debian-bookworm | Provider: regiocloud-a 2026-07-03 03:20:24.201545 | debian-bookworm | Region: 2026-07-03 03:20:24.201567 | debian-bookworm | Label: debian-bookworm 2026-07-03 03:20:24.201587 | debian-bookworm | Product Name: OpenStack Nova 2026-07-03 03:20:24.201607 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9f:796 2026-07-03 03:20:24.224971 | 2026-07-03 03:20:24.225093 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-03 03:20:25.213928 | debian-bookworm -> localhost | changed 2026-07-03 03:20:25.221259 | 2026-07-03 03:20:25.221386 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-03 03:20:27.013334 | debian-bookworm -> localhost | changed 2026-07-03 03:20:27.024152 | 2026-07-03 03:20:27.024260 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-03 03:20:27.355730 | debian-bookworm -> localhost | ok 2026-07-03 03:20:27.361959 | 2026-07-03 03:20:27.362060 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-03 03:20:27.402195 | debian-bookworm | ok 2026-07-03 03:20:27.416843 | debian-bookworm | included: /var/lib/zuul/builds/3fb16c8f81704ccd90b7d6a2fd91f2ba/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-03 03:20:27.422571 | 2026-07-03 03:20:27.422656 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-03 03:20:28.881534 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-03 03:20:28.882055 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3fb16c8f81704ccd90b7d6a2fd91f2ba/work/3fb16c8f81704ccd90b7d6a2fd91f2ba_id_rsa 2026-07-03 03:20:28.882103 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3fb16c8f81704ccd90b7d6a2fd91f2ba/work/3fb16c8f81704ccd90b7d6a2fd91f2ba_id_rsa.pub 2026-07-03 03:20:28.882131 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-03 03:20:28.882155 | debian-bookworm -> localhost | SHA256:UPDbVqGGoctrghWtgKbb8UKGzIxB/FnHphEvtK4LXD0 zuul-build-sshkey 2026-07-03 03:20:28.882178 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-03 03:20:28.882210 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-03 03:20:28.882233 | debian-bookworm -> localhost | |.. o+.o . | 2026-07-03 03:20:28.882256 | debian-bookworm -> localhost | |.o .+oB o . . | 2026-07-03 03:20:28.882277 | debian-bookworm -> localhost | |o.o +oO.o o . | 2026-07-03 03:20:28.882297 | debian-bookworm -> localhost | |Bo +o=.o + . | 2026-07-03 03:20:28.882317 | debian-bookworm -> localhost | |+++.oEo S o | 2026-07-03 03:20:28.882341 | debian-bookworm -> localhost | |.=.=. .. . | 2026-07-03 03:20:28.882362 | debian-bookworm -> localhost | |.o+.o o | 2026-07-03 03:20:28.882382 | debian-bookworm -> localhost | | ...o | 2026-07-03 03:20:28.882403 | debian-bookworm -> localhost | | . | 2026-07-03 03:20:28.882423 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-03 03:20:28.882492 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.809348 2026-07-03 03:20:28.891994 | 2026-07-03 03:20:28.892107 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-03 03:20:28.946188 | debian-bookworm | ok 2026-07-03 03:20:28.966476 | debian-bookworm | included: /var/lib/zuul/builds/3fb16c8f81704ccd90b7d6a2fd91f2ba/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-03 03:20:28.995626 | 2026-07-03 03:20:28.995735 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-03 03:20:29.040640 | debian-bookworm | skipping: Conditional result was False 2026-07-03 03:20:29.047191 | 2026-07-03 03:20:29.047297 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-03 03:20:30.083926 | debian-bookworm | changed 2026-07-03 03:20:30.095886 | 2026-07-03 03:20:30.095988 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-03 03:20:30.404507 | debian-bookworm | ok 2026-07-03 03:20:30.416771 | 2026-07-03 03:20:30.416882 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-03 03:20:31.112422 | debian-bookworm | changed 2026-07-03 03:20:31.133194 | 2026-07-03 03:20:31.133635 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-03 03:20:31.878099 | debian-bookworm | changed 2026-07-03 03:20:31.884600 | 2026-07-03 03:20:31.884701 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-03 03:20:31.937063 | debian-bookworm | skipping: Conditional result was False 2026-07-03 03:20:31.945067 | 2026-07-03 03:20:31.945171 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-03 03:20:32.579590 | debian-bookworm -> localhost | changed 2026-07-03 03:20:32.610915 | 2026-07-03 03:20:32.611029 | TASK [add-build-sshkey : Add back temp key] 2026-07-03 03:20:33.036141 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3fb16c8f81704ccd90b7d6a2fd91f2ba/work/3fb16c8f81704ccd90b7d6a2fd91f2ba_id_rsa (zuul-build-sshkey) 2026-07-03 03:20:33.036347 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011652 2026-07-03 03:20:33.042918 | 2026-07-03 03:20:33.043003 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-03 03:20:33.413959 | debian-bookworm | ok 2026-07-03 03:20:33.423744 | 2026-07-03 03:20:33.423844 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-03 03:20:33.456954 | debian-bookworm | skipping: Conditional result was False 2026-07-03 03:20:33.470629 | 2026-07-03 03:20:33.470734 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-03 03:20:34.047930 | debian-bookworm | ok 2026-07-03 03:20:34.085304 | 2026-07-03 03:20:34.085424 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-03 03:20:34.145163 | debian-bookworm | ok 2026-07-03 03:20:34.151541 | 2026-07-03 03:20:34.151632 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-03 03:20:34.789823 | debian-bookworm -> localhost | ok 2026-07-03 03:20:34.796353 | 2026-07-03 03:20:34.796452 | TASK [validate-host : Collect information about the host] 2026-07-03 03:20:36.419837 | debian-bookworm | ok 2026-07-03 03:20:36.435727 | 2026-07-03 03:20:36.435817 | TASK [validate-host : Sanitize hostname] 2026-07-03 03:20:36.648619 | debian-bookworm | ok 2026-07-03 03:20:36.655760 | 2026-07-03 03:20:36.655872 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-03 03:20:37.549612 | debian-bookworm -> localhost | changed 2026-07-03 03:20:37.570615 | 2026-07-03 03:20:37.570959 | TASK [validate-host : Collect information about zuul worker] 2026-07-03 03:20:38.055780 | debian-bookworm | ok 2026-07-03 03:20:38.060504 | 2026-07-03 03:20:38.060605 | TASK [validate-host : Write out all zuul information for each host] 2026-07-03 03:20:38.613428 | debian-bookworm -> localhost | changed 2026-07-03 03:20:38.622977 | 2026-07-03 03:20:38.623073 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-03 03:20:38.866057 | debian-bookworm | ok 2026-07-03 03:20:38.872253 | 2026-07-03 03:20:38.872357 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-03 03:20:39.978588 | debian-bookworm | changed: 2026-07-03 03:20:39.978816 | debian-bookworm | cd+++++++++ src/ 2026-07-03 03:20:39.978872 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-03 03:20:39.978897 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-03 03:20:39.978919 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2026-07-03 03:20:39.978941 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/3fb16c8f81704ccd90b7d6a2fd91f2ba/work/logs" 2026-07-03 03:21:42.763132 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3fb16c8f81704ccd90b7d6a2fd91f2ba/work/artifacts" 2026-07-03 03:21:43.074712 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3fb16c8f81704ccd90b7d6a2fd91f2ba/work/docs" 2026-07-03 03:21:43.086611 | 2026-07-03 03:21:43.086750 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-03 03:21:43.909819 | debian-bookworm | changed: 2026-07-03 03:21:43.910107 | debian-bookworm | .d..t...... ./ 2026-07-03 03:21:43.910144 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-03 03:21:43.910168 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-03 03:21:43.910190 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-03 03:21:43.910212 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-03 03:21:43.910233 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-03 03:21:43.910275 | debian-bookworm | changed: All items complete 2026-07-03 03:21:43.910300 | 2026-07-03 03:21:44.797703 | debian-bookworm | changed: .d..t...... ./ 2026-07-03 03:21:46.080572 | debian-bookworm | changed: .d..t...... ./ 2026-07-03 03:21:46.118999 | 2026-07-03 03:21:46.119259 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-03 03:21:46.208446 | debian-bookworm | skipping: Conditional result was False 2026-07-03 03:21:46.239856 | debian-bookworm | skipping: Conditional result was False 2026-07-03 03:21:46.263410 | 2026-07-03 03:21:46.263571 | PLAY RECAP 2026-07-03 03:21:46.263630 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-03 03:21:46.263655 | 2026-07-03 03:21:46.531801 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-03 03:21:46.533224 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-03 03:21:47.610218 | 2026-07-03 03:21:47.614698 | PLAY [Base post] 2026-07-03 03:21:47.636844 | 2026-07-03 03:21:47.636965 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-03 03:21:48.272512 | debian-bookworm | changed 2026-07-03 03:21:48.281253 | 2026-07-03 03:21:48.281354 | PLAY RECAP 2026-07-03 03:21:48.281420 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-03 03:21:48.281494 | 2026-07-03 03:21:48.424582 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-03 03:21:48.425373 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-03 03:21:49.148415 | 2026-07-03 03:21:49.148593 | PLAY [Base post-logs] 2026-07-03 03:21:49.158886 | 2026-07-03 03:21:49.159014 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-03 03:21:49.700243 | localhost | changed 2026-07-03 03:21:49.710711 | 2026-07-03 03:21:49.710878 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-03 03:21:49.751981 | localhost | ok 2026-07-03 03:21:49.755188 | 2026-07-03 03:21:49.755285 | TASK [Set zuul-log-path fact] 2026-07-03 03:21:49.782023 | localhost | ok 2026-07-03 03:21:49.795770 | 2026-07-03 03:21:49.795962 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-03 03:21:49.824175 | localhost | ok 2026-07-03 03:21:49.828921 | 2026-07-03 03:21:49.829050 | TASK [upload-logs : Create log directories] 2026-07-03 03:21:50.617031 | localhost | changed 2026-07-03 03:21:50.619832 | 2026-07-03 03:21:50.619936 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-03 03:21:51.232541 | localhost -> localhost | ok: Runtime: 0:00:00.003590 2026-07-03 03:21:51.236480 | 2026-07-03 03:21:51.236590 | TASK [upload-logs : Upload logs to log server] 2026-07-03 03:21:51.899396 | localhost | Output suppressed because no_log was given 2026-07-03 03:21:51.900880 | 2026-07-03 03:21:51.900956 | LOOP [upload-logs : Compress console log and json output] 2026-07-03 03:21:51.963411 | localhost | skipping: Conditional result was False 2026-07-03 03:21:51.979169 | localhost | skipping: Conditional result was False 2026-07-03 03:21:51.986747 | 2026-07-03 03:21:51.986859 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-03 03:21:52.104356 | localhost | skipping: Conditional result was False 2026-07-03 03:21:52.104630 | 2026-07-03 03:21:52.111000 | localhost | skipping: Conditional result was False 2026-07-03 03:21:52.125429 | 2026-07-03 03:21:52.125543 | LOOP [upload-logs : Upload console log and json output]