2026-05-21 00:00:08.924911 | Job console starting 2026-05-21 00:00:08.937525 | Updating git repos 2026-05-21 00:00:09.109595 | Cloning repos into workspace 2026-05-21 00:00:09.421366 | Restoring repo states 2026-05-21 00:00:09.445700 | Merging changes 2026-05-21 00:00:09.445743 | Checking out repos 2026-05-21 00:00:09.822448 | Preparing playbooks 2026-05-21 00:00:11.252994 | Running Ansible setup 2026-05-21 00:00:19.435408 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-21 00:00:20.747412 | 2026-05-21 00:00:20.747532 | PLAY [Base pre] 2026-05-21 00:00:20.777903 | 2026-05-21 00:00:20.778009 | TASK [Setup log path fact] 2026-05-21 00:00:20.816722 | orchestrator | ok 2026-05-21 00:00:20.848204 | 2026-05-21 00:00:20.848372 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 00:00:20.919818 | orchestrator | ok 2026-05-21 00:00:20.939713 | 2026-05-21 00:00:20.939820 | TASK [emit-job-header : Print job information] 2026-05-21 00:00:20.978750 | # Job Information 2026-05-21 00:00:20.978899 | Ansible Version: 2.16.14 2026-05-21 00:00:20.978929 | Job: testbed-update-stable-current-ubuntu-24.04 2026-05-21 00:00:20.978957 | Pipeline: periodic-midnight 2026-05-21 00:00:20.978975 | Executor: 521e9411259a 2026-05-21 00:00:20.978992 | Triggered by: https://github.com/osism/testbed 2026-05-21 00:00:20.979009 | Event ID: 4de47e166b7c47aeaf752c77d16ae21f 2026-05-21 00:00:20.986890 | 2026-05-21 00:00:20.986980 | LOOP [emit-job-header : Print node information] 2026-05-21 00:00:21.386632 | orchestrator | ok: 2026-05-21 00:00:21.386866 | orchestrator | # Node Information 2026-05-21 00:00:21.386905 | orchestrator | Inventory Hostname: orchestrator 2026-05-21 00:00:21.386929 | orchestrator | Hostname: zuul-static-regiocloud-infra-1 2026-05-21 00:00:21.386951 | orchestrator | Username: zuul-testbed05 2026-05-21 00:00:21.386972 | orchestrator | Distro: Debian 12.14 2026-05-21 00:00:21.386995 | orchestrator | Provider: static-testbed 2026-05-21 00:00:21.387016 | orchestrator | Region: 2026-05-21 00:00:21.387038 | orchestrator | Label: testbed-orchestrator 2026-05-21 00:00:21.387058 | orchestrator | Product Name: OpenStack Nova 2026-05-21 00:00:21.387077 | orchestrator | Interface IP: 81.163.193.140 2026-05-21 00:00:21.412346 | 2026-05-21 00:00:21.412467 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-21 00:00:22.851572 | orchestrator -> localhost | changed 2026-05-21 00:00:22.858155 | 2026-05-21 00:00:22.858253 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-21 00:00:25.199152 | orchestrator -> localhost | changed 2026-05-21 00:00:25.218724 | 2026-05-21 00:00:25.218877 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-21 00:00:25.986396 | orchestrator -> localhost | ok 2026-05-21 00:00:25.992116 | 2026-05-21 00:00:25.992209 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-21 00:00:26.050317 | orchestrator | ok 2026-05-21 00:00:26.077303 | orchestrator | included: /var/lib/zuul/builds/b0f6381cb54646ba8429a5423ceb7883/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-21 00:00:26.102251 | 2026-05-21 00:00:26.102358 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-21 00:00:30.794163 | orchestrator -> localhost | Generating public/private rsa key pair. 2026-05-21 00:00:30.794345 | orchestrator -> localhost | Your identification has been saved in /var/lib/zuul/builds/b0f6381cb54646ba8429a5423ceb7883/work/b0f6381cb54646ba8429a5423ceb7883_id_rsa 2026-05-21 00:00:30.794378 | orchestrator -> localhost | Your public key has been saved in /var/lib/zuul/builds/b0f6381cb54646ba8429a5423ceb7883/work/b0f6381cb54646ba8429a5423ceb7883_id_rsa.pub 2026-05-21 00:00:30.794399 | orchestrator -> localhost | The key fingerprint is: 2026-05-21 00:00:30.794419 | orchestrator -> localhost | SHA256:eAtwEAuppUztdy2ezHf48R84kg2BizozxWB+FbML1u0 zuul-build-sshkey 2026-05-21 00:00:30.794437 | orchestrator -> localhost | The key's randomart image is: 2026-05-21 00:00:30.794465 | orchestrator -> localhost | +---[RSA 3072]----+ 2026-05-21 00:00:30.794484 | orchestrator -> localhost | | o.o. o | 2026-05-21 00:00:30.794501 | orchestrator -> localhost | | .oo o . * | 2026-05-21 00:00:30.794518 | orchestrator -> localhost | |o+. oo.o.= o | 2026-05-21 00:00:30.794535 | orchestrator -> localhost | |o. .o++++.+ . | 2026-05-21 00:00:30.794551 | orchestrator -> localhost | | ..B=So.E | 2026-05-21 00:00:30.794571 | orchestrator -> localhost | | +B + o+ . | 2026-05-21 00:00:30.794588 | orchestrator -> localhost | | = o ooo+ . | 2026-05-21 00:00:30.794615 | orchestrator -> localhost | | + .... .| 2026-05-21 00:00:30.794633 | orchestrator -> localhost | | .. | 2026-05-21 00:00:30.794650 | orchestrator -> localhost | +----[SHA256]-----+ 2026-05-21 00:00:30.794694 | orchestrator -> localhost | ok: Runtime: 0:00:03.108692 2026-05-21 00:00:30.800576 | 2026-05-21 00:00:30.800661 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-21 00:00:30.838443 | orchestrator | ok 2026-05-21 00:00:30.850610 | orchestrator | included: /var/lib/zuul/builds/b0f6381cb54646ba8429a5423ceb7883/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-21 00:00:30.870701 | 2026-05-21 00:00:30.870798 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-21 00:00:30.931437 | orchestrator | skipping: Conditional result was False 2026-05-21 00:00:30.937101 | 2026-05-21 00:00:30.937189 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-21 00:00:31.740559 | orchestrator | changed 2026-05-21 00:00:31.745755 | 2026-05-21 00:00:31.745832 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-21 00:00:32.027263 | orchestrator | ok 2026-05-21 00:00:32.041109 | 2026-05-21 00:00:32.041218 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-21 00:00:32.522504 | orchestrator | ok 2026-05-21 00:00:32.532891 | 2026-05-21 00:00:32.532992 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-21 00:00:33.051160 | orchestrator | ok 2026-05-21 00:00:33.057157 | 2026-05-21 00:00:33.057253 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-21 00:00:33.127054 | orchestrator | skipping: Conditional result was False 2026-05-21 00:00:33.134205 | 2026-05-21 00:00:33.134319 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-21 00:00:34.684189 | orchestrator -> localhost | changed 2026-05-21 00:00:34.695222 | 2026-05-21 00:00:34.695325 | TASK [add-build-sshkey : Add back temp key] 2026-05-21 00:00:35.851366 | orchestrator -> localhost | Identity added: /var/lib/zuul/builds/b0f6381cb54646ba8429a5423ceb7883/work/b0f6381cb54646ba8429a5423ceb7883_id_rsa (zuul-build-sshkey) 2026-05-21 00:00:35.851548 | orchestrator -> localhost | ok: Runtime: 0:00:00.019240 2026-05-21 00:00:35.857258 | 2026-05-21 00:00:35.857356 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-21 00:00:36.272410 | orchestrator | ok 2026-05-21 00:00:36.283803 | 2026-05-21 00:00:36.283900 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-21 00:00:36.306672 | orchestrator | skipping: Conditional result was False 2026-05-21 00:00:36.364040 | 2026-05-21 00:00:36.364140 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-21 00:00:37.005208 | orchestrator | ok 2026-05-21 00:00:37.031534 | 2026-05-21 00:00:37.031635 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-21 00:00:37.080388 | orchestrator | ok 2026-05-21 00:00:37.085389 | 2026-05-21 00:00:37.085479 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-21 00:00:37.945264 | orchestrator -> localhost | ok 2026-05-21 00:00:37.951212 | 2026-05-21 00:00:37.951307 | TASK [validate-host : Collect information about the host] 2026-05-21 00:00:39.774060 | orchestrator | ok 2026-05-21 00:00:39.799445 | 2026-05-21 00:00:39.799552 | TASK [validate-host : Sanitize hostname] 2026-05-21 00:00:39.889975 | orchestrator | ok 2026-05-21 00:00:39.894779 | 2026-05-21 00:00:39.895932 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-21 00:00:41.582065 | orchestrator -> localhost | changed 2026-05-21 00:00:41.587268 | 2026-05-21 00:00:41.587371 | TASK [validate-host : Collect information about zuul worker] 2026-05-21 00:00:42.011910 | orchestrator | ok 2026-05-21 00:00:42.021664 | 2026-05-21 00:00:42.021762 | TASK [validate-host : Write out all zuul information for each host] 2026-05-21 00:00:43.407602 | orchestrator -> localhost | changed 2026-05-21 00:00:43.418372 | 2026-05-21 00:00:43.418471 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-21 00:00:43.723340 | orchestrator | ok 2026-05-21 00:00:43.728670 | 2026-05-21 00:00:43.728755 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-21 00:02:06.432041 | orchestrator | changed: 2026-05-21 00:02:06.433225 | orchestrator | .d..t...... src/ 2026-05-21 00:02:06.433310 | orchestrator | .d..t...... src/github.com/ 2026-05-21 00:02:06.433339 | orchestrator | .d..t...... src/github.com/osism/ 2026-05-21 00:02:06.433362 | orchestrator | .d..t...... src/github.com/osism/ansible-collection-commons/ 2026-05-21 00:02:06.433386 | orchestrator | RedHat.yml 2026-05-21 00:02:06.449379 | orchestrator | .L..t...... src/github.com/osism/ansible-collection-commons/roles/repository/tasks/CentOS.yml -> RedHat.yml 2026-05-21 00:02:06.449396 | orchestrator | RedHat.yml 2026-05-21 00:02:06.449448 | orchestrator | localhost | ok: "/var/lib/zuul/builds/b0f6381cb54646ba8429a5423ceb7883/work/logs" 2026-05-21 00:02:16.174118 | orchestrator -> localhost | changed: "/var/lib/zuul/builds/b0f6381cb54646ba8429a5423ceb7883/work/artifacts" 2026-05-21 00:02:16.575769 | orchestrator -> localhost | changed: "/var/lib/zuul/builds/b0f6381cb54646ba8429a5423ceb7883/work/docs" 2026-05-21 00:02:16.588603 | 2026-05-21 00:02:16.588753 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-21 00:02:17.932509 | orchestrator | changed: 2026-05-21 00:02:17.932755 | orchestrator | .d..t...... ./ 2026-05-21 00:02:17.932794 | orchestrator | >f+++++++++ sudo-debug.txt 2026-05-21 00:02:17.932825 | orchestrator | >f+++++++++ sudo-strace.log 2026-05-21 00:02:17.932853 | orchestrator | >f+++++++++ sudo-strace.log.time 2026-05-21 00:02:17.932895 | orchestrator | changed: All items complete 2026-05-21 00:02:17.932922 | 2026-05-21 00:02:18.869822 | orchestrator | changed: .d..t...... ./ 2026-05-21 00:02:19.693875 | orchestrator | changed: .d..t...... ./ 2026-05-21 00:02:19.711986 | 2026-05-21 00:02:19.712120 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-21 00:02:19.741501 | orchestrator | skipping: Conditional result was False 2026-05-21 00:02:19.745481 | orchestrator | skipping: Conditional result was False 2026-05-21 00:02:19.755090 | 2026-05-21 00:02:19.755181 | PLAY RECAP 2026-05-21 00:02:19.755255 | orchestrator | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-21 00:02:19.755281 | 2026-05-21 00:02:19.953729 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-21 00:02:19.954813 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 00:02:21.108357 | 2026-05-21 00:02:21.109331 | PLAY [Base post] 2026-05-21 00:02:21.166977 | 2026-05-21 00:02:21.168041 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-21 00:02:22.270965 | orchestrator | changed 2026-05-21 00:02:22.287194 | 2026-05-21 00:02:22.287360 | PLAY RECAP 2026-05-21 00:02:22.287428 | orchestrator | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 00:02:22.287493 | 2026-05-21 00:02:22.494477 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 00:02:22.495612 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-21 00:02:23.604297 | 2026-05-21 00:02:23.604493 | PLAY [Base post-logs] 2026-05-21 00:02:23.616019 | 2026-05-21 00:02:23.616182 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-21 00:02:24.192479 | localhost | changed 2026-05-21 00:02:24.203838 | 2026-05-21 00:02:24.204013 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-21 00:02:24.231103 | localhost | ok 2026-05-21 00:02:24.235968 | 2026-05-21 00:02:24.236083 | TASK [Set zuul-log-path fact] 2026-05-21 00:02:24.255113 | localhost | ok 2026-05-21 00:02:24.264990 | 2026-05-21 00:02:24.265128 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 00:02:24.292861 | localhost | ok 2026-05-21 00:02:24.296765 | 2026-05-21 00:02:24.296899 | TASK [upload-logs : Create log directories] 2026-05-21 00:02:25.006009 | localhost | changed 2026-05-21 00:02:25.008404 | 2026-05-21 00:02:25.008482 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-21 00:02:25.755031 | localhost -> localhost | ok: Runtime: 0:00:00.016174 2026-05-21 00:02:25.758069 | 2026-05-21 00:02:25.758153 | TASK [upload-logs : Upload logs to log server] 2026-05-21 00:02:26.261170 | localhost | Output suppressed because no_log was given 2026-05-21 00:02:26.262573 | 2026-05-21 00:02:26.262644 | LOOP [upload-logs : Compress console log and json output] 2026-05-21 00:02:26.345231 | localhost | skipping: Conditional result was False 2026-05-21 00:02:26.353511 | localhost | skipping: Conditional result was False 2026-05-21 00:02:26.358804 | 2026-05-21 00:02:26.358913 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-21 00:02:26.446367 | localhost | skipping: Conditional result was False 2026-05-21 00:02:26.446612 | 2026-05-21 00:02:26.453880 | localhost | skipping: Conditional result was False 2026-05-21 00:02:26.462828 | 2026-05-21 00:02:26.462967 | LOOP [upload-logs : Upload console log and json output]