2026-07-18 03:02:18.865876 | Job console starting 2026-07-18 03:02:18.873870 | Updating git repos 2026-07-18 03:02:18.940416 | Cloning repos into workspace 2026-07-18 03:02:19.065046 | Restoring repo states 2026-07-18 03:02:19.103956 | Merging changes 2026-07-18 03:02:19.103975 | Checking out repos 2026-07-18 03:02:19.231140 | Preparing playbooks 2026-07-18 03:02:21.371036 | Running Ansible setup 2026-07-18 03:02:26.845102 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-18 03:02:27.661281 | 2026-07-18 03:02:27.661507 | PLAY [Base pre] 2026-07-18 03:02:27.682219 | 2026-07-18 03:02:27.682419 | TASK [Setup log path fact] 2026-07-18 03:02:27.719587 | debian-bookworm | ok 2026-07-18 03:02:27.741177 | 2026-07-18 03:02:27.741433 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-18 03:02:27.786389 | debian-bookworm | ok 2026-07-18 03:02:27.819549 | 2026-07-18 03:02:27.819741 | TASK [emit-job-header : Print job information] 2026-07-18 03:02:27.871129 | # Job Information 2026-07-18 03:02:27.871365 | Ansible Version: 2.16.14 2026-07-18 03:02:27.871401 | Job: python-black 2026-07-18 03:02:27.871435 | Pipeline: periodic-daily 2026-07-18 03:02:27.871459 | Executor: 521e9411259a 2026-07-18 03:02:27.871480 | Triggered by: https://github.com/osism/openstack-image-manager 2026-07-18 03:02:27.871503 | Event ID: 3cb84d4ab14346b993ff0f0d19db1280 2026-07-18 03:02:27.876878 | 2026-07-18 03:02:27.877021 | LOOP [emit-job-header : Print node information] 2026-07-18 03:02:28.037602 | debian-bookworm | ok: 2026-07-18 03:02:28.037850 | debian-bookworm | # Node Information 2026-07-18 03:02:28.037886 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-18 03:02:28.037911 | debian-bookworm | Hostname: debian 2026-07-18 03:02:28.037933 | debian-bookworm | Username: zuul 2026-07-18 03:02:28.037954 | debian-bookworm | Distro: Debian 12.15 2026-07-18 03:02:28.037979 | debian-bookworm | Provider: regiocloud-a 2026-07-18 03:02:28.038000 | debian-bookworm | Region: 2026-07-18 03:02:28.038022 | debian-bookworm | Label: debian-bookworm 2026-07-18 03:02:28.038042 | debian-bookworm | Product Name: OpenStack Nova 2026-07-18 03:02:28.038062 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe01:e19b 2026-07-18 03:02:28.052380 | 2026-07-18 03:02:28.052572 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-18 03:02:28.709684 | debian-bookworm -> localhost | changed 2026-07-18 03:02:28.718253 | 2026-07-18 03:02:28.718454 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-18 03:02:30.361841 | debian-bookworm -> localhost | changed 2026-07-18 03:02:30.374749 | 2026-07-18 03:02:30.374934 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-18 03:02:30.792573 | debian-bookworm -> localhost | ok 2026-07-18 03:02:30.799641 | 2026-07-18 03:02:30.799772 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-18 03:02:30.865015 | debian-bookworm | ok 2026-07-18 03:02:30.909096 | debian-bookworm | included: /var/lib/zuul/builds/6f9b5a5ad90043f8a60d927c7571c16f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-18 03:02:30.926604 | 2026-07-18 03:02:30.926752 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-18 03:02:34.369016 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-18 03:02:34.369272 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6f9b5a5ad90043f8a60d927c7571c16f/work/6f9b5a5ad90043f8a60d927c7571c16f_id_rsa 2026-07-18 03:02:34.369334 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6f9b5a5ad90043f8a60d927c7571c16f/work/6f9b5a5ad90043f8a60d927c7571c16f_id_rsa.pub 2026-07-18 03:02:34.369369 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-18 03:02:34.369395 | debian-bookworm -> localhost | SHA256:HymTBseKdAIEMT4VQOp6MbH8ek15vuF5BMZ6OY533Qs zuul-build-sshkey 2026-07-18 03:02:34.369418 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-18 03:02:34.369961 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-18 03:02:34.369986 | debian-bookworm -> localhost | |=*+o. | 2026-07-18 03:02:34.370008 | debian-bookworm -> localhost | |o... . | 2026-07-18 03:02:34.370030 | debian-bookworm -> localhost | |.o. o o.o | 2026-07-18 03:02:34.370049 | debian-bookworm -> localhost | |...+ + ++. . | 2026-07-18 03:02:34.370070 | debian-bookworm -> localhost | | .= . .+Soo | 2026-07-18 03:02:34.370098 | debian-bookworm -> localhost | |. + +.=+.. | 2026-07-18 03:02:34.370119 | debian-bookworm -> localhost | |. . .o *.o..E. | 2026-07-18 03:02:34.370141 | debian-bookworm -> localhost | | . .. o.+oo ... | 2026-07-18 03:02:34.370162 | debian-bookworm -> localhost | | .. .++ .. | 2026-07-18 03:02:34.370183 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-18 03:02:34.370240 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.218931 2026-07-18 03:02:34.382588 | 2026-07-18 03:02:34.382766 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-18 03:02:34.504843 | debian-bookworm | ok 2026-07-18 03:02:34.568544 | debian-bookworm | included: /var/lib/zuul/builds/6f9b5a5ad90043f8a60d927c7571c16f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-18 03:02:34.621986 | 2026-07-18 03:02:34.622184 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-18 03:02:34.671565 | debian-bookworm | skipping: Conditional result was False 2026-07-18 03:02:34.679529 | 2026-07-18 03:02:34.679695 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-18 03:02:36.011574 | debian-bookworm | changed 2026-07-18 03:02:36.024129 | 2026-07-18 03:02:36.027000 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-18 03:02:36.327274 | debian-bookworm | ok 2026-07-18 03:02:36.337195 | 2026-07-18 03:02:36.337391 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-18 03:02:37.083351 | debian-bookworm | changed 2026-07-18 03:02:37.089447 | 2026-07-18 03:02:37.089574 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-18 03:02:37.778327 | debian-bookworm | changed 2026-07-18 03:02:37.787439 | 2026-07-18 03:02:37.787610 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-18 03:02:37.830516 | debian-bookworm | skipping: Conditional result was False 2026-07-18 03:02:37.837051 | 2026-07-18 03:02:37.837175 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-18 03:02:38.394514 | debian-bookworm -> localhost | changed 2026-07-18 03:02:38.407957 | 2026-07-18 03:02:38.408114 | TASK [add-build-sshkey : Add back temp key] 2026-07-18 03:02:38.798107 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6f9b5a5ad90043f8a60d927c7571c16f/work/6f9b5a5ad90043f8a60d927c7571c16f_id_rsa (zuul-build-sshkey) 2026-07-18 03:02:38.798482 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012530 2026-07-18 03:02:38.807136 | 2026-07-18 03:02:38.807284 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-18 03:02:39.245311 | debian-bookworm | ok 2026-07-18 03:02:39.251823 | 2026-07-18 03:02:39.251972 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-18 03:02:39.282171 | debian-bookworm | skipping: Conditional result was False 2026-07-18 03:02:39.293202 | 2026-07-18 03:02:39.293369 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-18 03:02:39.787145 | debian-bookworm | ok 2026-07-18 03:02:39.811143 | 2026-07-18 03:02:39.811391 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-18 03:02:39.852333 | debian-bookworm | ok 2026-07-18 03:02:39.858262 | 2026-07-18 03:02:39.858420 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-18 03:02:40.167730 | debian-bookworm -> localhost | ok 2026-07-18 03:02:40.174824 | 2026-07-18 03:02:40.174971 | TASK [validate-host : Collect information about the host] 2026-07-18 03:02:41.385183 | debian-bookworm | ok 2026-07-18 03:02:41.430164 | 2026-07-18 03:02:41.430372 | TASK [validate-host : Sanitize hostname] 2026-07-18 03:02:41.762600 | debian-bookworm | ok 2026-07-18 03:02:41.780097 | 2026-07-18 03:02:41.780272 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-18 03:02:42.418612 | debian-bookworm -> localhost | changed 2026-07-18 03:02:42.425205 | 2026-07-18 03:02:42.425393 | TASK [validate-host : Collect information about zuul worker] 2026-07-18 03:02:42.845875 | debian-bookworm | ok 2026-07-18 03:02:42.854872 | 2026-07-18 03:02:42.855036 | TASK [validate-host : Write out all zuul information for each host] 2026-07-18 03:02:43.455836 | debian-bookworm -> localhost | changed 2026-07-18 03:02:43.467182 | 2026-07-18 03:02:43.467381 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-18 03:02:43.746754 | debian-bookworm | ok 2026-07-18 03:02:43.767066 | 2026-07-18 03:02:43.767226 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-18 03:02:44.968854 | debian-bookworm | changed: 2026-07-18 03:02:44.969135 | debian-bookworm | cd+++++++++ src/ 2026-07-18 03:02:44.970648 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-18 03:02:44.970699 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-18 03:02:44.970725 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-18 03:02:44.970748 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/6f9b5a5ad90043f8a60d927c7571c16f/work/logs" 2026-07-18 03:03:50.463050 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6f9b5a5ad90043f8a60d927c7571c16f/work/artifacts" 2026-07-18 03:03:50.885910 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6f9b5a5ad90043f8a60d927c7571c16f/work/docs" 2026-07-18 03:03:50.901449 | 2026-07-18 03:03:50.901572 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-18 03:03:52.224963 | debian-bookworm | changed: 2026-07-18 03:03:52.225159 | debian-bookworm | .d..t...... ./ 2026-07-18 03:03:52.225192 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-18 03:03:52.225217 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-18 03:03:52.225239 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-18 03:03:52.225261 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-18 03:03:52.225282 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-18 03:03:52.225343 | debian-bookworm | changed: All items complete 2026-07-18 03:03:52.225372 | 2026-07-18 03:03:53.412669 | debian-bookworm | changed: .d..t...... ./ 2026-07-18 03:03:54.870030 | debian-bookworm | changed: .d..t...... ./ 2026-07-18 03:03:54.897452 | 2026-07-18 03:03:54.897639 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-18 03:03:54.972727 | debian-bookworm | skipping: Conditional result was False 2026-07-18 03:03:54.989776 | debian-bookworm | skipping: Conditional result was False 2026-07-18 03:03:55.002962 | 2026-07-18 03:03:55.003088 | PLAY RECAP 2026-07-18 03:03:55.003137 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-18 03:03:55.003159 | 2026-07-18 03:03:55.341628 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-18 03:03:55.342293 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-18 03:03:56.366694 | 2026-07-18 03:03:56.366860 | PLAY [Base post] 2026-07-18 03:03:56.389404 | 2026-07-18 03:03:56.389539 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-18 03:03:57.007086 | debian-bookworm | changed 2026-07-18 03:03:57.029814 | 2026-07-18 03:03:57.029935 | PLAY RECAP 2026-07-18 03:03:57.029995 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-18 03:03:57.030058 | 2026-07-18 03:03:57.180483 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-18 03:03:57.181245 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-18 03:03:58.893562 | 2026-07-18 03:03:58.893720 | PLAY [Base post-logs] 2026-07-18 03:03:58.905574 | 2026-07-18 03:03:58.905720 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-18 03:03:59.541260 | localhost | changed 2026-07-18 03:03:59.552803 | 2026-07-18 03:03:59.556424 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-18 03:03:59.621968 | localhost | ok 2026-07-18 03:03:59.625566 | 2026-07-18 03:03:59.625671 | TASK [Set zuul-log-path fact] 2026-07-18 03:03:59.657824 | localhost | ok 2026-07-18 03:03:59.668112 | 2026-07-18 03:03:59.668229 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-18 03:03:59.719503 | localhost | ok 2026-07-18 03:03:59.722579 | 2026-07-18 03:03:59.722687 | TASK [upload-logs : Create log directories] 2026-07-18 03:04:00.594115 | localhost | changed 2026-07-18 03:04:00.596492 | 2026-07-18 03:04:00.596587 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-18 03:04:01.571811 | localhost -> localhost | ok: Runtime: 0:00:00.011157 2026-07-18 03:04:01.575099 | 2026-07-18 03:04:01.575202 | TASK [upload-logs : Upload logs to log server] 2026-07-18 03:04:02.706718 | localhost | Output suppressed because no_log was given 2026-07-18 03:04:02.708258 | 2026-07-18 03:04:02.708355 | LOOP [upload-logs : Compress console log and json output] 2026-07-18 03:04:02.846402 | localhost | skipping: Conditional result was False 2026-07-18 03:04:02.873833 | localhost | skipping: Conditional result was False 2026-07-18 03:04:02.877360 | 2026-07-18 03:04:02.877468 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-18 03:04:02.954479 | localhost | skipping: Conditional result was False 2026-07-18 03:04:02.954760 | 2026-07-18 03:04:02.959513 | localhost | skipping: Conditional result was False 2026-07-18 03:04:02.964341 | 2026-07-18 03:04:02.964447 | LOOP [upload-logs : Upload console log and json output]