2026-05-09 03:12:50.829237 | Job console starting 2026-05-09 03:12:50.859149 | Updating git repos 2026-05-09 03:12:50.923093 | Cloning repos into workspace 2026-05-09 03:12:50.994402 | Restoring repo states 2026-05-09 03:12:51.011977 | Merging changes 2026-05-09 03:12:51.012001 | Checking out repos 2026-05-09 03:12:51.079785 | Preparing playbooks 2026-05-09 03:12:52.453071 | Running Ansible setup 2026-05-09 03:12:58.145462 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-09 03:12:59.029538 | 2026-05-09 03:12:59.029673 | PLAY [Base pre] 2026-05-09 03:12:59.046800 | 2026-05-09 03:12:59.046963 | TASK [Setup log path fact] 2026-05-09 03:12:59.065471 | debian-bookworm | ok 2026-05-09 03:12:59.090858 | 2026-05-09 03:12:59.090993 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-09 03:12:59.119179 | debian-bookworm | ok 2026-05-09 03:12:59.135012 | 2026-05-09 03:12:59.135125 | TASK [emit-job-header : Print job information] 2026-05-09 03:12:59.215986 | # Job Information 2026-05-09 03:12:59.216146 | Ansible Version: 2.16.14 2026-05-09 03:12:59.216180 | Job: python-black 2026-05-09 03:12:59.216213 | Pipeline: periodic-daily 2026-05-09 03:12:59.216236 | Executor: 521e9411259a 2026-05-09 03:12:59.216257 | Triggered by: https://github.com/osism/container-image-osism-ansible 2026-05-09 03:12:59.216280 | Event ID: 73c19f12752f4706b5aaffb8420d5113 2026-05-09 03:12:59.221926 | 2026-05-09 03:12:59.222030 | LOOP [emit-job-header : Print node information] 2026-05-09 03:12:59.403410 | debian-bookworm | ok: 2026-05-09 03:12:59.403624 | debian-bookworm | # Node Information 2026-05-09 03:12:59.403657 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-09 03:12:59.403689 | debian-bookworm | Hostname: debian 2026-05-09 03:12:59.403725 | debian-bookworm | Username: zuul 2026-05-09 03:12:59.403746 | debian-bookworm | Distro: Debian 12.13 2026-05-09 03:12:59.403768 | debian-bookworm | Provider: regiocloud-a 2026-05-09 03:12:59.403789 | debian-bookworm | Region: 2026-05-09 03:12:59.403811 | debian-bookworm | Label: debian-bookworm 2026-05-09 03:12:59.403830 | debian-bookworm | Product Name: OpenStack Nova 2026-05-09 03:12:59.403850 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb9:56cc 2026-05-09 03:12:59.420195 | 2026-05-09 03:12:59.420315 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-09 03:12:59.862666 | debian-bookworm -> localhost | changed 2026-05-09 03:12:59.870394 | 2026-05-09 03:12:59.870511 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-09 03:13:01.201524 | debian-bookworm -> localhost | changed 2026-05-09 03:13:01.214425 | 2026-05-09 03:13:01.214607 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-09 03:13:01.683580 | debian-bookworm -> localhost | ok 2026-05-09 03:13:01.690493 | 2026-05-09 03:13:01.690609 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-09 03:13:01.725805 | debian-bookworm | ok 2026-05-09 03:13:01.761954 | debian-bookworm | included: /var/lib/zuul/builds/48d44e4bd9114be3bc123650ff73145c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-09 03:13:01.769487 | 2026-05-09 03:13:01.769594 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-09 03:13:05.247267 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-09 03:13:05.247483 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/48d44e4bd9114be3bc123650ff73145c/work/48d44e4bd9114be3bc123650ff73145c_id_rsa 2026-05-09 03:13:05.247521 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/48d44e4bd9114be3bc123650ff73145c/work/48d44e4bd9114be3bc123650ff73145c_id_rsa.pub 2026-05-09 03:13:05.247547 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-09 03:13:05.247571 | debian-bookworm -> localhost | SHA256:G5uxv5PTtD+Mlw7H6NeEGKx5/k0976tn66AELYL5owM zuul-build-sshkey 2026-05-09 03:13:05.247593 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-09 03:13:05.247624 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-09 03:13:05.247646 | debian-bookworm -> localhost | | | 2026-05-09 03:13:05.247668 | debian-bookworm -> localhost | | | 2026-05-09 03:13:05.247700 | debian-bookworm -> localhost | | . | 2026-05-09 03:13:05.247722 | debian-bookworm -> localhost | | o . o | 2026-05-09 03:13:05.247743 | debian-bookworm -> localhost | | o .So + o . | 2026-05-09 03:13:05.247770 | debian-bookworm -> localhost | | E . .B= +o. o| 2026-05-09 03:13:05.247791 | debian-bookworm -> localhost | | . o= Bo=o=o| 2026-05-09 03:13:05.247811 | debian-bookworm -> localhost | | .. ..=.*oB=+| 2026-05-09 03:13:05.247832 | debian-bookworm -> localhost | | .. o=.BO**| 2026-05-09 03:13:05.247852 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-09 03:13:05.247909 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.711718 2026-05-09 03:13:05.254699 | 2026-05-09 03:13:05.254796 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-09 03:13:05.296852 | debian-bookworm | ok 2026-05-09 03:13:05.309263 | debian-bookworm | included: /var/lib/zuul/builds/48d44e4bd9114be3bc123650ff73145c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-09 03:13:05.331937 | 2026-05-09 03:13:05.332063 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-09 03:13:05.357881 | debian-bookworm | skipping: Conditional result was False 2026-05-09 03:13:05.365547 | 2026-05-09 03:13:05.365675 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-09 03:13:06.121138 | debian-bookworm | changed 2026-05-09 03:13:06.126438 | 2026-05-09 03:13:06.126530 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-09 03:13:06.466288 | debian-bookworm | ok 2026-05-09 03:13:06.472262 | 2026-05-09 03:13:06.472354 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-09 03:13:07.178957 | debian-bookworm | changed 2026-05-09 03:13:07.199653 | 2026-05-09 03:13:07.199980 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-09 03:13:07.941969 | debian-bookworm | changed 2026-05-09 03:13:07.950676 | 2026-05-09 03:13:07.950781 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-09 03:13:07.994091 | debian-bookworm | skipping: Conditional result was False 2026-05-09 03:13:08.002060 | 2026-05-09 03:13:08.002163 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-09 03:13:08.581390 | debian-bookworm -> localhost | changed 2026-05-09 03:13:08.594953 | 2026-05-09 03:13:08.595071 | TASK [add-build-sshkey : Add back temp key] 2026-05-09 03:13:09.180763 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/48d44e4bd9114be3bc123650ff73145c/work/48d44e4bd9114be3bc123650ff73145c_id_rsa (zuul-build-sshkey) 2026-05-09 03:13:09.180987 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.036516 2026-05-09 03:13:09.189124 | 2026-05-09 03:13:09.189384 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-09 03:13:09.710715 | debian-bookworm | ok 2026-05-09 03:13:09.716099 | 2026-05-09 03:13:09.716192 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-09 03:13:09.739113 | debian-bookworm | skipping: Conditional result was False 2026-05-09 03:13:09.749580 | 2026-05-09 03:13:09.749691 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-09 03:13:10.317619 | debian-bookworm | ok 2026-05-09 03:13:10.346012 | 2026-05-09 03:13:10.346142 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-09 03:13:10.384086 | debian-bookworm | ok 2026-05-09 03:13:10.389606 | 2026-05-09 03:13:10.389721 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-09 03:13:10.880987 | debian-bookworm -> localhost | ok 2026-05-09 03:13:10.887471 | 2026-05-09 03:13:10.887571 | TASK [validate-host : Collect information about the host] 2026-05-09 03:13:11.998628 | debian-bookworm | ok 2026-05-09 03:13:12.021185 | 2026-05-09 03:13:12.025889 | TASK [validate-host : Sanitize hostname] 2026-05-09 03:13:12.170207 | debian-bookworm | ok 2026-05-09 03:13:12.305457 | 2026-05-09 03:13:12.305654 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-09 03:13:13.110602 | debian-bookworm -> localhost | changed 2026-05-09 03:13:13.117369 | 2026-05-09 03:13:13.117498 | TASK [validate-host : Collect information about zuul worker] 2026-05-09 03:13:13.539437 | debian-bookworm | ok 2026-05-09 03:13:13.543702 | 2026-05-09 03:13:13.543781 | TASK [validate-host : Write out all zuul information for each host] 2026-05-09 03:13:14.377345 | debian-bookworm -> localhost | changed 2026-05-09 03:13:14.400928 | 2026-05-09 03:13:14.401056 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-09 03:13:14.720184 | debian-bookworm | ok 2026-05-09 03:13:14.726034 | 2026-05-09 03:13:14.726118 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-09 03:13:15.601425 | debian-bookworm | changed: 2026-05-09 03:13:15.601652 | debian-bookworm | cd+++++++++ src/ 2026-05-09 03:13:15.601730 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-09 03:13:15.601761 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-09 03:13:15.601790 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-osism-ansible/ 2026-05-09 03:13:15.601815 | debian-bookworm | Containerfile 2026-05-09 03:13:15.601981 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/48d44e4bd9114be3bc123650ff73145c/work/logs" 2026-05-09 03:13:44.613830 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/48d44e4bd9114be3bc123650ff73145c/work/artifacts" 2026-05-09 03:13:45.050630 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/48d44e4bd9114be3bc123650ff73145c/work/docs" 2026-05-09 03:13:45.070425 | 2026-05-09 03:13:45.070563 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-09 03:13:45.906655 | debian-bookworm | changed: 2026-05-09 03:13:45.906867 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-09 03:13:45.906906 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-09 03:13:45.906935 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-09 03:13:45.906977 | debian-bookworm | changed: All items complete 2026-05-09 03:13:45.907000 | 2026-05-09 03:13:46.761919 | debian-bookworm | changed: .d..t...... ./ 2026-05-09 03:13:47.719946 | debian-bookworm | changed: .d..t...... ./ 2026-05-09 03:13:47.734963 | 2026-05-09 03:13:47.735065 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-09 03:13:47.792235 | debian-bookworm | skipping: Conditional result was False 2026-05-09 03:13:47.803853 | debian-bookworm | skipping: Conditional result was False 2026-05-09 03:13:47.819279 | 2026-05-09 03:13:47.819349 | PLAY RECAP 2026-05-09 03:13:47.819399 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-09 03:13:47.819550 | 2026-05-09 03:13:48.019815 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-09 03:13:48.020593 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-09 03:13:49.027215 | 2026-05-09 03:13:49.027335 | PLAY [Base post] 2026-05-09 03:13:49.040046 | 2026-05-09 03:13:49.040160 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-09 03:13:49.835766 | debian-bookworm | changed 2026-05-09 03:13:49.851048 | 2026-05-09 03:13:49.851177 | PLAY RECAP 2026-05-09 03:13:49.851250 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-09 03:13:49.851313 | 2026-05-09 03:13:50.093510 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-09 03:13:50.094343 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-09 03:13:51.306999 | 2026-05-09 03:13:51.307161 | PLAY [Base post-logs] 2026-05-09 03:13:51.319288 | 2026-05-09 03:13:51.319430 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-09 03:13:51.781876 | localhost | changed 2026-05-09 03:13:51.791667 | 2026-05-09 03:13:51.791796 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-09 03:13:51.817233 | localhost | ok 2026-05-09 03:13:51.820682 | 2026-05-09 03:13:51.820773 | TASK [Set zuul-log-path fact] 2026-05-09 03:13:51.835597 | localhost | ok 2026-05-09 03:13:51.848275 | 2026-05-09 03:13:51.848388 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-09 03:13:51.914349 | localhost | ok 2026-05-09 03:13:51.917805 | 2026-05-09 03:13:51.917924 | TASK [upload-logs : Create log directories] 2026-05-09 03:13:53.249247 | localhost | changed 2026-05-09 03:13:53.254251 | 2026-05-09 03:13:53.254336 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-09 03:13:53.885578 | localhost -> localhost | ok: Runtime: 0:00:00.006213 2026-05-09 03:13:53.889276 | 2026-05-09 03:13:53.889377 | TASK [upload-logs : Upload logs to log server] 2026-05-09 03:13:54.563437 | localhost | Output suppressed because no_log was given 2026-05-09 03:13:54.565007 | 2026-05-09 03:13:54.565090 | LOOP [upload-logs : Compress console log and json output] 2026-05-09 03:13:54.619733 | localhost | skipping: Conditional result was False 2026-05-09 03:13:54.624487 | localhost | skipping: Conditional result was False 2026-05-09 03:13:54.633435 | 2026-05-09 03:13:54.633545 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-09 03:13:54.746012 | localhost | skipping: Conditional result was False 2026-05-09 03:13:54.746243 | 2026-05-09 03:13:54.769562 | localhost | skipping: Conditional result was False 2026-05-09 03:13:54.780404 | 2026-05-09 03:13:54.780503 | LOOP [upload-logs : Upload console log and json output]