2026-05-21 00:06:25.087822 | Job console starting 2026-05-21 00:06:25.100158 | Updating git repos 2026-05-21 00:06:25.186321 | Cloning repos into workspace 2026-05-21 00:06:25.434923 | Restoring repo states 2026-05-21 00:06:25.463933 | Merging changes 2026-05-21 00:06:25.463954 | Checking out repos 2026-05-21 00:06:25.693737 | Preparing playbooks 2026-05-21 00:06:26.605947 | Running Ansible setup 2026-05-21 00:06:31.291355 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-21 00:06:32.145534 | 2026-05-21 00:06:32.145708 | PLAY [Base pre] 2026-05-21 00:06:32.165255 | 2026-05-21 00:06:32.165399 | TASK [Setup log path fact] 2026-05-21 00:06:32.196140 | orchestrator | ok 2026-05-21 00:06:32.216876 | 2026-05-21 00:06:32.217064 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 00:06:32.257545 | orchestrator | ok 2026-05-21 00:06:32.269641 | 2026-05-21 00:06:32.269761 | TASK [emit-job-header : Print job information] 2026-05-21 00:06:32.327503 | # Job Information 2026-05-21 00:06:32.327778 | Ansible Version: 2.16.14 2026-05-21 00:06:32.327840 | Job: testbed-upgrade-stable-next-ubuntu-24.04 2026-05-21 00:06:32.327900 | Pipeline: periodic-midnight 2026-05-21 00:06:32.327940 | Executor: 521e9411259a 2026-05-21 00:06:32.327994 | Triggered by: https://github.com/osism/testbed 2026-05-21 00:06:32.328033 | Event ID: 4de47e166b7c47aeaf752c77d16ae21f 2026-05-21 00:06:32.338283 | 2026-05-21 00:06:32.338437 | LOOP [emit-job-header : Print node information] 2026-05-21 00:06:32.481895 | orchestrator | ok: 2026-05-21 00:06:32.482196 | orchestrator | # Node Information 2026-05-21 00:06:32.482254 | orchestrator | Inventory Hostname: orchestrator 2026-05-21 00:06:32.482297 | orchestrator | Hostname: zuul-static-regiocloud-infra-1 2026-05-21 00:06:32.482333 | orchestrator | Username: zuul-testbed06 2026-05-21 00:06:32.482367 | orchestrator | Distro: Debian 12.14 2026-05-21 00:06:32.482405 | orchestrator | Provider: static-testbed 2026-05-21 00:06:32.482439 | orchestrator | Region: 2026-05-21 00:06:32.482474 | orchestrator | Label: testbed-orchestrator 2026-05-21 00:06:32.482506 | orchestrator | Product Name: OpenStack Nova 2026-05-21 00:06:32.482538 | orchestrator | Interface IP: 81.163.193.140 2026-05-21 00:06:32.511193 | 2026-05-21 00:06:32.511371 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-21 00:06:33.058258 | orchestrator -> localhost | changed 2026-05-21 00:06:33.067822 | 2026-05-21 00:06:33.068019 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-21 00:06:34.407201 | orchestrator -> localhost | changed 2026-05-21 00:06:34.425300 | 2026-05-21 00:06:34.425445 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-21 00:06:34.768812 | orchestrator -> localhost | ok 2026-05-21 00:06:34.777002 | 2026-05-21 00:06:34.777138 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-21 00:06:34.807770 | orchestrator | ok 2026-05-21 00:06:34.833031 | orchestrator | included: /var/lib/zuul/builds/2ec3d762abf548129da8f17126da5200/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-21 00:06:34.841068 | 2026-05-21 00:06:34.841204 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-21 00:06:35.780485 | orchestrator -> localhost | Generating public/private rsa key pair. 2026-05-21 00:06:35.780721 | orchestrator -> localhost | Your identification has been saved in /var/lib/zuul/builds/2ec3d762abf548129da8f17126da5200/work/2ec3d762abf548129da8f17126da5200_id_rsa 2026-05-21 00:06:35.780762 | orchestrator -> localhost | Your public key has been saved in /var/lib/zuul/builds/2ec3d762abf548129da8f17126da5200/work/2ec3d762abf548129da8f17126da5200_id_rsa.pub 2026-05-21 00:06:35.780791 | orchestrator -> localhost | The key fingerprint is: 2026-05-21 00:06:35.780816 | orchestrator -> localhost | SHA256:qPd704wS25vAsTgFer/oDXTCNMnvnk9zJmsz/JmITXo zuul-build-sshkey 2026-05-21 00:06:35.780840 | orchestrator -> localhost | The key's randomart image is: 2026-05-21 00:06:35.780874 | orchestrator -> localhost | +---[RSA 3072]----+ 2026-05-21 00:06:35.780897 | orchestrator -> localhost | | | 2026-05-21 00:06:35.780918 | orchestrator -> localhost | | . . | 2026-05-21 00:06:35.780940 | orchestrator -> localhost | | * | 2026-05-21 00:06:35.781001 | orchestrator -> localhost | | + = | 2026-05-21 00:06:35.781024 | orchestrator -> localhost | | . * S | 2026-05-21 00:06:35.781051 | orchestrator -> localhost | | + O.o | 2026-05-21 00:06:35.781073 | orchestrator -> localhost | | . = *==+o | 2026-05-21 00:06:35.781094 | orchestrator -> localhost | | . BoXEOoo | 2026-05-21 00:06:35.781116 | orchestrator -> localhost | | .o XBB*+ | 2026-05-21 00:06:35.781136 | orchestrator -> localhost | +----[SHA256]-----+ 2026-05-21 00:06:35.781188 | orchestrator -> localhost | ok: Runtime: 0:00:00.429596 2026-05-21 00:06:35.789095 | 2026-05-21 00:06:35.789219 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-21 00:06:35.819563 | orchestrator | ok 2026-05-21 00:06:35.830340 | orchestrator | included: /var/lib/zuul/builds/2ec3d762abf548129da8f17126da5200/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-21 00:06:35.842300 | 2026-05-21 00:06:35.842416 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-21 00:06:35.867265 | orchestrator | skipping: Conditional result was False 2026-05-21 00:06:35.874982 | 2026-05-21 00:06:35.875113 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-21 00:06:36.533369 | orchestrator | changed 2026-05-21 00:06:36.548978 | 2026-05-21 00:06:36.549130 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-21 00:06:36.813963 | orchestrator | ok 2026-05-21 00:06:36.828322 | 2026-05-21 00:06:36.828538 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-21 00:06:37.251924 | orchestrator | ok 2026-05-21 00:06:37.259569 | 2026-05-21 00:06:37.259713 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-21 00:06:37.625410 | orchestrator | ok 2026-05-21 00:06:37.632729 | 2026-05-21 00:06:37.632859 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-21 00:06:37.673363 | orchestrator | skipping: Conditional result was False 2026-05-21 00:06:37.685381 | 2026-05-21 00:06:37.685520 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-21 00:06:38.206334 | orchestrator -> localhost | changed 2026-05-21 00:06:38.221142 | 2026-05-21 00:06:38.221281 | TASK [add-build-sshkey : Add back temp key] 2026-05-21 00:06:38.661007 | orchestrator -> localhost | Identity added: /var/lib/zuul/builds/2ec3d762abf548129da8f17126da5200/work/2ec3d762abf548129da8f17126da5200_id_rsa (zuul-build-sshkey) 2026-05-21 00:06:38.661261 | orchestrator -> localhost | ok: Runtime: 0:00:00.012123 2026-05-21 00:06:38.670085 | 2026-05-21 00:06:38.670212 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-21 00:06:39.130015 | orchestrator | ok 2026-05-21 00:06:39.136742 | 2026-05-21 00:06:39.136884 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-21 00:06:39.161081 | orchestrator | skipping: Conditional result was False 2026-05-21 00:06:39.219423 | 2026-05-21 00:06:39.219572 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-21 00:06:39.617783 | orchestrator | ok 2026-05-21 00:06:39.630766 | 2026-05-21 00:06:39.630920 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-21 00:06:39.662402 | orchestrator | ok 2026-05-21 00:06:39.668594 | 2026-05-21 00:06:39.668712 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-21 00:06:39.949583 | orchestrator -> localhost | ok 2026-05-21 00:06:39.959427 | 2026-05-21 00:06:39.959562 | TASK [validate-host : Collect information about the host] 2026-05-21 00:06:41.219077 | orchestrator | ok 2026-05-21 00:06:41.236594 | 2026-05-21 00:06:41.236823 | TASK [validate-host : Sanitize hostname] 2026-05-21 00:06:41.296862 | orchestrator | ok 2026-05-21 00:06:41.302939 | 2026-05-21 00:06:41.303083 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-21 00:06:41.969540 | orchestrator -> localhost | changed 2026-05-21 00:06:41.976633 | 2026-05-21 00:06:41.976763 | TASK [validate-host : Collect information about zuul worker] 2026-05-21 00:06:42.760594 | orchestrator | ok 2026-05-21 00:06:42.771021 | 2026-05-21 00:06:42.771298 | TASK [validate-host : Write out all zuul information for each host] 2026-05-21 00:06:43.350687 | orchestrator -> localhost | changed 2026-05-21 00:06:43.363837 | 2026-05-21 00:06:43.363989 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-21 00:06:44.734212 | orchestrator | ok 2026-05-21 00:06:44.741334 | 2026-05-21 00:06:44.741470 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-21 00:07:24.541675 | orchestrator | changed: 2026-05-21 00:07:24.542668 | orchestrator | .d..t...... src/ 2026-05-21 00:07:24.542721 | orchestrator | .d..t...... src/github.com/ 2026-05-21 00:07:24.542753 | orchestrator | .d..t...... src/github.com/osism/ 2026-05-21 00:07:24.542781 | orchestrator | .d..t...... src/github.com/osism/ansible-collection-commons/ 2026-05-21 00:07:24.542805 | orchestrator | RedHat.yml 2026-05-21 00:07:24.558961 | orchestrator | .L..t...... src/github.com/osism/ansible-collection-commons/roles/repository/tasks/CentOS.yml -> RedHat.yml 2026-05-21 00:07:24.558979 | orchestrator | RedHat.yml 2026-05-21 00:07:24.559033 | orchestrator | localhost | ok: "/var/lib/zuul/builds/2ec3d762abf548129da8f17126da5200/work/logs" 2026-05-21 00:07:34.343000 | orchestrator -> localhost | changed: "/var/lib/zuul/builds/2ec3d762abf548129da8f17126da5200/work/artifacts" 2026-05-21 00:07:34.622608 | orchestrator -> localhost | changed: "/var/lib/zuul/builds/2ec3d762abf548129da8f17126da5200/work/docs" 2026-05-21 00:07:34.647882 | 2026-05-21 00:07:34.648191 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-21 00:07:35.640867 | orchestrator | changed: 2026-05-21 00:07:35.641149 | orchestrator | .d..t...... ./ 2026-05-21 00:07:35.641184 | orchestrator | >f+++++++++ sudo-debug.txt 2026-05-21 00:07:35.641215 | orchestrator | >f+++++++++ sudo-strace.log 2026-05-21 00:07:35.641242 | orchestrator | >f+++++++++ sudo-strace.log.time 2026-05-21 00:07:35.641281 | orchestrator | changed: All items complete 2026-05-21 00:07:35.641304 | 2026-05-21 00:07:36.385543 | orchestrator | changed: .d..t...... ./ 2026-05-21 00:07:37.130214 | orchestrator | changed: .d..t...... ./ 2026-05-21 00:07:37.154822 | 2026-05-21 00:07:37.155043 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-21 00:07:37.196789 | orchestrator | skipping: Conditional result was False 2026-05-21 00:07:37.204431 | orchestrator | skipping: Conditional result was False 2026-05-21 00:07:37.224502 | 2026-05-21 00:07:37.224617 | PLAY RECAP 2026-05-21 00:07:37.224688 | orchestrator | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-21 00:07:37.224724 | 2026-05-21 00:07:37.371946 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-21 00:07:37.375013 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 00:07:38.169233 | 2026-05-21 00:07:38.169435 | PLAY [Base post] 2026-05-21 00:07:38.188640 | 2026-05-21 00:07:38.188808 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-21 00:07:39.381279 | orchestrator | changed 2026-05-21 00:07:39.396645 | 2026-05-21 00:07:39.396972 | PLAY RECAP 2026-05-21 00:07:39.397100 | orchestrator | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 00:07:39.397212 | 2026-05-21 00:07:39.534747 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 00:07:39.535923 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-21 00:07:40.358528 | 2026-05-21 00:07:40.358707 | PLAY [Base post-logs] 2026-05-21 00:07:40.371568 | 2026-05-21 00:07:40.371715 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-21 00:07:40.843400 | localhost | changed 2026-05-21 00:07:40.857115 | 2026-05-21 00:07:40.857266 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-21 00:07:40.893991 | localhost | ok 2026-05-21 00:07:40.897426 | 2026-05-21 00:07:40.897536 | TASK [Set zuul-log-path fact] 2026-05-21 00:07:40.913190 | localhost | ok 2026-05-21 00:07:40.921827 | 2026-05-21 00:07:40.921962 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 00:07:40.947879 | localhost | ok 2026-05-21 00:07:40.951078 | 2026-05-21 00:07:40.951184 | TASK [upload-logs : Create log directories] 2026-05-21 00:07:41.550250 | localhost | changed 2026-05-21 00:07:41.553760 | 2026-05-21 00:07:41.553942 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-21 00:07:42.086218 | localhost -> localhost | ok: Runtime: 0:00:00.006749 2026-05-21 00:07:42.092740 | 2026-05-21 00:07:42.092901 | TASK [upload-logs : Upload logs to log server] 2026-05-21 00:07:42.660186 | localhost | Output suppressed because no_log was given 2026-05-21 00:07:42.663164 | 2026-05-21 00:07:42.663313 | LOOP [upload-logs : Compress console log and json output] 2026-05-21 00:07:42.710157 | localhost | skipping: Conditional result was False 2026-05-21 00:07:42.716206 | localhost | skipping: Conditional result was False 2026-05-21 00:07:42.728604 | 2026-05-21 00:07:42.728806 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-21 00:07:42.775785 | localhost | skipping: Conditional result was False 2026-05-21 00:07:42.776140 | 2026-05-21 00:07:42.783346 | localhost | skipping: Conditional result was False 2026-05-21 00:07:42.791820 | 2026-05-21 00:07:42.792142 | LOOP [upload-logs : Upload console log and json output]