2026-05-28 03:11:56.071938 | Job console starting 2026-05-28 03:11:56.086386 | Updating git repos 2026-05-28 03:11:56.112874 | Cloning repos into workspace 2026-05-28 03:11:56.179520 | Restoring repo states 2026-05-28 03:11:56.193284 | Merging changes 2026-05-28 03:11:56.193301 | Checking out repos 2026-05-28 03:11:56.323865 | Preparing playbooks 2026-05-28 03:11:57.479948 | Running Ansible setup 2026-05-28 03:12:02.035431 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-28 03:12:03.195702 | 2026-05-28 03:12:03.195917 | PLAY [Base pre] 2026-05-28 03:12:03.212863 | 2026-05-28 03:12:03.213001 | TASK [Setup log path fact] 2026-05-28 03:12:03.241819 | debian-bookworm | ok 2026-05-28 03:12:03.274156 | 2026-05-28 03:12:03.274320 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 03:12:03.325359 | debian-bookworm | ok 2026-05-28 03:12:03.341118 | 2026-05-28 03:12:03.341246 | TASK [emit-job-header : Print job information] 2026-05-28 03:12:03.411641 | # Job Information 2026-05-28 03:12:03.411853 | Ansible Version: 2.16.14 2026-05-28 03:12:03.411890 | Job: flake8 2026-05-28 03:12:03.411924 | Pipeline: periodic-daily 2026-05-28 03:12:03.411946 | Executor: 521e9411259a 2026-05-28 03:12:03.411967 | Triggered by: https://github.com/osism/node-image 2026-05-28 03:12:03.411990 | Event ID: 9a23aad4cc144b9997bdaa1cf118db43 2026-05-28 03:12:03.416966 | 2026-05-28 03:12:03.417073 | LOOP [emit-job-header : Print node information] 2026-05-28 03:12:03.598969 | debian-bookworm | ok: 2026-05-28 03:12:03.599200 | debian-bookworm | # Node Information 2026-05-28 03:12:03.599255 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-28 03:12:03.599311 | debian-bookworm | Hostname: debian 2026-05-28 03:12:03.599337 | debian-bookworm | Username: zuul 2026-05-28 03:12:03.599358 | debian-bookworm | Distro: Debian 12.14 2026-05-28 03:12:03.599383 | debian-bookworm | Provider: regiocloud-a 2026-05-28 03:12:03.599404 | debian-bookworm | Region: 2026-05-28 03:12:03.599425 | debian-bookworm | Label: debian-bookworm 2026-05-28 03:12:03.599446 | debian-bookworm | Product Name: OpenStack Nova 2026-05-28 03:12:03.599465 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1f:f8d1 2026-05-28 03:12:03.620227 | 2026-05-28 03:12:03.620358 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-28 03:12:04.110624 | debian-bookworm -> localhost | changed 2026-05-28 03:12:04.117913 | 2026-05-28 03:12:04.118020 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-28 03:12:05.729313 | debian-bookworm -> localhost | changed 2026-05-28 03:12:05.742661 | 2026-05-28 03:12:05.742770 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-28 03:12:06.111810 | debian-bookworm -> localhost | ok 2026-05-28 03:12:06.130940 | 2026-05-28 03:12:06.131205 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-28 03:12:06.155955 | debian-bookworm | ok 2026-05-28 03:12:06.170068 | debian-bookworm | included: /var/lib/zuul/builds/cdd64638668a4332b77182b44a4cdec6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-28 03:12:06.176815 | 2026-05-28 03:12:06.176903 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-28 03:12:08.513075 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-28 03:12:08.513275 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/cdd64638668a4332b77182b44a4cdec6/work/cdd64638668a4332b77182b44a4cdec6_id_rsa 2026-05-28 03:12:08.513310 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/cdd64638668a4332b77182b44a4cdec6/work/cdd64638668a4332b77182b44a4cdec6_id_rsa.pub 2026-05-28 03:12:08.513336 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-28 03:12:08.513360 | debian-bookworm -> localhost | SHA256:llwN49SOezQbq/B+k+uV7FUXHiKKf7/loxzOYrRZkCA zuul-build-sshkey 2026-05-28 03:12:08.513382 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-28 03:12:08.513413 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-28 03:12:08.513436 | debian-bookworm -> localhost | | +. | 2026-05-28 03:12:08.513458 | debian-bookworm -> localhost | | E + +. | 2026-05-28 03:12:08.513479 | debian-bookworm -> localhost | | . ++o. o | 2026-05-28 03:12:08.513499 | debian-bookworm -> localhost | | ..ooo* o o| 2026-05-28 03:12:08.513519 | debian-bookworm -> localhost | | .S. o.= .o| 2026-05-28 03:12:08.513543 | debian-bookworm -> localhost | | .o ..+o .o| 2026-05-28 03:12:08.513563 | debian-bookworm -> localhost | | +.++o+..| 2026-05-28 03:12:08.513583 | debian-bookworm -> localhost | | +=Oo+o | 2026-05-28 03:12:08.513604 | debian-bookworm -> localhost | | .oo+X+..| 2026-05-28 03:12:08.513624 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-28 03:12:08.513676 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.660664 2026-05-28 03:12:08.519993 | 2026-05-28 03:12:08.520084 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-28 03:12:08.548119 | debian-bookworm | ok 2026-05-28 03:12:08.575115 | debian-bookworm | included: /var/lib/zuul/builds/cdd64638668a4332b77182b44a4cdec6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-28 03:12:08.590182 | 2026-05-28 03:12:08.590314 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-28 03:12:08.637985 | debian-bookworm | skipping: Conditional result was False 2026-05-28 03:12:08.644198 | 2026-05-28 03:12:08.644319 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-28 03:12:09.338756 | debian-bookworm | changed 2026-05-28 03:12:09.346716 | 2026-05-28 03:12:09.346821 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-28 03:12:09.618164 | debian-bookworm | ok 2026-05-28 03:12:09.633455 | 2026-05-28 03:12:09.633558 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-28 03:12:10.329623 | debian-bookworm | changed 2026-05-28 03:12:10.341345 | 2026-05-28 03:12:10.341459 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-28 03:12:11.092657 | debian-bookworm | changed 2026-05-28 03:12:11.098517 | 2026-05-28 03:12:11.098611 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-28 03:12:11.112366 | debian-bookworm | skipping: Conditional result was False 2026-05-28 03:12:11.119209 | 2026-05-28 03:12:11.119322 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-28 03:12:11.719216 | debian-bookworm -> localhost | changed 2026-05-28 03:12:11.730911 | 2026-05-28 03:12:11.731019 | TASK [add-build-sshkey : Add back temp key] 2026-05-28 03:12:12.392668 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/cdd64638668a4332b77182b44a4cdec6/work/cdd64638668a4332b77182b44a4cdec6_id_rsa (zuul-build-sshkey) 2026-05-28 03:12:12.392902 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013529 2026-05-28 03:12:12.400834 | 2026-05-28 03:12:12.400930 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-28 03:12:12.929759 | debian-bookworm | ok 2026-05-28 03:12:12.935131 | 2026-05-28 03:12:12.935228 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-28 03:12:12.994437 | debian-bookworm | skipping: Conditional result was False 2026-05-28 03:12:13.015312 | 2026-05-28 03:12:13.017368 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-28 03:12:13.486553 | debian-bookworm | ok 2026-05-28 03:12:13.515218 | 2026-05-28 03:12:13.515360 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-28 03:12:13.589515 | debian-bookworm | ok 2026-05-28 03:12:13.596598 | 2026-05-28 03:12:13.596761 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-28 03:12:14.559004 | debian-bookworm -> localhost | ok 2026-05-28 03:12:14.566904 | 2026-05-28 03:12:14.566999 | TASK [validate-host : Collect information about the host] 2026-05-28 03:12:16.368017 | debian-bookworm | ok 2026-05-28 03:12:16.395772 | 2026-05-28 03:12:16.395892 | TASK [validate-host : Sanitize hostname] 2026-05-28 03:12:16.514448 | debian-bookworm | ok 2026-05-28 03:12:16.581005 | 2026-05-28 03:12:16.581119 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-28 03:12:17.249924 | debian-bookworm -> localhost | changed 2026-05-28 03:12:17.255627 | 2026-05-28 03:12:17.255736 | TASK [validate-host : Collect information about zuul worker] 2026-05-28 03:12:17.861357 | debian-bookworm | ok 2026-05-28 03:12:17.865894 | 2026-05-28 03:12:17.865984 | TASK [validate-host : Write out all zuul information for each host] 2026-05-28 03:12:18.590035 | debian-bookworm -> localhost | changed 2026-05-28 03:12:18.597714 | 2026-05-28 03:12:18.597809 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-28 03:12:18.873580 | debian-bookworm | ok 2026-05-28 03:12:18.878757 | 2026-05-28 03:12:18.878867 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-28 03:12:20.529667 | debian-bookworm | changed: 2026-05-28 03:12:20.529856 | debian-bookworm | cd+++++++++ src/ 2026-05-28 03:12:20.529891 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-28 03:12:20.529915 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-28 03:12:20.529937 | debian-bookworm | cd+++++++++ src/github.com/osism/node-image/ 2026-05-28 03:12:20.529957 | debian-bookworm | Containerfile 2026-05-28 03:12:20.530087 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/cdd64638668a4332b77182b44a4cdec6/work/logs" 2026-05-28 03:12:45.601677 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/cdd64638668a4332b77182b44a4cdec6/work/artifacts" 2026-05-28 03:12:45.966391 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/cdd64638668a4332b77182b44a4cdec6/work/docs" 2026-05-28 03:12:45.975778 | 2026-05-28 03:12:45.975870 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-28 03:12:46.812875 | debian-bookworm | changed: 2026-05-28 03:12:46.813085 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-28 03:12:46.813122 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-28 03:12:46.813152 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-28 03:12:46.813199 | debian-bookworm | changed: All items complete 2026-05-28 03:12:46.813226 | 2026-05-28 03:12:47.408806 | debian-bookworm | changed: .d..t...... ./ 2026-05-28 03:12:48.043402 | debian-bookworm | changed: .d..t...... ./ 2026-05-28 03:12:48.059854 | 2026-05-28 03:12:48.059949 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-28 03:12:48.083435 | debian-bookworm | skipping: Conditional result was False 2026-05-28 03:12:48.088843 | debian-bookworm | skipping: Conditional result was False 2026-05-28 03:12:48.111611 | 2026-05-28 03:12:48.112099 | PLAY RECAP 2026-05-28 03:12:48.112165 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-28 03:12:48.112192 | 2026-05-28 03:12:48.255272 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-28 03:12:48.256220 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 03:12:49.050467 | 2026-05-28 03:12:49.050594 | PLAY [Base post] 2026-05-28 03:12:49.067775 | 2026-05-28 03:12:49.067902 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-28 03:12:49.630650 | debian-bookworm | changed 2026-05-28 03:12:49.639702 | 2026-05-28 03:12:49.639830 | PLAY RECAP 2026-05-28 03:12:49.639893 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-28 03:12:49.640074 | 2026-05-28 03:12:49.763471 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 03:12:49.764401 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-28 03:12:50.761575 | 2026-05-28 03:12:50.761774 | PLAY [Base post-logs] 2026-05-28 03:12:50.780195 | 2026-05-28 03:12:50.780365 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-28 03:12:51.789125 | localhost | changed 2026-05-28 03:12:51.811739 | 2026-05-28 03:12:51.811952 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-28 03:12:51.868810 | localhost | ok 2026-05-28 03:12:51.872980 | 2026-05-28 03:12:51.873120 | TASK [Set zuul-log-path fact] 2026-05-28 03:12:51.908350 | localhost | ok 2026-05-28 03:12:51.923455 | 2026-05-28 03:12:51.923596 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 03:12:51.969897 | localhost | ok 2026-05-28 03:12:51.974957 | 2026-05-28 03:12:51.975072 | TASK [upload-logs : Create log directories] 2026-05-28 03:12:52.705117 | localhost | changed 2026-05-28 03:12:52.708223 | 2026-05-28 03:12:52.708341 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-28 03:12:53.573505 | localhost -> localhost | ok: Runtime: 0:00:00.008250 2026-05-28 03:12:53.578154 | 2026-05-28 03:12:53.578285 | TASK [upload-logs : Upload logs to log server] 2026-05-28 03:12:54.524677 | localhost | Output suppressed because no_log was given 2026-05-28 03:12:54.526283 | 2026-05-28 03:12:54.526369 | LOOP [upload-logs : Compress console log and json output] 2026-05-28 03:12:54.569879 | localhost | skipping: Conditional result was False 2026-05-28 03:12:54.575874 | localhost | skipping: Conditional result was False 2026-05-28 03:12:54.582412 | 2026-05-28 03:12:54.582512 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-28 03:12:54.675745 | localhost | skipping: Conditional result was False 2026-05-28 03:12:54.675990 | 2026-05-28 03:12:54.696267 | localhost | skipping: Conditional result was False 2026-05-28 03:12:54.708902 | 2026-05-28 03:12:54.709017 | LOOP [upload-logs : Upload console log and json output]