2026-05-03 03:10:12.969360 | Job console starting 2026-05-03 03:10:12.989790 | Updating git repos 2026-05-03 03:10:13.040823 | Cloning repos into workspace 2026-05-03 03:10:13.129068 | Restoring repo states 2026-05-03 03:10:13.144751 | Merging changes 2026-05-03 03:10:13.144775 | Checking out repos 2026-05-03 03:10:13.210263 | Preparing playbooks 2026-05-03 03:10:14.080139 | Running Ansible setup 2026-05-03 03:10:19.233431 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-03 03:10:20.078364 | 2026-05-03 03:10:20.078543 | PLAY [Base pre] 2026-05-03 03:10:20.097175 | 2026-05-03 03:10:20.097323 | TASK [Setup log path fact] 2026-05-03 03:10:20.117018 | debian-bookworm | ok 2026-05-03 03:10:20.134794 | 2026-05-03 03:10:20.135027 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-03 03:10:20.164434 | debian-bookworm | ok 2026-05-03 03:10:20.175243 | 2026-05-03 03:10:20.175387 | TASK [emit-job-header : Print job information] 2026-05-03 03:10:20.215798 | # Job Information 2026-05-03 03:10:20.216027 | Ansible Version: 2.16.14 2026-05-03 03:10:20.216064 | Job: flake8 2026-05-03 03:10:20.216185 | Pipeline: periodic-daily 2026-05-03 03:10:20.216213 | Executor: 521e9411259a 2026-05-03 03:10:20.216235 | Triggered by: https://github.com/osism/testbed 2026-05-03 03:10:20.216257 | Event ID: 2d2e50f78ab64279bc2526ac1f52fdd3 2026-05-03 03:10:20.221485 | 2026-05-03 03:10:20.221617 | LOOP [emit-job-header : Print node information] 2026-05-03 03:10:20.334556 | debian-bookworm | ok: 2026-05-03 03:10:20.334930 | debian-bookworm | # Node Information 2026-05-03 03:10:20.334977 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-03 03:10:20.335003 | debian-bookworm | Hostname: debian 2026-05-03 03:10:20.335026 | debian-bookworm | Username: zuul 2026-05-03 03:10:20.335047 | debian-bookworm | Distro: Debian 12.13 2026-05-03 03:10:20.335078 | debian-bookworm | Provider: regiocloud-a 2026-05-03 03:10:20.335103 | debian-bookworm | Region: 2026-05-03 03:10:20.335125 | debian-bookworm | Label: debian-bookworm 2026-05-03 03:10:20.335144 | debian-bookworm | Product Name: OpenStack Nova 2026-05-03 03:10:20.335164 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fece:df0a 2026-05-03 03:10:20.361677 | 2026-05-03 03:10:20.361867 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-03 03:10:20.944816 | debian-bookworm -> localhost | changed 2026-05-03 03:10:20.952756 | 2026-05-03 03:10:20.952949 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-03 03:10:22.251714 | debian-bookworm -> localhost | changed 2026-05-03 03:10:22.274234 | 2026-05-03 03:10:22.274388 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-03 03:10:22.576999 | debian-bookworm -> localhost | ok 2026-05-03 03:10:22.584010 | 2026-05-03 03:10:22.584166 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-03 03:10:22.625302 | debian-bookworm | ok 2026-05-03 03:10:22.644221 | debian-bookworm | included: /var/lib/zuul/builds/dc4b2d67cba445b49a32608091195d07/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-03 03:10:22.652575 | 2026-05-03 03:10:22.652709 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-03 03:10:23.937454 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-03 03:10:23.937723 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/dc4b2d67cba445b49a32608091195d07/work/dc4b2d67cba445b49a32608091195d07_id_rsa 2026-05-03 03:10:23.937765 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/dc4b2d67cba445b49a32608091195d07/work/dc4b2d67cba445b49a32608091195d07_id_rsa.pub 2026-05-03 03:10:23.937794 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-03 03:10:23.937820 | debian-bookworm -> localhost | SHA256:iuDLY4I0L6Wr0QN3VYavBNLfCiPnpFx3vK/TD2ob9aQ zuul-build-sshkey 2026-05-03 03:10:23.937890 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-03 03:10:23.937926 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-03 03:10:23.937950 | debian-bookworm -> localhost | | . .o | 2026-05-03 03:10:23.937974 | debian-bookworm -> localhost | | . o .o | 2026-05-03 03:10:23.937995 | debian-bookworm -> localhost | | . o.+ | 2026-05-03 03:10:23.938016 | debian-bookworm -> localhost | | . *.+ = | 2026-05-03 03:10:23.938036 | debian-bookworm -> localhost | |..oB.= +S.. . | 2026-05-03 03:10:23.938062 | debian-bookworm -> localhost | | Bo+..o... + | 2026-05-03 03:10:23.938083 | debian-bookworm -> localhost | |+ O . . .oE . | 2026-05-03 03:10:23.938103 | debian-bookworm -> localhost | |o=o+ ooo. | 2026-05-03 03:10:23.938124 | debian-bookworm -> localhost | |o+=. .++ .. | 2026-05-03 03:10:23.938145 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-03 03:10:23.938210 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.644677 2026-05-03 03:10:23.950636 | 2026-05-03 03:10:23.950775 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-03 03:10:23.986053 | debian-bookworm | ok 2026-05-03 03:10:24.001572 | debian-bookworm | included: /var/lib/zuul/builds/dc4b2d67cba445b49a32608091195d07/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-03 03:10:24.012435 | 2026-05-03 03:10:24.012574 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-03 03:10:24.037322 | debian-bookworm | skipping: Conditional result was False 2026-05-03 03:10:24.044241 | 2026-05-03 03:10:24.044373 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-03 03:10:24.873686 | debian-bookworm | changed 2026-05-03 03:10:24.883264 | 2026-05-03 03:10:24.883514 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-03 03:10:25.172544 | debian-bookworm | ok 2026-05-03 03:10:25.182556 | 2026-05-03 03:10:25.182695 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-03 03:10:25.900636 | debian-bookworm | changed 2026-05-03 03:10:25.910022 | 2026-05-03 03:10:25.910180 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-03 03:10:26.634752 | debian-bookworm | changed 2026-05-03 03:10:26.642193 | 2026-05-03 03:10:26.642438 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-03 03:10:26.668551 | debian-bookworm | skipping: Conditional result was False 2026-05-03 03:10:26.676394 | 2026-05-03 03:10:26.676554 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-03 03:10:27.259768 | debian-bookworm -> localhost | changed 2026-05-03 03:10:27.290039 | 2026-05-03 03:10:27.290197 | TASK [add-build-sshkey : Add back temp key] 2026-05-03 03:10:27.735532 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/dc4b2d67cba445b49a32608091195d07/work/dc4b2d67cba445b49a32608091195d07_id_rsa (zuul-build-sshkey) 2026-05-03 03:10:27.735929 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012227 2026-05-03 03:10:27.749912 | 2026-05-03 03:10:27.750058 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-03 03:10:28.192976 | debian-bookworm | ok 2026-05-03 03:10:28.198532 | 2026-05-03 03:10:28.198675 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-03 03:10:28.223914 | debian-bookworm | skipping: Conditional result was False 2026-05-03 03:10:28.246477 | 2026-05-03 03:10:28.246633 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-03 03:10:28.760317 | debian-bookworm | ok 2026-05-03 03:10:28.776083 | 2026-05-03 03:10:28.782734 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-03 03:10:28.818591 | debian-bookworm | ok 2026-05-03 03:10:28.824157 | 2026-05-03 03:10:28.824270 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-03 03:10:29.332064 | debian-bookworm -> localhost | ok 2026-05-03 03:10:29.339084 | 2026-05-03 03:10:29.339212 | TASK [validate-host : Collect information about the host] 2026-05-03 03:10:30.762138 | debian-bookworm | ok 2026-05-03 03:10:30.775166 | 2026-05-03 03:10:30.775315 | TASK [validate-host : Sanitize hostname] 2026-05-03 03:10:30.929146 | debian-bookworm | ok 2026-05-03 03:10:30.984001 | 2026-05-03 03:10:30.984160 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-03 03:10:31.627540 | debian-bookworm -> localhost | changed 2026-05-03 03:10:31.633672 | 2026-05-03 03:10:31.633797 | TASK [validate-host : Collect information about zuul worker] 2026-05-03 03:10:32.072838 | debian-bookworm | ok 2026-05-03 03:10:32.081796 | 2026-05-03 03:10:32.081977 | TASK [validate-host : Write out all zuul information for each host] 2026-05-03 03:10:32.853081 | debian-bookworm -> localhost | changed 2026-05-03 03:10:32.863203 | 2026-05-03 03:10:32.863328 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-03 03:10:33.154807 | debian-bookworm | ok 2026-05-03 03:10:33.165078 | 2026-05-03 03:10:33.165224 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-03 03:10:34.892634 | debian-bookworm | changed: 2026-05-03 03:10:34.892898 | debian-bookworm | cd+++++++++ src/ 2026-05-03 03:10:34.892941 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-03 03:10:34.892965 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-03 03:10:34.892986 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-05-03 03:10:34.893006 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/dc4b2d67cba445b49a32608091195d07/work/logs" 2026-05-03 03:11:02.509116 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/dc4b2d67cba445b49a32608091195d07/work/artifacts" 2026-05-03 03:11:03.037909 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/dc4b2d67cba445b49a32608091195d07/work/docs" 2026-05-03 03:11:03.053866 | 2026-05-03 03:11:03.054015 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-03 03:11:04.514137 | debian-bookworm | changed: 2026-05-03 03:11:04.514439 | debian-bookworm | .d..t...... ./ 2026-05-03 03:11:04.514480 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-03 03:11:04.514510 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-03 03:11:04.514535 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-03 03:11:04.514575 | debian-bookworm | changed: All items complete 2026-05-03 03:11:04.514597 | 2026-05-03 03:11:05.314785 | debian-bookworm | changed: .d..t...... ./ 2026-05-03 03:11:05.887107 | debian-bookworm | changed: .d..t...... ./ 2026-05-03 03:11:05.904662 | 2026-05-03 03:11:05.906262 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-03 03:11:05.931304 | debian-bookworm | skipping: Conditional result was False 2026-05-03 03:11:05.936214 | debian-bookworm | skipping: Conditional result was False 2026-05-03 03:11:05.948194 | 2026-05-03 03:11:05.948273 | PLAY RECAP 2026-05-03 03:11:05.948323 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-03 03:11:05.948347 | 2026-05-03 03:11:06.162046 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-03 03:11:06.162792 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-03 03:11:07.020651 | 2026-05-03 03:11:07.020780 | PLAY [Base post] 2026-05-03 03:11:07.031460 | 2026-05-03 03:11:07.031562 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-03 03:11:07.584481 | debian-bookworm | changed 2026-05-03 03:11:07.591353 | 2026-05-03 03:11:07.591443 | PLAY RECAP 2026-05-03 03:11:07.591494 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-03 03:11:07.591544 | 2026-05-03 03:11:07.679334 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-03 03:11:07.680082 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-03 03:11:08.425491 | 2026-05-03 03:11:08.425609 | PLAY [Base post-logs] 2026-05-03 03:11:08.438107 | 2026-05-03 03:11:08.438218 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-03 03:11:08.900292 | localhost | changed 2026-05-03 03:11:08.909679 | 2026-05-03 03:11:08.909843 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-03 03:11:08.934342 | localhost | ok 2026-05-03 03:11:08.937196 | 2026-05-03 03:11:08.937287 | TASK [Set zuul-log-path fact] 2026-05-03 03:11:08.961671 | localhost | ok 2026-05-03 03:11:08.969121 | 2026-05-03 03:11:08.969220 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-03 03:11:08.993438 | localhost | ok 2026-05-03 03:11:08.996422 | 2026-05-03 03:11:08.996516 | TASK [upload-logs : Create log directories] 2026-05-03 03:11:09.512240 | localhost | changed 2026-05-03 03:11:09.514721 | 2026-05-03 03:11:09.515245 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-03 03:11:10.014469 | localhost -> localhost | ok: Runtime: 0:00:00.012182 2026-05-03 03:11:10.018239 | 2026-05-03 03:11:10.018336 | TASK [upload-logs : Upload logs to log server] 2026-05-03 03:11:10.842332 | localhost | Output suppressed because no_log was given 2026-05-03 03:11:10.844868 | 2026-05-03 03:11:10.844962 | LOOP [upload-logs : Compress console log and json output] 2026-05-03 03:11:11.058323 | localhost | skipping: Conditional result was False 2026-05-03 03:11:11.101656 | localhost | skipping: Conditional result was False 2026-05-03 03:11:11.112768 | 2026-05-03 03:11:11.112887 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-03 03:11:11.279495 | localhost | skipping: Conditional result was False 2026-05-03 03:11:11.279801 | 2026-05-03 03:11:11.301878 | localhost | skipping: Conditional result was False 2026-05-03 03:11:11.313905 | 2026-05-03 03:11:11.314031 | LOOP [upload-logs : Upload console log and json output]