2026-09-09 03:01:45.330116 | Job console starting 2026-09-09 03:01:45.337682 | Updating git repos 2026-09-09 03:01:45.368340 | Cloning repos into workspace 2026-09-09 03:01:45.488991 | Restoring repo states 2026-09-09 03:01:45.518783 | Merging changes 2026-09-09 03:01:45.518798 | Checking out repos 2026-09-09 03:01:45.610149 | Preparing playbooks 2026-09-09 03:01:47.183578 | Running Ansible setup 2026-09-09 03:01:53.920460 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-09 03:01:56.093782 | 2026-09-09 03:01:56.093907 | PLAY [Base pre] 2026-09-09 03:01:56.152650 | 2026-09-09 03:01:56.152764 | TASK [Setup log path fact] 2026-09-09 03:01:56.183442 | debian-bookworm | ok 2026-09-09 03:01:56.224071 | 2026-09-09 03:01:56.224193 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-09 03:01:56.305662 | debian-bookworm | ok 2026-09-09 03:01:56.324184 | 2026-09-09 03:01:56.324282 | TASK [emit-job-header : Print job information] 2026-09-09 03:01:56.395341 | # Job Information 2026-09-09 03:01:56.395521 | Ansible Version: 2.16.14 2026-09-09 03:01:56.395556 | Job: python-black 2026-09-09 03:01:56.395584 | Pipeline: periodic-daily 2026-09-09 03:01:56.395602 | Executor: 521e9411259a 2026-09-09 03:01:56.395619 | Triggered by: https://github.com/osism/openstack-project-manager 2026-09-09 03:01:56.395638 | Event ID: 6d8cbac87b22417cbcb5c89f200ae01b 2026-09-09 03:01:56.400229 | 2026-09-09 03:01:56.400398 | LOOP [emit-job-header : Print node information] 2026-09-09 03:01:56.667077 | debian-bookworm | ok: 2026-09-09 03:01:56.667278 | debian-bookworm | # Node Information 2026-09-09 03:01:56.667311 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-09 03:01:56.667343 | debian-bookworm | Hostname: debian 2026-09-09 03:01:56.667362 | debian-bookworm | Username: zuul 2026-09-09 03:01:56.667379 | debian-bookworm | Distro: Debian 12.15 2026-09-09 03:01:56.667398 | debian-bookworm | Provider: regiocloud-a 2026-09-09 03:01:56.667415 | debian-bookworm | Region: 2026-09-09 03:01:56.667431 | debian-bookworm | Label: debian-bookworm 2026-09-09 03:01:56.667447 | debian-bookworm | Product Name: OpenStack Nova 2026-09-09 03:01:56.667462 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe59:33f7 2026-09-09 03:01:56.695142 | 2026-09-09 03:01:56.695235 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-09 03:01:57.826270 | debian-bookworm -> localhost | changed 2026-09-09 03:01:57.832856 | 2026-09-09 03:01:57.832943 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-09 03:02:00.810550 | debian-bookworm -> localhost | changed 2026-09-09 03:02:00.823710 | 2026-09-09 03:02:00.824116 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-09 03:02:01.297221 | debian-bookworm -> localhost | ok 2026-09-09 03:02:01.302238 | 2026-09-09 03:02:01.302322 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-09 03:02:01.371247 | debian-bookworm | ok 2026-09-09 03:02:01.395153 | debian-bookworm | included: /var/lib/zuul/builds/b03e3b4891324dd5938db4044de342df/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-09 03:02:01.407700 | 2026-09-09 03:02:01.407789 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-09 03:02:03.628262 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-09 03:02:03.628425 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b03e3b4891324dd5938db4044de342df/work/b03e3b4891324dd5938db4044de342df_id_rsa 2026-09-09 03:02:03.628457 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b03e3b4891324dd5938db4044de342df/work/b03e3b4891324dd5938db4044de342df_id_rsa.pub 2026-09-09 03:02:03.628480 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-09 03:02:03.628500 | debian-bookworm -> localhost | SHA256:IqL1+UihMBlG2hoYUGbV6qiq1Oh8mVkOS9AqWabB/zI zuul-build-sshkey 2026-09-09 03:02:03.628520 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-09 03:02:03.628550 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-09 03:02:03.628570 | debian-bookworm -> localhost | |+o+... | 2026-09-09 03:02:03.628589 | debian-bookworm -> localhost | |+= . | 2026-09-09 03:02:03.628608 | debian-bookworm -> localhost | |*.o . | 2026-09-09 03:02:03.628626 | debian-bookworm -> localhost | |oBo.. | 2026-09-09 03:02:03.628643 | debian-bookworm -> localhost | |=**oo . S | 2026-09-09 03:02:03.628663 | debian-bookworm -> localhost | |+*+B.= . | 2026-09-09 03:02:03.628682 | debian-bookworm -> localhost | |o+o.& | 2026-09-09 03:02:03.628700 | debian-bookworm -> localhost | |= E = | 2026-09-09 03:02:03.628718 | debian-bookworm -> localhost | |=o. + . | 2026-09-09 03:02:03.628737 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-09 03:02:03.628777 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.925806 2026-09-09 03:02:03.633779 | 2026-09-09 03:02:03.633860 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-09 03:02:03.649896 | debian-bookworm | ok 2026-09-09 03:02:03.657976 | debian-bookworm | included: /var/lib/zuul/builds/b03e3b4891324dd5938db4044de342df/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-09 03:02:03.672643 | 2026-09-09 03:02:03.672726 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-09 03:02:03.719589 | debian-bookworm | skipping: Conditional result was False 2026-09-09 03:02:03.725250 | 2026-09-09 03:02:03.725379 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-09 03:02:04.470053 | debian-bookworm | changed 2026-09-09 03:02:04.474929 | 2026-09-09 03:02:04.474999 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-09 03:02:04.785271 | debian-bookworm | ok 2026-09-09 03:02:04.794846 | 2026-09-09 03:02:04.794981 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-09 03:02:05.527016 | debian-bookworm | changed 2026-09-09 03:02:05.534175 | 2026-09-09 03:02:05.534562 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-09 03:02:06.308267 | debian-bookworm | changed 2026-09-09 03:02:06.312839 | 2026-09-09 03:02:06.312914 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-09 03:02:06.336172 | debian-bookworm | skipping: Conditional result was False 2026-09-09 03:02:06.342314 | 2026-09-09 03:02:06.342401 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-09 03:02:07.066896 | debian-bookworm -> localhost | changed 2026-09-09 03:02:07.077622 | 2026-09-09 03:02:07.078448 | TASK [add-build-sshkey : Add back temp key] 2026-09-09 03:02:07.476431 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b03e3b4891324dd5938db4044de342df/work/b03e3b4891324dd5938db4044de342df_id_rsa (zuul-build-sshkey) 2026-09-09 03:02:07.476601 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009208 2026-09-09 03:02:07.482582 | 2026-09-09 03:02:07.482662 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-09 03:02:07.995449 | debian-bookworm | ok 2026-09-09 03:02:07.999603 | 2026-09-09 03:02:07.999677 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-09 03:02:08.022395 | debian-bookworm | skipping: Conditional result was False 2026-09-09 03:02:08.031257 | 2026-09-09 03:02:08.031355 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-09 03:02:08.440910 | debian-bookworm | ok 2026-09-09 03:02:08.451411 | 2026-09-09 03:02:08.451492 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-09 03:02:08.477503 | debian-bookworm | ok 2026-09-09 03:02:08.481439 | 2026-09-09 03:02:08.481504 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-09 03:02:08.690926 | debian-bookworm -> localhost | ok 2026-09-09 03:02:08.698940 | 2026-09-09 03:02:08.699021 | TASK [validate-host : Collect information about the host] 2026-09-09 03:02:09.959239 | debian-bookworm | ok 2026-09-09 03:02:09.971075 | 2026-09-09 03:02:09.971166 | TASK [validate-host : Sanitize hostname] 2026-09-09 03:02:10.093590 | debian-bookworm | ok 2026-09-09 03:02:10.098126 | 2026-09-09 03:02:10.098204 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-09 03:02:10.536651 | debian-bookworm -> localhost | changed 2026-09-09 03:02:10.541193 | 2026-09-09 03:02:10.541272 | TASK [validate-host : Collect information about zuul worker] 2026-09-09 03:02:10.970369 | debian-bookworm | ok 2026-09-09 03:02:10.974314 | 2026-09-09 03:02:10.974420 | TASK [validate-host : Write out all zuul information for each host] 2026-09-09 03:02:11.572583 | debian-bookworm -> localhost | changed 2026-09-09 03:02:11.580262 | 2026-09-09 03:02:11.580355 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-09 03:02:11.894848 | debian-bookworm | ok 2026-09-09 03:02:11.899259 | 2026-09-09 03:02:11.899365 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-09 03:02:13.074794 | debian-bookworm | changed: 2026-09-09 03:02:13.074952 | debian-bookworm | cd+++++++++ src/ 2026-09-09 03:02:13.074986 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-09 03:02:13.075010 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-09 03:02:13.075032 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2026-09-09 03:02:13.075051 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/b03e3b4891324dd5938db4044de342df/work/logs" 2026-09-09 03:03:19.492930 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b03e3b4891324dd5938db4044de342df/work/artifacts" 2026-09-09 03:03:19.809739 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b03e3b4891324dd5938db4044de342df/work/docs" 2026-09-09 03:03:19.830917 | 2026-09-09 03:03:19.831058 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-09 03:03:20.757903 | debian-bookworm | changed: 2026-09-09 03:03:20.758149 | debian-bookworm | .d..t...... ./ 2026-09-09 03:03:20.758185 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-09 03:03:20.758209 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-09 03:03:20.758231 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-09 03:03:20.758252 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-09 03:03:20.758273 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-09 03:03:20.758313 | debian-bookworm | changed: All items complete 2026-09-09 03:03:20.758355 | 2026-09-09 03:03:21.650754 | debian-bookworm | changed: .d..t...... ./ 2026-09-09 03:03:22.297204 | debian-bookworm | changed: .d..t...... ./ 2026-09-09 03:03:22.312227 | 2026-09-09 03:03:22.312365 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-09 03:03:22.334074 | debian-bookworm | skipping: Conditional result was False 2026-09-09 03:03:22.342588 | debian-bookworm | skipping: Conditional result was False 2026-09-09 03:03:22.365856 | 2026-09-09 03:03:22.365932 | PLAY RECAP 2026-09-09 03:03:22.365988 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-09-09 03:03:22.366014 | 2026-09-09 03:03:22.465798 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-09 03:03:22.466626 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-09 03:03:23.156278 | 2026-09-09 03:03:23.156449 | PLAY [Base post] 2026-09-09 03:03:23.190581 | 2026-09-09 03:03:23.190742 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-09 03:03:23.799235 | debian-bookworm | changed 2026-09-09 03:03:23.808262 | 2026-09-09 03:03:23.808408 | PLAY RECAP 2026-09-09 03:03:23.808477 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-09 03:03:23.808540 | 2026-09-09 03:03:23.941119 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-09 03:03:23.941998 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-09 03:03:24.738345 | 2026-09-09 03:03:24.738515 | PLAY [Base post-logs] 2026-09-09 03:03:24.749589 | 2026-09-09 03:03:24.749718 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-09 03:03:25.198148 | localhost | changed 2026-09-09 03:03:25.212481 | 2026-09-09 03:03:25.212648 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-09 03:03:25.239048 | localhost | ok 2026-09-09 03:03:25.242950 | 2026-09-09 03:03:25.243065 | TASK [Set zuul-log-path fact] 2026-09-09 03:03:25.258736 | localhost | ok 2026-09-09 03:03:25.267452 | 2026-09-09 03:03:25.267558 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-09 03:03:25.292312 | localhost | ok 2026-09-09 03:03:25.295600 | 2026-09-09 03:03:25.295709 | TASK [upload-logs : Create log directories] 2026-09-09 03:03:25.740670 | localhost | changed 2026-09-09 03:03:25.743853 | 2026-09-09 03:03:25.743945 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-09 03:03:26.197771 | localhost -> localhost | ok: Runtime: 0:00:00.007299 2026-09-09 03:03:26.201806 | 2026-09-09 03:03:26.201918 | TASK [upload-logs : Upload logs to log server] 2026-09-09 03:03:26.757186 | localhost | Output suppressed because no_log was given 2026-09-09 03:03:26.762546 | 2026-09-09 03:03:26.762760 | LOOP [upload-logs : Compress console log and json output] 2026-09-09 03:03:26.813777 | localhost | skipping: Conditional result was False 2026-09-09 03:03:26.818680 | localhost | skipping: Conditional result was False 2026-09-09 03:03:26.825960 | 2026-09-09 03:03:26.826137 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-09 03:03:26.882040 | localhost | skipping: Conditional result was False 2026-09-09 03:03:26.883318 | 2026-09-09 03:03:26.885195 | localhost | skipping: Conditional result was False 2026-09-09 03:03:26.895094 | 2026-09-09 03:03:26.895208 | LOOP [upload-logs : Upload console log and json output]