2026-05-24 03:01:41.664899 | Job console starting 2026-05-24 03:01:41.692788 | Updating git repos 2026-05-24 03:01:41.721816 | Cloning repos into workspace 2026-05-24 03:01:41.821493 | Restoring repo states 2026-05-24 03:01:41.847999 | Merging changes 2026-05-24 03:01:41.848014 | Checking out repos 2026-05-24 03:01:41.994358 | Preparing playbooks 2026-05-24 03:01:43.361881 | Running Ansible setup 2026-05-24 03:01:49.468718 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-24 03:01:51.090651 | 2026-05-24 03:01:51.090789 | PLAY [Base pre] 2026-05-24 03:01:51.193201 | 2026-05-24 03:01:51.193340 | TASK [Setup log path fact] 2026-05-24 03:01:51.281072 | debian-bookworm | ok 2026-05-24 03:01:51.313174 | 2026-05-24 03:01:51.313292 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-24 03:01:51.442497 | debian-bookworm | ok 2026-05-24 03:01:51.454300 | 2026-05-24 03:01:51.454392 | TASK [emit-job-header : Print job information] 2026-05-24 03:01:51.525998 | # Job Information 2026-05-24 03:01:51.526229 | Ansible Version: 2.16.14 2026-05-24 03:01:51.526261 | Job: ansible-lint 2026-05-24 03:01:51.526289 | Pipeline: periodic-daily 2026-05-24 03:01:51.526308 | Executor: 521e9411259a 2026-05-24 03:01:51.526325 | Triggered by: https://github.com/osism/metalbox 2026-05-24 03:01:51.526343 | Event ID: ac3714bf6642412ab9f8cac156d6034c 2026-05-24 03:01:51.532704 | 2026-05-24 03:01:51.533035 | LOOP [emit-job-header : Print node information] 2026-05-24 03:01:51.760651 | debian-bookworm | ok: 2026-05-24 03:01:51.761223 | debian-bookworm | # Node Information 2026-05-24 03:01:51.761268 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-24 03:01:51.761291 | debian-bookworm | Hostname: debian 2026-05-24 03:01:51.761309 | debian-bookworm | Username: zuul 2026-05-24 03:01:51.761327 | debian-bookworm | Distro: Debian 12.14 2026-05-24 03:01:51.761346 | debian-bookworm | Provider: regiocloud-a 2026-05-24 03:01:51.761363 | debian-bookworm | Region: 2026-05-24 03:01:51.761380 | debian-bookworm | Label: debian-bookworm 2026-05-24 03:01:51.761396 | debian-bookworm | Product Name: OpenStack Nova 2026-05-24 03:01:51.761411 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe03:d2b7 2026-05-24 03:01:51.781488 | 2026-05-24 03:01:51.782306 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-24 03:01:52.697408 | debian-bookworm -> localhost | changed 2026-05-24 03:01:52.703433 | 2026-05-24 03:01:52.703524 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-24 03:01:55.007205 | debian-bookworm -> localhost | changed 2026-05-24 03:01:55.053568 | 2026-05-24 03:01:55.053690 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-24 03:01:55.642128 | debian-bookworm -> localhost | ok 2026-05-24 03:01:55.648511 | 2026-05-24 03:01:55.648668 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-24 03:01:55.697205 | debian-bookworm | ok 2026-05-24 03:01:55.718184 | debian-bookworm | included: /var/lib/zuul/builds/8cf8410d154242a089b33f6a95b753df/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-24 03:01:55.724837 | 2026-05-24 03:01:55.724950 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-24 03:01:58.895861 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-24 03:01:58.896038 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8cf8410d154242a089b33f6a95b753df/work/8cf8410d154242a089b33f6a95b753df_id_rsa 2026-05-24 03:01:58.896068 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8cf8410d154242a089b33f6a95b753df/work/8cf8410d154242a089b33f6a95b753df_id_rsa.pub 2026-05-24 03:01:58.896090 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-24 03:01:58.896109 | debian-bookworm -> localhost | SHA256:b7TEygxAbdF2xl9/fqzHhNdlObsgCiqN/H5Vkp4KQko zuul-build-sshkey 2026-05-24 03:01:58.896127 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-24 03:01:58.896153 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-24 03:01:58.896171 | debian-bookworm -> localhost | | ...o . | 2026-05-24 03:01:58.896188 | debian-bookworm -> localhost | | . o o + . | 2026-05-24 03:01:58.896204 | debian-bookworm -> localhost | | .. . o.. . ..| 2026-05-24 03:01:58.896220 | debian-bookworm -> localhost | | E . . + .. o=| 2026-05-24 03:01:58.896236 | debian-bookworm -> localhost | |. o . S B =*| 2026-05-24 03:01:58.896256 | debian-bookworm -> localhost | | . . . = O o ...B| 2026-05-24 03:01:58.896272 | debian-bookworm -> localhost | | . + o B = . .=o| 2026-05-24 03:01:58.896288 | debian-bookworm -> localhost | | + o o o ..o| 2026-05-24 03:01:58.896305 | debian-bookworm -> localhost | | +o. . | 2026-05-24 03:01:58.896321 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-24 03:01:58.896360 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.236255 2026-05-24 03:01:58.901762 | 2026-05-24 03:01:58.902226 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-24 03:01:58.928550 | debian-bookworm | ok 2026-05-24 03:01:58.938117 | debian-bookworm | included: /var/lib/zuul/builds/8cf8410d154242a089b33f6a95b753df/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-24 03:01:58.951099 | 2026-05-24 03:01:58.951180 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-24 03:01:58.987039 | debian-bookworm | skipping: Conditional result was False 2026-05-24 03:01:58.991852 | 2026-05-24 03:01:58.991951 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-24 03:01:59.841414 | debian-bookworm | changed 2026-05-24 03:01:59.846058 | 2026-05-24 03:01:59.846140 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-24 03:02:00.134752 | debian-bookworm | ok 2026-05-24 03:02:00.161236 | 2026-05-24 03:02:00.163083 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-24 03:02:00.958581 | debian-bookworm | changed 2026-05-24 03:02:00.970368 | 2026-05-24 03:02:00.970473 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-24 03:02:01.731647 | debian-bookworm | changed 2026-05-24 03:02:01.736939 | 2026-05-24 03:02:01.737032 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-24 03:02:01.770218 | debian-bookworm | skipping: Conditional result was False 2026-05-24 03:02:01.776107 | 2026-05-24 03:02:01.776206 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-24 03:02:02.706805 | debian-bookworm -> localhost | changed 2026-05-24 03:02:02.717340 | 2026-05-24 03:02:02.717440 | TASK [add-build-sshkey : Add back temp key] 2026-05-24 03:02:03.509324 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8cf8410d154242a089b33f6a95b753df/work/8cf8410d154242a089b33f6a95b753df_id_rsa (zuul-build-sshkey) 2026-05-24 03:02:03.509505 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.027432 2026-05-24 03:02:03.516131 | 2026-05-24 03:02:03.516218 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-24 03:02:03.919867 | debian-bookworm | ok 2026-05-24 03:02:03.925222 | 2026-05-24 03:02:03.925307 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-24 03:02:03.958751 | debian-bookworm | skipping: Conditional result was False 2026-05-24 03:02:03.967327 | 2026-05-24 03:02:03.967415 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-24 03:02:04.420731 | debian-bookworm | ok 2026-05-24 03:02:04.434489 | 2026-05-24 03:02:04.434585 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-24 03:02:04.461406 | debian-bookworm | ok 2026-05-24 03:02:04.468144 | 2026-05-24 03:02:04.468293 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-24 03:02:04.804343 | debian-bookworm -> localhost | ok 2026-05-24 03:02:04.816446 | 2026-05-24 03:02:04.816536 | TASK [validate-host : Collect information about the host] 2026-05-24 03:02:06.153675 | debian-bookworm | ok 2026-05-24 03:02:06.171811 | 2026-05-24 03:02:06.171919 | TASK [validate-host : Sanitize hostname] 2026-05-24 03:02:06.315601 | debian-bookworm | ok 2026-05-24 03:02:06.380601 | 2026-05-24 03:02:06.380715 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-24 03:02:07.638524 | debian-bookworm -> localhost | changed 2026-05-24 03:02:07.644253 | 2026-05-24 03:02:07.644356 | TASK [validate-host : Collect information about zuul worker] 2026-05-24 03:02:08.177403 | debian-bookworm | ok 2026-05-24 03:02:08.182420 | 2026-05-24 03:02:08.182522 | TASK [validate-host : Write out all zuul information for each host] 2026-05-24 03:02:09.453531 | debian-bookworm -> localhost | changed 2026-05-24 03:02:09.463557 | 2026-05-24 03:02:09.463655 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-24 03:02:09.747249 | debian-bookworm | ok 2026-05-24 03:02:09.752719 | 2026-05-24 03:02:09.752818 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-24 03:02:10.950160 | debian-bookworm | changed: 2026-05-24 03:02:10.950333 | debian-bookworm | cd+++++++++ src/ 2026-05-24 03:02:10.950368 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-24 03:02:10.950392 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-24 03:02:10.950412 | debian-bookworm | cd+++++++++ src/github.com/osism/metalbox/ 2026-05-24 03:02:10.950432 | debian-bookworm | Containerfile 2026-05-24 03:02:10.968135 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/8cf8410d154242a089b33f6a95b753df/work/logs" 2026-05-24 03:02:46.261330 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/8cf8410d154242a089b33f6a95b753df/work/artifacts" 2026-05-24 03:02:46.781914 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/8cf8410d154242a089b33f6a95b753df/work/docs" 2026-05-24 03:02:46.795009 | 2026-05-24 03:02:46.795111 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-24 03:02:47.916208 | debian-bookworm | changed: 2026-05-24 03:02:47.916383 | debian-bookworm | .d..t...... ./ 2026-05-24 03:02:47.916413 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-24 03:02:47.916437 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-24 03:02:47.916458 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-24 03:02:47.916489 | debian-bookworm | changed: All items complete 2026-05-24 03:02:47.916507 | 2026-05-24 03:02:49.120540 | debian-bookworm | changed: .d..t...... ./ 2026-05-24 03:02:50.048661 | debian-bookworm | changed: .d..t...... ./ 2026-05-24 03:02:50.062025 | 2026-05-24 03:02:50.062122 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-24 03:02:50.160660 | debian-bookworm | skipping: Conditional result was False 2026-05-24 03:02:50.164172 | debian-bookworm | skipping: Conditional result was False 2026-05-24 03:02:50.172765 | 2026-05-24 03:02:50.172827 | PLAY RECAP 2026-05-24 03:02:50.172865 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-24 03:02:50.172885 | 2026-05-24 03:02:50.452387 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-24 03:02:50.453012 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-24 03:02:52.730423 | 2026-05-24 03:02:52.730545 | PLAY [Base post] 2026-05-24 03:02:52.772020 | 2026-05-24 03:02:52.772139 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-24 03:02:53.883761 | debian-bookworm | changed 2026-05-24 03:02:53.892148 | 2026-05-24 03:02:53.892241 | PLAY RECAP 2026-05-24 03:02:53.892292 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-24 03:02:53.892346 | 2026-05-24 03:02:54.130290 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-24 03:02:54.131136 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-24 03:02:55.210814 | 2026-05-24 03:02:55.211107 | PLAY [Base post-logs] 2026-05-24 03:02:55.232232 | 2026-05-24 03:02:55.232362 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-24 03:02:56.431053 | localhost | changed 2026-05-24 03:02:56.439172 | 2026-05-24 03:02:56.439292 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-24 03:02:56.582065 | localhost | ok 2026-05-24 03:02:56.584907 | 2026-05-24 03:02:56.585011 | TASK [Set zuul-log-path fact] 2026-05-24 03:02:56.631007 | localhost | ok 2026-05-24 03:02:56.639515 | 2026-05-24 03:02:56.642041 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-24 03:02:56.713582 | localhost | ok 2026-05-24 03:02:56.716172 | 2026-05-24 03:02:56.716254 | TASK [upload-logs : Create log directories] 2026-05-24 03:02:58.237484 | localhost | changed 2026-05-24 03:02:58.240083 | 2026-05-24 03:02:58.240175 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-24 03:02:59.547266 | localhost -> localhost | ok: Runtime: 0:00:00.021246 2026-05-24 03:02:59.550717 | 2026-05-24 03:02:59.550814 | TASK [upload-logs : Upload logs to log server] 2026-05-24 03:03:00.284005 | localhost | Output suppressed because no_log was given 2026-05-24 03:03:00.285606 | 2026-05-24 03:03:00.285685 | LOOP [upload-logs : Compress console log and json output] 2026-05-24 03:03:00.377742 | localhost | skipping: Conditional result was False 2026-05-24 03:03:00.390806 | localhost | skipping: Conditional result was False 2026-05-24 03:03:00.401680 | 2026-05-24 03:03:00.401788 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-24 03:03:00.478320 | localhost | skipping: Conditional result was False 2026-05-24 03:03:00.478537 | 2026-05-24 03:03:00.488177 | localhost | skipping: Conditional result was False 2026-05-24 03:03:00.497827 | 2026-05-24 03:03:00.497938 | LOOP [upload-logs : Upload console log and json output]