2026-05-21 00:07:45.635412 | Job console starting 2026-05-21 00:07:45.649705 | Updating git repos 2026-05-21 00:07:45.704686 | Cloning repos into workspace 2026-05-21 00:07:45.927460 | Restoring repo states 2026-05-21 00:07:45.945457 | Merging changes 2026-05-21 00:07:45.945480 | Checking out repos 2026-05-21 00:07:46.237887 | Preparing playbooks 2026-05-21 00:07:47.127336 | Running Ansible setup 2026-05-21 00:07:51.737163 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-21 00:07:52.551638 | 2026-05-21 00:07:52.551821 | PLAY [Base pre] 2026-05-21 00:07:52.570257 | 2026-05-21 00:07:52.570411 | TASK [Setup log path fact] 2026-05-21 00:07:52.595818 | orchestrator | ok 2026-05-21 00:07:52.613850 | 2026-05-21 00:07:52.614035 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 00:07:52.654360 | orchestrator | ok 2026-05-21 00:07:52.666247 | 2026-05-21 00:07:52.666371 | TASK [emit-job-header : Print job information] 2026-05-21 00:07:52.722609 | # Job Information 2026-05-21 00:07:52.722995 | Ansible Version: 2.16.14 2026-05-21 00:07:52.723041 | Job: testbed-upgrade-stable-next-ubuntu-24.04 2026-05-21 00:07:52.723076 | Pipeline: periodic-midnight 2026-05-21 00:07:52.723100 | Executor: 521e9411259a 2026-05-21 00:07:52.723121 | Triggered by: https://github.com/osism/testbed 2026-05-21 00:07:52.723143 | Event ID: 4de47e166b7c47aeaf752c77d16ae21f 2026-05-21 00:07:52.732317 | 2026-05-21 00:07:52.732574 | LOOP [emit-job-header : Print node information] 2026-05-21 00:07:52.911989 | orchestrator | ok: 2026-05-21 00:07:52.912326 | orchestrator | # Node Information 2026-05-21 00:07:52.912383 | orchestrator | Inventory Hostname: orchestrator 2026-05-21 00:07:52.912424 | orchestrator | Hostname: zuul-static-regiocloud-infra-1 2026-05-21 00:07:52.912458 | orchestrator | Username: zuul-testbed04 2026-05-21 00:07:52.912490 | orchestrator | Distro: Debian 12.14 2026-05-21 00:07:52.912527 | orchestrator | Provider: static-testbed 2026-05-21 00:07:52.912562 | orchestrator | Region: 2026-05-21 00:07:52.912595 | orchestrator | Label: testbed-orchestrator 2026-05-21 00:07:52.912707 | orchestrator | Product Name: OpenStack Nova 2026-05-21 00:07:52.912813 | orchestrator | Interface IP: 81.163.193.140 2026-05-21 00:07:52.939064 | 2026-05-21 00:07:52.939233 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-21 00:07:53.486296 | orchestrator -> localhost | changed 2026-05-21 00:07:53.497139 | 2026-05-21 00:07:53.497268 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-21 00:07:54.673268 | orchestrator -> localhost | changed 2026-05-21 00:07:54.687655 | 2026-05-21 00:07:54.687794 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-21 00:07:54.985782 | orchestrator -> localhost | ok 2026-05-21 00:07:55.000967 | 2026-05-21 00:07:55.001144 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-21 00:07:55.035954 | orchestrator | ok 2026-05-21 00:07:55.057258 | orchestrator | included: /var/lib/zuul/builds/39dd002231554cc2a9e7ac62174ae0f4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-21 00:07:55.064437 | 2026-05-21 00:07:55.064556 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-21 00:07:56.522313 | orchestrator -> localhost | Generating public/private rsa key pair. 2026-05-21 00:07:56.523090 | orchestrator -> localhost | Your identification has been saved in /var/lib/zuul/builds/39dd002231554cc2a9e7ac62174ae0f4/work/39dd002231554cc2a9e7ac62174ae0f4_id_rsa 2026-05-21 00:07:56.523217 | orchestrator -> localhost | Your public key has been saved in /var/lib/zuul/builds/39dd002231554cc2a9e7ac62174ae0f4/work/39dd002231554cc2a9e7ac62174ae0f4_id_rsa.pub 2026-05-21 00:07:56.523298 | orchestrator -> localhost | The key fingerprint is: 2026-05-21 00:07:56.523369 | orchestrator -> localhost | SHA256:2ZlGZiOKjCxc2of0vH7wkb1kWnJfA7kX13pA5seDv4M zuul-build-sshkey 2026-05-21 00:07:56.523433 | orchestrator -> localhost | The key's randomart image is: 2026-05-21 00:07:56.523518 | orchestrator -> localhost | +---[RSA 3072]----+ 2026-05-21 00:07:56.523581 | orchestrator -> localhost | | | 2026-05-21 00:07:56.523643 | orchestrator -> localhost | | o | 2026-05-21 00:07:56.523701 | orchestrator -> localhost | | o . = .+...| 2026-05-21 00:07:56.523756 | orchestrator -> localhost | |..=o+. . B * ooo+| 2026-05-21 00:07:56.523812 | orchestrator -> localhost | |.oooo+. S = o ++.| 2026-05-21 00:07:56.523900 | orchestrator -> localhost | | . ...+ B . +...| 2026-05-21 00:07:56.523963 | orchestrator -> localhost | | .o O o o o..| 2026-05-21 00:07:56.524022 | orchestrator -> localhost | | . + . . E o | 2026-05-21 00:07:56.524083 | orchestrator -> localhost | | .. .| 2026-05-21 00:07:56.524141 | orchestrator -> localhost | +----[SHA256]-----+ 2026-05-21 00:07:56.524306 | orchestrator -> localhost | ok: Runtime: 0:00:00.869630 2026-05-21 00:07:56.539307 | 2026-05-21 00:07:56.539462 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-21 00:07:56.573938 | orchestrator | ok 2026-05-21 00:07:56.584810 | orchestrator | included: /var/lib/zuul/builds/39dd002231554cc2a9e7ac62174ae0f4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-21 00:07:56.599113 | 2026-05-21 00:07:56.599247 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-21 00:07:56.623759 | orchestrator | skipping: Conditional result was False 2026-05-21 00:07:56.636666 | 2026-05-21 00:07:56.637026 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-21 00:07:57.266967 | orchestrator | changed 2026-05-21 00:07:57.273467 | 2026-05-21 00:07:57.273586 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-21 00:07:57.540300 | orchestrator | ok 2026-05-21 00:07:57.549662 | 2026-05-21 00:07:57.549853 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-21 00:07:57.955092 | orchestrator | ok 2026-05-21 00:07:57.961260 | 2026-05-21 00:07:57.961373 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-21 00:07:58.383104 | orchestrator | ok 2026-05-21 00:07:58.391546 | 2026-05-21 00:07:58.391672 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-21 00:07:58.426233 | orchestrator | skipping: Conditional result was False 2026-05-21 00:07:58.436838 | 2026-05-21 00:07:58.437033 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-21 00:07:58.948050 | orchestrator -> localhost | changed 2026-05-21 00:07:58.963254 | 2026-05-21 00:07:58.963387 | TASK [add-build-sshkey : Add back temp key] 2026-05-21 00:07:59.364269 | orchestrator -> localhost | Identity added: /var/lib/zuul/builds/39dd002231554cc2a9e7ac62174ae0f4/work/39dd002231554cc2a9e7ac62174ae0f4_id_rsa (zuul-build-sshkey) 2026-05-21 00:07:59.364674 | orchestrator -> localhost | ok: Runtime: 0:00:00.014458 2026-05-21 00:07:59.377616 | 2026-05-21 00:07:59.377754 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-21 00:07:59.801743 | orchestrator | ok 2026-05-21 00:07:59.808684 | 2026-05-21 00:07:59.808815 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-21 00:07:59.853644 | orchestrator | skipping: Conditional result was False 2026-05-21 00:07:59.929024 | 2026-05-21 00:07:59.929167 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-21 00:08:00.345905 | orchestrator | ok 2026-05-21 00:08:00.364025 | 2026-05-21 00:08:00.364179 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-21 00:08:00.412352 | orchestrator | ok 2026-05-21 00:08:00.420208 | 2026-05-21 00:08:00.420330 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-21 00:08:00.719748 | orchestrator -> localhost | ok 2026-05-21 00:08:00.727965 | 2026-05-21 00:08:00.728081 | TASK [validate-host : Collect information about the host] 2026-05-21 00:08:01.988734 | orchestrator | ok 2026-05-21 00:08:02.002853 | 2026-05-21 00:08:02.003011 | TASK [validate-host : Sanitize hostname] 2026-05-21 00:08:02.082878 | orchestrator | ok 2026-05-21 00:08:02.099396 | 2026-05-21 00:08:02.099955 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-21 00:08:02.726769 | orchestrator -> localhost | changed 2026-05-21 00:08:02.737893 | 2026-05-21 00:08:02.738131 | TASK [validate-host : Collect information about zuul worker] 2026-05-21 00:08:03.177892 | orchestrator | ok 2026-05-21 00:08:03.184324 | 2026-05-21 00:08:03.184458 | TASK [validate-host : Write out all zuul information for each host] 2026-05-21 00:08:03.809582 | orchestrator -> localhost | changed 2026-05-21 00:08:03.828567 | 2026-05-21 00:08:03.828703 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-21 00:08:04.119637 | orchestrator | ok 2026-05-21 00:08:04.130210 | 2026-05-21 00:08:04.130357 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-21 00:08:39.220419 | orchestrator | changed: 2026-05-21 00:08:39.220659 | orchestrator | .d..t...... src/ 2026-05-21 00:08:39.220695 | orchestrator | .d..t...... src/github.com/ 2026-05-21 00:08:39.220722 | orchestrator | .d..t...... src/github.com/osism/ 2026-05-21 00:08:39.220744 | orchestrator | .d..t...... src/github.com/osism/ansible-collection-commons/ 2026-05-21 00:08:39.220765 | orchestrator | RedHat.yml 2026-05-21 00:08:39.235573 | orchestrator | .L..t...... src/github.com/osism/ansible-collection-commons/roles/repository/tasks/CentOS.yml -> RedHat.yml 2026-05-21 00:08:39.235590 | orchestrator | RedHat.yml 2026-05-21 00:08:39.235642 | orchestrator | localhost | ok: "/var/lib/zuul/builds/39dd002231554cc2a9e7ac62174ae0f4/work/logs" 2026-05-21 00:08:49.082667 | orchestrator -> localhost | changed: "/var/lib/zuul/builds/39dd002231554cc2a9e7ac62174ae0f4/work/artifacts" 2026-05-21 00:08:49.385637 | orchestrator -> localhost | changed: "/var/lib/zuul/builds/39dd002231554cc2a9e7ac62174ae0f4/work/docs" 2026-05-21 00:08:49.405695 | 2026-05-21 00:08:49.405856 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-21 00:08:50.340527 | orchestrator | changed: 2026-05-21 00:08:50.340880 | orchestrator | .d..t...... ./ 2026-05-21 00:08:50.340942 | orchestrator | >f+++++++++ sudo-debug.txt 2026-05-21 00:08:50.340993 | orchestrator | >f+++++++++ sudo-strace.log 2026-05-21 00:08:50.341038 | orchestrator | >f+++++++++ sudo-strace.log.time 2026-05-21 00:08:50.341097 | orchestrator | changed: All items complete 2026-05-21 00:08:50.341132 | 2026-05-21 00:08:51.073091 | orchestrator | changed: .d..t...... ./ 2026-05-21 00:08:51.805346 | orchestrator | changed: .d..t...... ./ 2026-05-21 00:08:51.827255 | 2026-05-21 00:08:51.827411 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-21 00:08:51.854453 | orchestrator | skipping: Conditional result was False 2026-05-21 00:08:51.861062 | orchestrator | skipping: Conditional result was False 2026-05-21 00:08:51.871691 | 2026-05-21 00:08:51.871871 | PLAY RECAP 2026-05-21 00:08:51.871959 | orchestrator | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-21 00:08:51.871999 | 2026-05-21 00:08:52.034872 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-21 00:08:52.036859 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 00:08:52.815803 | 2026-05-21 00:08:52.816030 | PLAY [Base post] 2026-05-21 00:08:52.831516 | 2026-05-21 00:08:52.831678 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-21 00:08:54.239363 | orchestrator | changed 2026-05-21 00:08:54.246544 | 2026-05-21 00:08:54.246656 | PLAY RECAP 2026-05-21 00:08:54.246723 | orchestrator | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 00:08:54.246785 | 2026-05-21 00:08:54.383776 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 00:08:54.386454 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-21 00:08:55.244461 | 2026-05-21 00:08:55.244637 | PLAY [Base post-logs] 2026-05-21 00:08:55.255589 | 2026-05-21 00:08:55.255729 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-21 00:08:55.738019 | localhost | changed 2026-05-21 00:08:55.749058 | 2026-05-21 00:08:55.749227 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-21 00:08:55.774796 | localhost | ok 2026-05-21 00:08:55.777996 | 2026-05-21 00:08:55.778094 | TASK [Set zuul-log-path fact] 2026-05-21 00:08:55.802990 | localhost | ok 2026-05-21 00:08:55.811311 | 2026-05-21 00:08:55.811423 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 00:08:55.836217 | localhost | ok 2026-05-21 00:08:55.839206 | 2026-05-21 00:08:55.839309 | TASK [upload-logs : Create log directories] 2026-05-21 00:08:56.408508 | localhost | changed 2026-05-21 00:08:56.414446 | 2026-05-21 00:08:56.414698 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-21 00:08:56.929632 | localhost -> localhost | ok: Runtime: 0:00:00.007581 2026-05-21 00:08:56.939075 | 2026-05-21 00:08:56.939257 | TASK [upload-logs : Upload logs to log server] 2026-05-21 00:08:57.536719 | localhost | Output suppressed because no_log was given 2026-05-21 00:08:57.538885 | 2026-05-21 00:08:57.539171 | LOOP [upload-logs : Compress console log and json output] 2026-05-21 00:08:57.587444 | localhost | skipping: Conditional result was False 2026-05-21 00:08:57.592073 | localhost | skipping: Conditional result was False 2026-05-21 00:08:57.603753 | 2026-05-21 00:08:57.603939 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-21 00:08:57.651984 | localhost | skipping: Conditional result was False 2026-05-21 00:08:57.652540 | 2026-05-21 00:08:57.656229 | localhost | skipping: Conditional result was False 2026-05-21 00:08:57.665939 | 2026-05-21 00:08:57.666175 | LOOP [upload-logs : Upload console log and json output]