2026-05-21 00:07:50.690058 | Job console starting 2026-05-21 00:07:50.713413 | Updating git repos 2026-05-21 00:07:50.780600 | Cloning repos into workspace 2026-05-21 00:07:51.013291 | Restoring repo states 2026-05-21 00:07:51.034249 | Merging changes 2026-05-21 00:07:51.034271 | Checking out repos 2026-05-21 00:07:51.338089 | Preparing playbooks 2026-05-21 00:07:52.135164 | Running Ansible setup 2026-05-21 00:07:56.596402 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-21 00:07:57.455683 | 2026-05-21 00:07:57.455853 | PLAY [Base pre] 2026-05-21 00:07:57.474453 | 2026-05-21 00:07:57.474605 | TASK [Setup log path fact] 2026-05-21 00:07:57.511669 | orchestrator | ok 2026-05-21 00:07:57.548722 | 2026-05-21 00:07:57.548944 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 00:07:57.590557 | orchestrator | ok 2026-05-21 00:07:57.602881 | 2026-05-21 00:07:57.603019 | TASK [emit-job-header : Print job information] 2026-05-21 00:07:57.647227 | # Job Information 2026-05-21 00:07:57.647487 | Ansible Version: 2.16.14 2026-05-21 00:07:57.647553 | Job: testbed-upgrade-stable-ubuntu-24.04 2026-05-21 00:07:57.647605 | Pipeline: periodic-midnight 2026-05-21 00:07:57.647643 | Executor: 521e9411259a 2026-05-21 00:07:57.647678 | Triggered by: https://github.com/osism/testbed 2026-05-21 00:07:57.647711 | Event ID: 4de47e166b7c47aeaf752c77d16ae21f 2026-05-21 00:07:57.659618 | 2026-05-21 00:07:57.659768 | LOOP [emit-job-header : Print node information] 2026-05-21 00:07:57.799991 | orchestrator | ok: 2026-05-21 00:07:57.800222 | orchestrator | # Node Information 2026-05-21 00:07:57.800256 | orchestrator | Inventory Hostname: orchestrator 2026-05-21 00:07:57.800281 | orchestrator | Hostname: zuul-static-regiocloud-infra-1 2026-05-21 00:07:57.800303 | orchestrator | Username: zuul-testbed05 2026-05-21 00:07:57.800323 | orchestrator | Distro: Debian 12.14 2026-05-21 00:07:57.800348 | orchestrator | Provider: static-testbed 2026-05-21 00:07:57.800368 | orchestrator | Region: 2026-05-21 00:07:57.800388 | orchestrator | Label: testbed-orchestrator 2026-05-21 00:07:57.800407 | orchestrator | Product Name: OpenStack Nova 2026-05-21 00:07:57.800426 | orchestrator | Interface IP: 81.163.193.140 2026-05-21 00:07:57.827581 | 2026-05-21 00:07:57.827748 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-21 00:07:58.331765 | orchestrator -> localhost | changed 2026-05-21 00:07:58.349528 | 2026-05-21 00:07:58.349711 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-21 00:07:59.484913 | orchestrator -> localhost | changed 2026-05-21 00:07:59.510186 | 2026-05-21 00:07:59.510406 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-21 00:07:59.814282 | orchestrator -> localhost | ok 2026-05-21 00:07:59.822105 | 2026-05-21 00:07:59.822248 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-21 00:07:59.857236 | orchestrator | ok 2026-05-21 00:07:59.888506 | orchestrator | included: /var/lib/zuul/builds/6cba8686e22247e885dee75c4ae0916d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-21 00:07:59.898034 | 2026-05-21 00:07:59.898189 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-21 00:08:01.806789 | orchestrator -> localhost | Generating public/private rsa key pair. 2026-05-21 00:08:01.807230 | orchestrator -> localhost | Your identification has been saved in /var/lib/zuul/builds/6cba8686e22247e885dee75c4ae0916d/work/6cba8686e22247e885dee75c4ae0916d_id_rsa 2026-05-21 00:08:01.807294 | orchestrator -> localhost | Your public key has been saved in /var/lib/zuul/builds/6cba8686e22247e885dee75c4ae0916d/work/6cba8686e22247e885dee75c4ae0916d_id_rsa.pub 2026-05-21 00:08:01.807337 | orchestrator -> localhost | The key fingerprint is: 2026-05-21 00:08:01.807377 | orchestrator -> localhost | SHA256:aI+gtmuBxO4i/NaP3KKSmtgTP2S16+CefQU/aPo1+Ho zuul-build-sshkey 2026-05-21 00:08:01.807414 | orchestrator -> localhost | The key's randomart image is: 2026-05-21 00:08:01.807467 | orchestrator -> localhost | +---[RSA 3072]----+ 2026-05-21 00:08:01.807504 | orchestrator -> localhost | | | 2026-05-21 00:08:01.807542 | orchestrator -> localhost | | | 2026-05-21 00:08:01.807576 | orchestrator -> localhost | |. | 2026-05-21 00:08:01.807609 | orchestrator -> localhost | | o ... | 2026-05-21 00:08:01.807641 | orchestrator -> localhost | |o. ..o.S+ | 2026-05-21 00:08:01.807689 | orchestrator -> localhost | |..o.oo.oo.+ | 2026-05-21 00:08:01.807723 | orchestrator -> localhost | |o +*o .+o.o. | 2026-05-21 00:08:01.807758 | orchestrator -> localhost | |+Oo++*= .oE. | 2026-05-21 00:08:01.807792 | orchestrator -> localhost | |B.B*====oo. | 2026-05-21 00:08:01.807827 | orchestrator -> localhost | +----[SHA256]-----+ 2026-05-21 00:08:01.807935 | orchestrator -> localhost | ok: Runtime: 0:00:01.330234 2026-05-21 00:08:01.819281 | 2026-05-21 00:08:01.819427 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-21 00:08:01.869288 | orchestrator | ok 2026-05-21 00:08:01.886040 | orchestrator | included: /var/lib/zuul/builds/6cba8686e22247e885dee75c4ae0916d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-21 00:08:01.899075 | 2026-05-21 00:08:01.899271 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-21 00:08:01.925156 | orchestrator | skipping: Conditional result was False 2026-05-21 00:08:01.932837 | 2026-05-21 00:08:01.932977 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-21 00:08:02.852524 | orchestrator | changed 2026-05-21 00:08:02.862118 | 2026-05-21 00:08:02.862247 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-21 00:08:03.149577 | orchestrator | ok 2026-05-21 00:08:03.160255 | 2026-05-21 00:08:03.160413 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-21 00:08:03.578294 | orchestrator | ok 2026-05-21 00:08:03.588596 | 2026-05-21 00:08:03.588759 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-21 00:08:04.034174 | orchestrator | ok 2026-05-21 00:08:04.042188 | 2026-05-21 00:08:04.042295 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-21 00:08:04.067404 | orchestrator | skipping: Conditional result was False 2026-05-21 00:08:04.084379 | 2026-05-21 00:08:04.084538 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-21 00:08:04.538355 | orchestrator -> localhost | changed 2026-05-21 00:08:04.555454 | 2026-05-21 00:08:04.555596 | TASK [add-build-sshkey : Add back temp key] 2026-05-21 00:08:04.915990 | orchestrator -> localhost | Identity added: /var/lib/zuul/builds/6cba8686e22247e885dee75c4ae0916d/work/6cba8686e22247e885dee75c4ae0916d_id_rsa (zuul-build-sshkey) 2026-05-21 00:08:04.916509 | orchestrator -> localhost | ok: Runtime: 0:00:00.012705 2026-05-21 00:08:04.933437 | 2026-05-21 00:08:04.933606 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-21 00:08:05.361796 | orchestrator | ok 2026-05-21 00:08:05.371054 | 2026-05-21 00:08:05.371196 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-21 00:08:05.406207 | orchestrator | skipping: Conditional result was False 2026-05-21 00:08:05.475071 | 2026-05-21 00:08:05.475235 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-21 00:08:05.893499 | orchestrator | ok 2026-05-21 00:08:05.909423 | 2026-05-21 00:08:05.909573 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-21 00:08:05.953694 | orchestrator | ok 2026-05-21 00:08:05.960117 | 2026-05-21 00:08:05.960236 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-21 00:08:06.300280 | orchestrator -> localhost | ok 2026-05-21 00:08:06.317671 | 2026-05-21 00:08:06.317848 | TASK [validate-host : Collect information about the host] 2026-05-21 00:08:07.573530 | orchestrator | ok 2026-05-21 00:08:07.590560 | 2026-05-21 00:08:07.590688 | TASK [validate-host : Sanitize hostname] 2026-05-21 00:08:07.667131 | orchestrator | ok 2026-05-21 00:08:07.672935 | 2026-05-21 00:08:07.673056 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-21 00:08:08.273777 | orchestrator -> localhost | changed 2026-05-21 00:08:08.280910 | 2026-05-21 00:08:08.281048 | TASK [validate-host : Collect information about zuul worker] 2026-05-21 00:08:08.745712 | orchestrator | ok 2026-05-21 00:08:08.756537 | 2026-05-21 00:08:08.756672 | TASK [validate-host : Write out all zuul information for each host] 2026-05-21 00:08:09.351292 | orchestrator -> localhost | changed 2026-05-21 00:08:09.362284 | 2026-05-21 00:08:09.362412 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-21 00:08:09.684142 | orchestrator | ok 2026-05-21 00:08:09.690732 | 2026-05-21 00:08:09.690910 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-21 00:08:44.650202 | orchestrator | changed: 2026-05-21 00:08:44.650500 | orchestrator | .d..t...... src/ 2026-05-21 00:08:44.650546 | orchestrator | .d..t...... src/github.com/ 2026-05-21 00:08:44.650572 | orchestrator | .d..t...... src/github.com/osism/ 2026-05-21 00:08:44.650594 | orchestrator | .d..t...... src/github.com/osism/ansible-collection-commons/ 2026-05-21 00:08:44.650615 | orchestrator | RedHat.yml 2026-05-21 00:08:44.672060 | orchestrator | .L..t...... src/github.com/osism/ansible-collection-commons/roles/repository/tasks/CentOS.yml -> RedHat.yml 2026-05-21 00:08:44.672087 | orchestrator | RedHat.yml 2026-05-21 00:08:44.672169 | orchestrator | localhost | ok: "/var/lib/zuul/builds/6cba8686e22247e885dee75c4ae0916d/work/logs" 2026-05-21 00:08:53.381643 | orchestrator -> localhost | changed: "/var/lib/zuul/builds/6cba8686e22247e885dee75c4ae0916d/work/artifacts" 2026-05-21 00:08:53.660795 | orchestrator -> localhost | changed: "/var/lib/zuul/builds/6cba8686e22247e885dee75c4ae0916d/work/docs" 2026-05-21 00:08:53.685862 | 2026-05-21 00:08:53.686039 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-21 00:08:54.665036 | orchestrator | changed: 2026-05-21 00:08:54.665365 | orchestrator | .d..t...... ./ 2026-05-21 00:08:54.665417 | orchestrator | >f+++++++++ sudo-debug.txt 2026-05-21 00:08:54.665451 | orchestrator | >f+++++++++ sudo-strace.log 2026-05-21 00:08:54.665484 | orchestrator | >f+++++++++ sudo-strace.log.time 2026-05-21 00:08:54.665531 | orchestrator | changed: All items complete 2026-05-21 00:08:54.665559 | 2026-05-21 00:08:55.451523 | orchestrator | changed: .d..t...... ./ 2026-05-21 00:08:56.182046 | orchestrator | changed: .d..t...... ./ 2026-05-21 00:08:56.206999 | 2026-05-21 00:08:56.207144 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-21 00:08:56.256394 | orchestrator | skipping: Conditional result was False 2026-05-21 00:08:56.259136 | orchestrator | skipping: Conditional result was False 2026-05-21 00:08:56.280366 | 2026-05-21 00:08:56.280488 | PLAY RECAP 2026-05-21 00:08:56.280554 | orchestrator | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-21 00:08:56.280933 | 2026-05-21 00:08:56.449221 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-21 00:08:56.452123 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 00:08:57.279171 | 2026-05-21 00:08:57.279338 | PLAY [Base post] 2026-05-21 00:08:57.294097 | 2026-05-21 00:08:57.294238 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-21 00:08:57.901945 | orchestrator | changed 2026-05-21 00:08:57.913648 | 2026-05-21 00:08:57.913787 | PLAY RECAP 2026-05-21 00:08:57.913870 | orchestrator | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 00:08:57.913941 | 2026-05-21 00:08:58.042602 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 00:08:58.046762 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-21 00:08:58.867072 | 2026-05-21 00:08:58.867248 | PLAY [Base post-logs] 2026-05-21 00:08:58.882674 | 2026-05-21 00:08:58.883013 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-21 00:08:59.380558 | localhost | changed 2026-05-21 00:08:59.397227 | 2026-05-21 00:08:59.397407 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-21 00:08:59.447211 | localhost | ok 2026-05-21 00:08:59.455791 | 2026-05-21 00:08:59.456005 | TASK [Set zuul-log-path fact] 2026-05-21 00:08:59.474233 | localhost | ok 2026-05-21 00:08:59.486652 | 2026-05-21 00:08:59.486819 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 00:08:59.514099 | localhost | ok 2026-05-21 00:08:59.519191 | 2026-05-21 00:08:59.519348 | TASK [upload-logs : Create log directories] 2026-05-21 00:09:00.087245 | localhost | changed 2026-05-21 00:09:00.095196 | 2026-05-21 00:09:00.095504 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-21 00:09:00.779058 | localhost -> localhost | ok: Runtime: 0:00:00.006271 2026-05-21 00:09:00.785732 | 2026-05-21 00:09:00.785882 | TASK [upload-logs : Upload logs to log server] 2026-05-21 00:09:01.426724 | localhost | Output suppressed because no_log was given 2026-05-21 00:09:01.428925 | 2026-05-21 00:09:01.429043 | LOOP [upload-logs : Compress console log and json output] 2026-05-21 00:09:01.479921 | localhost | skipping: Conditional result was False 2026-05-21 00:09:01.501595 | localhost | skipping: Conditional result was False 2026-05-21 00:09:01.509265 | 2026-05-21 00:09:01.509461 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-21 00:09:01.562255 | localhost | skipping: Conditional result was False 2026-05-21 00:09:01.562791 | 2026-05-21 00:09:01.566382 | localhost | skipping: Conditional result was False 2026-05-21 00:09:01.575293 | 2026-05-21 00:09:01.575485 | LOOP [upload-logs : Upload console log and json output]