2026-08-02 03:01:44.284894 | Job console starting 2026-08-02 03:01:44.301750 | Updating git repos 2026-08-02 03:01:44.323674 | Cloning repos into workspace 2026-08-02 03:01:44.364301 | Restoring repo states 2026-08-02 03:01:44.376193 | Merging changes 2026-08-02 03:01:44.376240 | Checking out repos 2026-08-02 03:01:44.456323 | Preparing playbooks 2026-08-02 03:01:45.472786 | Running Ansible setup 2026-08-02 03:01:54.845462 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-02 03:01:56.735656 | 2026-08-02 03:01:56.735842 | PLAY [Base pre] 2026-08-02 03:01:56.789794 | 2026-08-02 03:01:56.789939 | TASK [Setup log path fact] 2026-08-02 03:01:56.840397 | debian-bookworm | ok 2026-08-02 03:01:56.882868 | 2026-08-02 03:01:56.883027 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-02 03:01:56.967253 | debian-bookworm | ok 2026-08-02 03:01:56.998377 | 2026-08-02 03:01:56.998493 | TASK [emit-job-header : Print job information] 2026-08-02 03:01:57.046914 | # Job Information 2026-08-02 03:01:57.047132 | Ansible Version: 2.16.14 2026-08-02 03:01:57.047164 | Job: python-black 2026-08-02 03:01:57.047197 | Pipeline: periodic-daily 2026-08-02 03:01:57.047217 | Executor: 521e9411259a 2026-08-02 03:01:57.047234 | Triggered by: https://github.com/osism/ansible-collection-validations 2026-08-02 03:01:57.047252 | Event ID: 6fa73b50b99a4c3fa970e519b950fdfd 2026-08-02 03:01:57.051779 | 2026-08-02 03:01:57.051872 | LOOP [emit-job-header : Print node information] 2026-08-02 03:01:57.248829 | debian-bookworm | ok: 2026-08-02 03:01:57.253018 | debian-bookworm | # Node Information 2026-08-02 03:01:57.253115 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-02 03:01:57.253146 | debian-bookworm | Hostname: debian 2026-08-02 03:01:57.253171 | debian-bookworm | Username: zuul 2026-08-02 03:01:57.253195 | debian-bookworm | Distro: Debian 12.15 2026-08-02 03:01:57.253239 | debian-bookworm | Provider: regiocloud-a 2026-08-02 03:01:57.253262 | debian-bookworm | Region: 2026-08-02 03:01:57.253285 | debian-bookworm | Label: debian-bookworm 2026-08-02 03:01:57.253305 | debian-bookworm | Product Name: OpenStack Nova 2026-08-02 03:01:57.253325 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee0:7d2a 2026-08-02 03:01:57.268140 | 2026-08-02 03:01:57.268254 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-02 03:01:58.433271 | debian-bookworm -> localhost | changed 2026-08-02 03:01:58.442325 | 2026-08-02 03:01:58.442443 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-02 03:02:01.092408 | debian-bookworm -> localhost | changed 2026-08-02 03:02:01.103001 | 2026-08-02 03:02:01.103097 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-02 03:02:01.890733 | debian-bookworm -> localhost | ok 2026-08-02 03:02:01.895855 | 2026-08-02 03:02:01.895949 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-02 03:02:01.945126 | debian-bookworm | ok 2026-08-02 03:02:01.978574 | debian-bookworm | included: /var/lib/zuul/builds/c78d6bc4bfab4e7fa255fcc556da64ec/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-02 03:02:01.999666 | 2026-08-02 03:02:01.999767 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-02 03:02:06.305633 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-02 03:02:06.305833 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c78d6bc4bfab4e7fa255fcc556da64ec/work/c78d6bc4bfab4e7fa255fcc556da64ec_id_rsa 2026-08-02 03:02:06.305866 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c78d6bc4bfab4e7fa255fcc556da64ec/work/c78d6bc4bfab4e7fa255fcc556da64ec_id_rsa.pub 2026-08-02 03:02:06.305889 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-02 03:02:06.305909 | debian-bookworm -> localhost | SHA256:iHRZ03hcyR9BWf2n20VF+fJFkfFFlDNYsbgeKk0E2T4 zuul-build-sshkey 2026-08-02 03:02:06.305928 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-02 03:02:06.305954 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-02 03:02:06.305973 | debian-bookworm -> localhost | | o=oo.o=%#| 2026-08-02 03:02:06.305990 | debian-bookworm -> localhost | | o.o=.o.+*B| 2026-08-02 03:02:06.306006 | debian-bookworm -> localhost | | . o ... o +B| 2026-08-02 03:02:06.306022 | debian-bookworm -> localhost | | . o . .E + *| 2026-08-02 03:02:06.306038 | debian-bookworm -> localhost | | . . S ..o =o| 2026-08-02 03:02:06.306056 | debian-bookworm -> localhost | | o o o o| 2026-08-02 03:02:06.306072 | debian-bookworm -> localhost | | . o . o.| 2026-08-02 03:02:06.306088 | debian-bookworm -> localhost | | . . .| 2026-08-02 03:02:06.306104 | debian-bookworm -> localhost | | | 2026-08-02 03:02:06.306120 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-02 03:02:06.306169 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.264724 2026-08-02 03:02:06.313322 | 2026-08-02 03:02:06.313436 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-02 03:02:06.345181 | debian-bookworm | ok 2026-08-02 03:02:06.357102 | debian-bookworm | included: /var/lib/zuul/builds/c78d6bc4bfab4e7fa255fcc556da64ec/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-02 03:02:06.364473 | 2026-08-02 03:02:06.364544 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-02 03:02:06.378377 | debian-bookworm | skipping: Conditional result was False 2026-08-02 03:02:06.383347 | 2026-08-02 03:02:06.383541 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-02 03:02:07.464434 | debian-bookworm | changed 2026-08-02 03:02:07.470247 | 2026-08-02 03:02:07.470335 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-02 03:02:07.832053 | debian-bookworm | ok 2026-08-02 03:02:07.837208 | 2026-08-02 03:02:07.837298 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-02 03:02:08.703976 | debian-bookworm | changed 2026-08-02 03:02:08.712701 | 2026-08-02 03:02:08.712817 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-02 03:02:09.557279 | debian-bookworm | changed 2026-08-02 03:02:09.562076 | 2026-08-02 03:02:09.562159 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-02 03:02:09.616566 | debian-bookworm | skipping: Conditional result was False 2026-08-02 03:02:09.622727 | 2026-08-02 03:02:09.622997 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-02 03:02:10.963422 | debian-bookworm -> localhost | changed 2026-08-02 03:02:10.973272 | 2026-08-02 03:02:10.973375 | TASK [add-build-sshkey : Add back temp key] 2026-08-02 03:02:12.571470 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c78d6bc4bfab4e7fa255fcc556da64ec/work/c78d6bc4bfab4e7fa255fcc556da64ec_id_rsa (zuul-build-sshkey) 2026-08-02 03:02:12.571709 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.031059 2026-08-02 03:02:12.579960 | 2026-08-02 03:02:12.580068 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-02 03:02:13.409135 | debian-bookworm | ok 2026-08-02 03:02:13.418908 | 2026-08-02 03:02:13.419017 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-02 03:02:13.491522 | debian-bookworm | skipping: Conditional result was False 2026-08-02 03:02:13.520027 | 2026-08-02 03:02:13.520151 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-02 03:02:14.722078 | debian-bookworm | ok 2026-08-02 03:02:14.754425 | 2026-08-02 03:02:14.754626 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-02 03:02:14.825087 | debian-bookworm | ok 2026-08-02 03:02:14.836375 | 2026-08-02 03:02:14.836498 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-02 03:02:15.841619 | debian-bookworm -> localhost | ok 2026-08-02 03:02:15.848197 | 2026-08-02 03:02:15.848288 | TASK [validate-host : Collect information about the host] 2026-08-02 03:02:17.271795 | debian-bookworm | ok 2026-08-02 03:02:17.283242 | 2026-08-02 03:02:17.283344 | TASK [validate-host : Sanitize hostname] 2026-08-02 03:02:17.413428 | debian-bookworm | ok 2026-08-02 03:02:17.420626 | 2026-08-02 03:02:17.420732 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-02 03:02:18.260045 | debian-bookworm -> localhost | changed 2026-08-02 03:02:18.265765 | 2026-08-02 03:02:18.265861 | TASK [validate-host : Collect information about zuul worker] 2026-08-02 03:02:18.833550 | debian-bookworm | ok 2026-08-02 03:02:18.845139 | 2026-08-02 03:02:18.845264 | TASK [validate-host : Write out all zuul information for each host] 2026-08-02 03:02:19.656735 | debian-bookworm -> localhost | changed 2026-08-02 03:02:19.667227 | 2026-08-02 03:02:19.667336 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-02 03:02:19.953393 | debian-bookworm | ok 2026-08-02 03:02:19.976268 | 2026-08-02 03:02:19.976413 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-02 03:02:20.881357 | debian-bookworm | changed: 2026-08-02 03:02:20.881597 | debian-bookworm | cd+++++++++ src/ 2026-08-02 03:02:20.881631 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-02 03:02:20.881655 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-02 03:02:20.881677 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-validations/ 2026-08-02 03:02:20.881697 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/c78d6bc4bfab4e7fa255fcc556da64ec/work/logs" 2026-08-02 03:03:20.802288 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c78d6bc4bfab4e7fa255fcc556da64ec/work/artifacts" 2026-08-02 03:03:21.415652 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c78d6bc4bfab4e7fa255fcc556da64ec/work/docs" 2026-08-02 03:03:21.426186 | 2026-08-02 03:03:21.426271 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-02 03:03:22.654331 | debian-bookworm | changed: 2026-08-02 03:03:22.654508 | debian-bookworm | .d..t...... ./ 2026-08-02 03:03:22.654536 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-02 03:03:22.654556 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-02 03:03:22.654573 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-02 03:03:22.654589 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-02 03:03:22.654606 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-02 03:03:22.654635 | debian-bookworm | changed: All items complete 2026-08-02 03:03:22.654653 | 2026-08-02 03:03:23.400325 | debian-bookworm | changed: .d..t...... ./ 2026-08-02 03:03:24.082744 | debian-bookworm | changed: .d..t...... ./ 2026-08-02 03:03:24.109644 | 2026-08-02 03:03:24.111022 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-02 03:03:24.141930 | debian-bookworm | skipping: Conditional result was False 2026-08-02 03:03:24.148597 | debian-bookworm | skipping: Conditional result was False 2026-08-02 03:03:24.162363 | 2026-08-02 03:03:24.162431 | PLAY RECAP 2026-08-02 03:03:24.162471 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-02 03:03:24.162492 | 2026-08-02 03:03:24.288319 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-02 03:03:24.289162 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-02 03:03:24.991944 | 2026-08-02 03:03:24.992060 | PLAY [Base post] 2026-08-02 03:03:25.014550 | 2026-08-02 03:03:25.014677 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-02 03:03:25.716926 | debian-bookworm | changed 2026-08-02 03:03:25.725252 | 2026-08-02 03:03:25.725339 | PLAY RECAP 2026-08-02 03:03:25.725403 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-02 03:03:25.725455 | 2026-08-02 03:03:25.963875 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-02 03:03:25.964646 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-02 03:03:27.345285 | 2026-08-02 03:03:27.345447 | PLAY [Base post-logs] 2026-08-02 03:03:27.360420 | 2026-08-02 03:03:27.360553 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-02 03:03:27.860968 | localhost | changed 2026-08-02 03:03:27.870455 | 2026-08-02 03:03:27.870591 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-02 03:03:27.915535 | localhost | ok 2026-08-02 03:03:27.918418 | 2026-08-02 03:03:27.918502 | TASK [Set zuul-log-path fact] 2026-08-02 03:03:27.943842 | localhost | ok 2026-08-02 03:03:27.962670 | 2026-08-02 03:03:27.962790 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-02 03:03:28.001269 | localhost | ok 2026-08-02 03:03:28.004287 | 2026-08-02 03:03:28.004385 | TASK [upload-logs : Create log directories] 2026-08-02 03:03:28.632728 | localhost | changed 2026-08-02 03:03:28.635384 | 2026-08-02 03:03:28.635466 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-02 03:03:29.270446 | localhost -> localhost | ok: Runtime: 0:00:00.032673 2026-08-02 03:03:29.273586 | 2026-08-02 03:03:29.273671 | TASK [upload-logs : Upload logs to log server] 2026-08-02 03:03:30.067334 | localhost | Output suppressed because no_log was given 2026-08-02 03:03:30.069412 | 2026-08-02 03:03:30.069486 | LOOP [upload-logs : Compress console log and json output] 2026-08-02 03:03:30.144133 | localhost | skipping: Conditional result was False 2026-08-02 03:03:30.150645 | localhost | skipping: Conditional result was False 2026-08-02 03:03:30.155247 | 2026-08-02 03:03:30.155375 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-02 03:03:30.231706 | localhost | skipping: Conditional result was False 2026-08-02 03:03:30.232009 | 2026-08-02 03:03:30.240733 | localhost | skipping: Conditional result was False 2026-08-02 03:03:30.244124 | 2026-08-02 03:03:30.244226 | LOOP [upload-logs : Upload console log and json output]