2026-05-05 08:25:34.836047 | Job console starting 2026-05-05 08:25:34.846097 | Updating git repos 2026-05-05 08:25:34.896587 | Cloning repos into workspace 2026-05-05 08:25:35.033455 | Restoring repo states 2026-05-05 08:25:35.045295 | Merging changes 2026-05-05 08:25:35.883077 | Checking out repos 2026-05-05 08:25:35.985850 | Preparing playbooks 2026-05-05 08:25:37.236140 | Running Ansible setup 2026-05-05 08:25:43.447168 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-05 08:25:45.106411 | 2026-05-05 08:25:45.106603 | PLAY [Base pre] 2026-05-05 08:25:45.174017 | 2026-05-05 08:25:45.174162 | TASK [Setup log path fact] 2026-05-05 08:25:45.213976 | debian-bookworm | ok 2026-05-05 08:25:45.256446 | 2026-05-05 08:25:45.256594 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-05 08:25:45.310956 | debian-bookworm | ok 2026-05-05 08:25:45.320666 | 2026-05-05 08:25:45.320807 | TASK [emit-job-header : Print job information] 2026-05-05 08:25:45.436585 | # Job Information 2026-05-05 08:25:45.436837 | Ansible Version: 2.16.14 2026-05-05 08:25:45.436895 | Job: yamllint 2026-05-05 08:25:45.436933 | Pipeline: check 2026-05-05 08:25:45.436956 | Executor: 521e9411259a 2026-05-05 08:25:45.436978 | Triggered by: https://github.com/osism/node-image/pull/121 2026-05-05 08:25:45.437001 | Event ID: 7b13e040-485b-11f1-948c-9c94ad45f706 2026-05-05 08:25:45.468643 | 2026-05-05 08:25:45.468812 | LOOP [emit-job-header : Print node information] 2026-05-05 08:25:45.691636 | debian-bookworm | ok: 2026-05-05 08:25:45.704942 | debian-bookworm | # Node Information 2026-05-05 08:25:45.706070 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-05 08:25:45.706123 | debian-bookworm | Hostname: debian 2026-05-05 08:25:45.706146 | debian-bookworm | Username: zuul 2026-05-05 08:25:45.706164 | debian-bookworm | Distro: Debian 12.13 2026-05-05 08:25:45.706184 | debian-bookworm | Provider: regiocloud-a 2026-05-05 08:25:45.706302 | debian-bookworm | Region: 2026-05-05 08:25:45.706353 | debian-bookworm | Label: debian-bookworm 2026-05-05 08:25:45.706376 | debian-bookworm | Product Name: OpenStack Nova 2026-05-05 08:25:45.706395 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee5:c1e5 2026-05-05 08:25:45.732321 | 2026-05-05 08:25:45.732447 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-05 08:25:46.576399 | debian-bookworm -> localhost | changed 2026-05-05 08:25:46.582268 | 2026-05-05 08:25:46.582360 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-05 08:25:48.389426 | debian-bookworm -> localhost | changed 2026-05-05 08:25:48.419531 | 2026-05-05 08:25:48.419757 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-05 08:25:48.967523 | debian-bookworm -> localhost | ok 2026-05-05 08:25:48.974568 | 2026-05-05 08:25:48.974669 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-05 08:25:49.024647 | debian-bookworm | ok 2026-05-05 08:25:49.049895 | debian-bookworm | included: /var/lib/zuul/builds/dcd56da464884b61aebc75163c7063a8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-05 08:25:49.059353 | 2026-05-05 08:25:49.059443 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-05 08:25:51.083731 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-05 08:25:51.083940 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/dcd56da464884b61aebc75163c7063a8/work/dcd56da464884b61aebc75163c7063a8_id_rsa 2026-05-05 08:25:51.083976 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/dcd56da464884b61aebc75163c7063a8/work/dcd56da464884b61aebc75163c7063a8_id_rsa.pub 2026-05-05 08:25:51.084003 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-05 08:25:51.084028 | debian-bookworm -> localhost | SHA256:EoTVKmHesvOlBYOyQwwl6uVrxqTZ/FJ7Txy00uztlu8 zuul-build-sshkey 2026-05-05 08:25:51.084050 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-05 08:25:51.084081 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-05 08:25:51.084102 | debian-bookworm -> localhost | |... oo. | 2026-05-05 08:25:51.084124 | debian-bookworm -> localhost | |o. +. . | 2026-05-05 08:25:51.084145 | debian-bookworm -> localhost | |.o + +.. . | 2026-05-05 08:25:51.084165 | debian-bookworm -> localhost | |. * = =.+ . | 2026-05-05 08:25:51.084184 | debian-bookworm -> localhost | | o = +.+S= | 2026-05-05 08:25:51.084208 | debian-bookworm -> localhost | | X +. .* o | 2026-05-05 08:25:51.084228 | debian-bookworm -> localhost | | o O.o.+ + .. | 2026-05-05 08:25:51.084248 | debian-bookworm -> localhost | | o...o.. .o | 2026-05-05 08:25:51.084269 | debian-bookworm -> localhost | | ... ....oE | 2026-05-05 08:25:51.084290 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-05 08:25:51.084338 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.351413 2026-05-05 08:25:51.091739 | 2026-05-05 08:25:51.091855 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-05 08:25:51.129600 | debian-bookworm | ok 2026-05-05 08:25:51.138449 | debian-bookworm | included: /var/lib/zuul/builds/dcd56da464884b61aebc75163c7063a8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-05 08:25:51.147619 | 2026-05-05 08:25:51.147732 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-05 08:25:51.160713 | debian-bookworm | skipping: Conditional result was False 2026-05-05 08:25:51.167122 | 2026-05-05 08:25:51.167234 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-05 08:25:51.817569 | debian-bookworm | changed 2026-05-05 08:25:51.840842 | 2026-05-05 08:25:51.840957 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-05 08:25:52.112456 | debian-bookworm | ok 2026-05-05 08:25:52.120098 | 2026-05-05 08:25:52.120208 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-05 08:25:52.954269 | debian-bookworm | changed 2026-05-05 08:25:52.966478 | 2026-05-05 08:25:52.966594 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-05 08:25:53.690800 | debian-bookworm | changed 2026-05-05 08:25:53.700609 | 2026-05-05 08:25:53.700764 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-05 08:25:53.725374 | debian-bookworm | skipping: Conditional result was False 2026-05-05 08:25:53.735165 | 2026-05-05 08:25:53.735280 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-05 08:25:54.378721 | debian-bookworm -> localhost | changed 2026-05-05 08:25:54.391190 | 2026-05-05 08:25:54.391289 | TASK [add-build-sshkey : Add back temp key] 2026-05-05 08:25:54.751489 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/dcd56da464884b61aebc75163c7063a8/work/dcd56da464884b61aebc75163c7063a8_id_rsa (zuul-build-sshkey) 2026-05-05 08:25:54.751728 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010781 2026-05-05 08:25:54.765442 | 2026-05-05 08:25:54.765553 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-05 08:25:55.253102 | debian-bookworm | ok 2026-05-05 08:25:55.261190 | 2026-05-05 08:25:55.261309 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-05 08:25:55.294761 | debian-bookworm | skipping: Conditional result was False 2026-05-05 08:25:55.306250 | 2026-05-05 08:25:55.306371 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-05 08:25:55.882468 | debian-bookworm | ok 2026-05-05 08:25:55.909851 | 2026-05-05 08:25:55.910012 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-05 08:25:55.967398 | debian-bookworm | ok 2026-05-05 08:25:55.977813 | 2026-05-05 08:25:55.977956 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-05 08:25:56.464551 | debian-bookworm -> localhost | ok 2026-05-05 08:25:56.481522 | 2026-05-05 08:25:56.484423 | TASK [validate-host : Collect information about the host] 2026-05-05 08:25:57.665153 | debian-bookworm | ok 2026-05-05 08:25:57.688855 | 2026-05-05 08:25:57.689010 | TASK [validate-host : Sanitize hostname] 2026-05-05 08:25:57.812777 | debian-bookworm | ok 2026-05-05 08:25:57.898661 | 2026-05-05 08:25:57.898888 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-05 08:25:58.962587 | debian-bookworm -> localhost | changed 2026-05-05 08:25:58.975534 | 2026-05-05 08:25:58.976281 | TASK [validate-host : Collect information about zuul worker] 2026-05-05 08:25:59.471597 | debian-bookworm | ok 2026-05-05 08:25:59.480262 | 2026-05-05 08:25:59.480409 | TASK [validate-host : Write out all zuul information for each host] 2026-05-05 08:26:00.426268 | debian-bookworm -> localhost | changed 2026-05-05 08:26:00.439676 | 2026-05-05 08:26:00.439860 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-05 08:26:00.774920 | debian-bookworm | ok 2026-05-05 08:26:00.783103 | 2026-05-05 08:26:00.783240 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-05 08:26:02.783945 | debian-bookworm | changed: 2026-05-05 08:26:02.784162 | debian-bookworm | cd+++++++++ src/ 2026-05-05 08:26:02.784197 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-05 08:26:02.784220 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-05 08:26:02.784241 | debian-bookworm | cd+++++++++ src/github.com/osism/node-image/ 2026-05-05 08:26:02.784261 | debian-bookworm | Containerfile 2026-05-05 08:26:02.784391 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/dcd56da464884b61aebc75163c7063a8/work/logs" 2026-05-05 08:26:30.901983 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/dcd56da464884b61aebc75163c7063a8/work/artifacts" 2026-05-05 08:26:31.166706 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/dcd56da464884b61aebc75163c7063a8/work/docs" 2026-05-05 08:26:31.196087 | 2026-05-05 08:26:31.196248 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-05 08:26:32.273743 | debian-bookworm | changed: 2026-05-05 08:26:32.274055 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-05 08:26:32.274093 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-05 08:26:32.274122 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-05 08:26:32.274174 | debian-bookworm | changed: All items complete 2026-05-05 08:26:32.274201 | 2026-05-05 08:26:33.038426 | debian-bookworm | changed: .d..t...... ./ 2026-05-05 08:26:33.878265 | debian-bookworm | changed: .d..t...... ./ 2026-05-05 08:26:33.895605 | 2026-05-05 08:26:33.895798 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-05 08:26:34.650728 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009936 2026-05-05 08:26:34.976765 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.018226 2026-05-05 08:26:34.989002 | 2026-05-05 08:26:34.989109 | PLAY RECAP 2026-05-05 08:26:34.989164 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-05 08:26:34.989190 | 2026-05-05 08:26:35.374438 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-05 08:26:35.375883 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-05 08:26:36.646987 | 2026-05-05 08:26:36.647177 | PLAY [Base post] 2026-05-05 08:26:36.678736 | 2026-05-05 08:26:36.678979 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-05 08:26:37.401756 | debian-bookworm | changed 2026-05-05 08:26:37.411240 | 2026-05-05 08:26:37.411335 | PLAY RECAP 2026-05-05 08:26:37.411390 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-05 08:26:37.411442 | 2026-05-05 08:26:37.622430 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-05 08:26:37.625016 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-05 08:26:38.943360 | 2026-05-05 08:26:38.943488 | PLAY [Base post-logs] 2026-05-05 08:26:38.958895 | 2026-05-05 08:26:38.959019 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-05 08:26:39.620331 | localhost | changed 2026-05-05 08:26:39.646138 | 2026-05-05 08:26:39.646282 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-05 08:26:39.701876 | localhost | ok 2026-05-05 08:26:39.706304 | 2026-05-05 08:26:39.706397 | TASK [Set zuul-log-path fact] 2026-05-05 08:26:39.744689 | localhost | ok 2026-05-05 08:26:39.759510 | 2026-05-05 08:26:39.759626 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-05 08:26:39.807651 | localhost | ok 2026-05-05 08:26:39.815746 | 2026-05-05 08:26:39.816026 | TASK [upload-logs : Create log directories] 2026-05-05 08:26:40.501865 | localhost | changed 2026-05-05 08:26:40.504856 | 2026-05-05 08:26:40.504982 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-05 08:26:40.945215 | localhost -> localhost | ok: Runtime: 0:00:00.014991 2026-05-05 08:26:40.949176 | 2026-05-05 08:26:40.949277 | TASK [upload-logs : Upload logs to log server] 2026-05-05 08:26:41.736548 | localhost | Output suppressed because no_log was given 2026-05-05 08:26:41.738513 | 2026-05-05 08:26:41.738624 | LOOP [upload-logs : Compress console log and json output] 2026-05-05 08:26:41.839343 | localhost | skipping: Conditional result was False 2026-05-05 08:26:41.848542 | localhost | skipping: Conditional result was False 2026-05-05 08:26:41.856491 | 2026-05-05 08:26:41.856634 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-05 08:26:41.919078 | localhost | skipping: Conditional result was False 2026-05-05 08:26:41.919418 | 2026-05-05 08:26:41.924430 | localhost | skipping: Conditional result was False 2026-05-05 08:26:41.928298 | 2026-05-05 08:26:41.928446 | LOOP [upload-logs : Upload console log and json output]