2026-05-26 16:24:30.267887 | Job console starting 2026-05-26 16:24:30.287436 | Updating git repos 2026-05-26 16:24:30.315169 | Cloning repos into workspace 2026-05-26 16:24:30.365847 | Restoring repo states 2026-05-26 16:24:30.376378 | Merging changes 2026-05-26 16:24:31.054978 | Checking out repos 2026-05-26 16:24:31.104442 | Preparing playbooks 2026-05-26 16:24:32.010904 | Running Ansible setup 2026-05-26 16:24:36.889481 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-26 16:24:37.683747 | 2026-05-26 16:24:37.683921 | PLAY [Base pre] 2026-05-26 16:24:37.701528 | 2026-05-26 16:24:37.701687 | TASK [Setup log path fact] 2026-05-26 16:24:37.721775 | debian-bookworm | ok 2026-05-26 16:24:37.738571 | 2026-05-26 16:24:37.738741 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-26 16:24:37.768021 | debian-bookworm | ok 2026-05-26 16:24:37.778279 | 2026-05-26 16:24:37.778407 | TASK [emit-job-header : Print job information] 2026-05-26 16:24:37.817989 | # Job Information 2026-05-26 16:24:37.818200 | Ansible Version: 2.16.14 2026-05-26 16:24:37.818238 | Job: ansible-lint 2026-05-26 16:24:37.818271 | Pipeline: check 2026-05-26 16:24:37.818295 | Executor: 521e9411259a 2026-05-26 16:24:37.818316 | Triggered by: https://github.com/osism/testbed/pull/2863 2026-05-26 16:24:37.818339 | Event ID: 58ffe6a0-591f-11f1-9390-cbb6a9cabb5f 2026-05-26 16:24:37.823557 | 2026-05-26 16:24:37.823684 | LOOP [emit-job-header : Print node information] 2026-05-26 16:24:37.960008 | debian-bookworm | ok: 2026-05-26 16:24:37.960313 | debian-bookworm | # Node Information 2026-05-26 16:24:37.960355 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-26 16:24:37.960382 | debian-bookworm | Hostname: debian 2026-05-26 16:24:37.960405 | debian-bookworm | Username: zuul 2026-05-26 16:24:37.960425 | debian-bookworm | Distro: Debian 12.14 2026-05-26 16:24:37.960450 | debian-bookworm | Provider: regiocloud-a 2026-05-26 16:24:37.960472 | debian-bookworm | Region: 2026-05-26 16:24:37.960493 | debian-bookworm | Label: debian-bookworm 2026-05-26 16:24:37.960514 | debian-bookworm | Product Name: OpenStack Nova 2026-05-26 16:24:37.960534 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe52:d8e6 2026-05-26 16:24:37.982315 | 2026-05-26 16:24:37.982480 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-26 16:24:38.555729 | debian-bookworm -> localhost | changed 2026-05-26 16:24:38.572435 | 2026-05-26 16:24:38.572630 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-26 16:24:39.815028 | debian-bookworm -> localhost | changed 2026-05-26 16:24:39.831525 | 2026-05-26 16:24:39.831679 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-26 16:24:40.132103 | debian-bookworm -> localhost | ok 2026-05-26 16:24:40.138878 | 2026-05-26 16:24:40.139019 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-26 16:24:40.169991 | debian-bookworm | ok 2026-05-26 16:24:40.185880 | debian-bookworm | included: /var/lib/zuul/builds/9eb90d49a5fc4bbdaa56246c3b08ea0a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-26 16:24:40.192536 | 2026-05-26 16:24:40.192658 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-26 16:24:41.375872 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-26 16:24:41.376231 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9eb90d49a5fc4bbdaa56246c3b08ea0a/work/9eb90d49a5fc4bbdaa56246c3b08ea0a_id_rsa 2026-05-26 16:24:41.376296 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9eb90d49a5fc4bbdaa56246c3b08ea0a/work/9eb90d49a5fc4bbdaa56246c3b08ea0a_id_rsa.pub 2026-05-26 16:24:41.376340 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-26 16:24:41.376380 | debian-bookworm -> localhost | SHA256:cvwtt17vLEBDn2kp4mn0ftaD7xP3YKR7OPzxwdmLbRI zuul-build-sshkey 2026-05-26 16:24:41.376418 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-26 16:24:41.376471 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-26 16:24:41.376508 | debian-bookworm -> localhost | | | 2026-05-26 16:24:41.376544 | debian-bookworm -> localhost | | . | 2026-05-26 16:24:41.376577 | debian-bookworm -> localhost | | . . + | 2026-05-26 16:24:41.376609 | debian-bookworm -> localhost | | . o + B | 2026-05-26 16:24:41.376642 | debian-bookworm -> localhost | | . So = * | 2026-05-26 16:24:41.376678 | debian-bookworm -> localhost | | o .+.+E+.+| 2026-05-26 16:24:41.376714 | debian-bookworm -> localhost | | .ooo==*=| 2026-05-26 16:24:41.376747 | debian-bookworm -> localhost | | o*=BO=| 2026-05-26 16:24:41.376780 | debian-bookworm -> localhost | | .oB*BB| 2026-05-26 16:24:41.376813 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-26 16:24:41.376888 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.598211 2026-05-26 16:24:41.386862 | 2026-05-26 16:24:41.386994 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-26 16:24:41.430264 | debian-bookworm | ok 2026-05-26 16:24:41.449411 | debian-bookworm | included: /var/lib/zuul/builds/9eb90d49a5fc4bbdaa56246c3b08ea0a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-26 16:24:41.458916 | 2026-05-26 16:24:41.459027 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-26 16:24:41.483148 | debian-bookworm | skipping: Conditional result was False 2026-05-26 16:24:41.489388 | 2026-05-26 16:24:41.489504 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-26 16:24:42.190009 | debian-bookworm | changed 2026-05-26 16:24:42.200851 | 2026-05-26 16:24:42.200999 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-26 16:24:42.472508 | debian-bookworm | ok 2026-05-26 16:24:42.484942 | 2026-05-26 16:24:42.485127 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-26 16:24:43.137580 | debian-bookworm | changed 2026-05-26 16:24:43.146377 | 2026-05-26 16:24:43.146693 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-26 16:24:43.826240 | debian-bookworm | changed 2026-05-26 16:24:43.832163 | 2026-05-26 16:24:43.832289 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-26 16:24:43.867184 | debian-bookworm | skipping: Conditional result was False 2026-05-26 16:24:43.874522 | 2026-05-26 16:24:43.874655 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-26 16:24:44.375382 | debian-bookworm -> localhost | changed 2026-05-26 16:24:44.394324 | 2026-05-26 16:24:44.394480 | TASK [add-build-sshkey : Add back temp key] 2026-05-26 16:24:44.734206 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9eb90d49a5fc4bbdaa56246c3b08ea0a/work/9eb90d49a5fc4bbdaa56246c3b08ea0a_id_rsa (zuul-build-sshkey) 2026-05-26 16:24:44.734458 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013237 2026-05-26 16:24:44.743542 | 2026-05-26 16:24:44.743680 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-26 16:24:45.161103 | debian-bookworm | ok 2026-05-26 16:24:45.171286 | 2026-05-26 16:24:45.171431 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-26 16:24:45.195871 | debian-bookworm | skipping: Conditional result was False 2026-05-26 16:24:45.207571 | 2026-05-26 16:24:45.207737 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-26 16:24:45.669950 | debian-bookworm | ok 2026-05-26 16:24:45.687115 | 2026-05-26 16:24:45.687275 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-26 16:24:45.720523 | debian-bookworm | ok 2026-05-26 16:24:45.726133 | 2026-05-26 16:24:45.726263 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-26 16:24:46.015509 | debian-bookworm -> localhost | ok 2026-05-26 16:24:46.029708 | 2026-05-26 16:24:46.029864 | TASK [validate-host : Collect information about the host] 2026-05-26 16:24:47.192464 | debian-bookworm | ok 2026-05-26 16:24:47.206503 | 2026-05-26 16:24:47.206655 | TASK [validate-host : Sanitize hostname] 2026-05-26 16:24:47.318278 | debian-bookworm | ok 2026-05-26 16:24:47.366926 | 2026-05-26 16:24:47.367101 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-26 16:24:47.972513 | debian-bookworm -> localhost | changed 2026-05-26 16:24:47.978799 | 2026-05-26 16:24:47.978947 | TASK [validate-host : Collect information about zuul worker] 2026-05-26 16:24:48.406306 | debian-bookworm | ok 2026-05-26 16:24:48.413901 | 2026-05-26 16:24:48.414058 | TASK [validate-host : Write out all zuul information for each host] 2026-05-26 16:24:49.048739 | debian-bookworm -> localhost | changed 2026-05-26 16:24:49.059129 | 2026-05-26 16:24:49.059261 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-26 16:24:49.356670 | debian-bookworm | ok 2026-05-26 16:24:49.363264 | 2026-05-26 16:24:49.363393 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-26 16:24:50.624883 | debian-bookworm | changed: 2026-05-26 16:24:50.625125 | debian-bookworm | cd+++++++++ src/ 2026-05-26 16:24:50.625162 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-26 16:24:50.625186 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-26 16:24:50.625209 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-05-26 16:24:50.625230 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/9eb90d49a5fc4bbdaa56246c3b08ea0a/work/logs" 2026-05-26 16:26:00.731664 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9eb90d49a5fc4bbdaa56246c3b08ea0a/work/artifacts" 2026-05-26 16:26:01.000266 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9eb90d49a5fc4bbdaa56246c3b08ea0a/work/docs" 2026-05-26 16:26:01.022856 | 2026-05-26 16:26:01.023078 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-26 16:26:01.860796 | debian-bookworm | changed: 2026-05-26 16:26:01.861277 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-26 16:26:01.861368 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-26 16:26:01.861441 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-26 16:26:01.861554 | debian-bookworm | changed: All items complete 2026-05-26 16:26:01.861620 | 2026-05-26 16:26:02.430734 | debian-bookworm | changed: .d..t...... ./ 2026-05-26 16:26:03.022557 | debian-bookworm | changed: .d..t...... ./ 2026-05-26 16:26:03.049988 | 2026-05-26 16:26:03.050218 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-26 16:26:03.590151 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.010132 2026-05-26 16:26:03.873837 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010490 2026-05-26 16:26:03.889948 | 2026-05-26 16:26:03.890112 | PLAY RECAP 2026-05-26 16:26:03.890181 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-26 16:26:03.890211 | 2026-05-26 16:26:04.042111 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-26 16:26:04.044223 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-26 16:26:04.794100 | 2026-05-26 16:26:04.794279 | PLAY [Base post] 2026-05-26 16:26:04.808507 | 2026-05-26 16:26:04.808678 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-26 16:26:05.343320 | debian-bookworm | changed 2026-05-26 16:26:05.354639 | 2026-05-26 16:26:05.354929 | PLAY RECAP 2026-05-26 16:26:05.355095 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-26 16:26:05.355249 | 2026-05-26 16:26:05.494129 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-26 16:26:05.495181 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-26 16:26:06.340180 | 2026-05-26 16:26:06.340380 | PLAY [Base post-logs] 2026-05-26 16:26:06.351820 | 2026-05-26 16:26:06.351966 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-26 16:26:06.825622 | localhost | changed 2026-05-26 16:26:06.835863 | 2026-05-26 16:26:06.836028 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-26 16:26:06.863031 | localhost | ok 2026-05-26 16:26:06.867007 | 2026-05-26 16:26:06.867152 | TASK [Set zuul-log-path fact] 2026-05-26 16:26:06.882290 | localhost | ok 2026-05-26 16:26:06.890114 | 2026-05-26 16:26:06.890227 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-26 16:26:06.916401 | localhost | ok 2026-05-26 16:26:06.919359 | 2026-05-26 16:26:06.919457 | TASK [upload-logs : Create log directories] 2026-05-26 16:26:07.412170 | localhost | changed 2026-05-26 16:26:07.417003 | 2026-05-26 16:26:07.417202 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-26 16:26:07.924072 | localhost -> localhost | ok: Runtime: 0:00:00.006852 2026-05-26 16:26:07.932293 | 2026-05-26 16:26:07.932526 | TASK [upload-logs : Upload logs to log server] 2026-05-26 16:26:08.513922 | localhost | Output suppressed because no_log was given 2026-05-26 16:26:08.517114 | 2026-05-26 16:26:08.517279 | LOOP [upload-logs : Compress console log and json output] 2026-05-26 16:26:08.572450 | localhost | skipping: Conditional result was False 2026-05-26 16:26:08.578438 | localhost | skipping: Conditional result was False 2026-05-26 16:26:08.587231 | 2026-05-26 16:26:08.587401 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-26 16:26:08.637523 | localhost | skipping: Conditional result was False 2026-05-26 16:26:08.638275 | 2026-05-26 16:26:08.642285 | localhost | skipping: Conditional result was False 2026-05-26 16:26:08.649692 | 2026-05-26 16:26:08.649917 | LOOP [upload-logs : Upload console log and json output]