2026-09-22 09:29:22.715406 | Job console starting 2026-09-22 09:29:22.763500 | Updating git repos 2026-09-22 09:29:22.792720 | Cloning repos into workspace 2026-09-22 09:29:22.884984 | Restoring repo states 2026-09-22 09:29:22.892143 | Merging changes 2026-09-22 09:29:24.084163 | Checking out repos 2026-09-22 09:29:24.137001 | Preparing playbooks 2026-09-22 09:29:25.499156 | Running Ansible setup 2026-09-22 09:29:29.951559 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-22 09:29:30.688325 | 2026-09-22 09:29:30.688443 | PLAY [Base pre] 2026-09-22 09:29:30.706180 | 2026-09-22 09:29:30.706289 | TASK [Setup log path fact] 2026-09-22 09:29:30.723655 | debian-bookworm | ok 2026-09-22 09:29:30.740012 | 2026-09-22 09:29:30.740123 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-22 09:29:30.767529 | debian-bookworm | ok 2026-09-22 09:29:30.778490 | 2026-09-22 09:29:30.778585 | TASK [emit-job-header : Print job information] 2026-09-22 09:29:30.816975 | # Job Information 2026-09-22 09:29:30.817126 | Ansible Version: 2.16.14 2026-09-22 09:29:30.817161 | Job: flake8 2026-09-22 09:29:30.817195 | Pipeline: check 2026-09-22 09:29:30.817219 | Executor: 521e9411259a 2026-09-22 09:29:30.817240 | Triggered by: https://github.com/osism/testbed/pull/2955 2026-09-22 09:29:30.817262 | Event ID: 12560f80-b668-11f1-967f-77d9940ab364 2026-09-22 09:29:30.822051 | 2026-09-22 09:29:30.822141 | LOOP [emit-job-header : Print node information] 2026-09-22 09:29:30.958278 | debian-bookworm | ok: 2026-09-22 09:29:30.958477 | debian-bookworm | # Node Information 2026-09-22 09:29:30.958514 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-22 09:29:30.958539 | debian-bookworm | Hostname: debian 2026-09-22 09:29:30.958560 | debian-bookworm | Username: zuul 2026-09-22 09:29:30.958581 | debian-bookworm | Distro: Debian 12.15 2026-09-22 09:29:30.958603 | debian-bookworm | Provider: regiocloud-a 2026-09-22 09:29:30.958624 | debian-bookworm | Region: 2026-09-22 09:29:30.958645 | debian-bookworm | Label: debian-bookworm 2026-09-22 09:29:30.958664 | debian-bookworm | Product Name: OpenStack Nova 2026-09-22 09:29:30.958683 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2a:fec5 2026-09-22 09:29:30.977507 | 2026-09-22 09:29:30.986191 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-22 09:29:31.464559 | debian-bookworm -> localhost | changed 2026-09-22 09:29:31.471322 | 2026-09-22 09:29:31.471991 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-22 09:29:32.487799 | debian-bookworm -> localhost | changed 2026-09-22 09:29:32.502005 | 2026-09-22 09:29:32.502107 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-22 09:29:32.781942 | debian-bookworm -> localhost | ok 2026-09-22 09:29:32.796426 | 2026-09-22 09:29:32.796585 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-22 09:29:32.818955 | debian-bookworm | ok 2026-09-22 09:29:32.836924 | debian-bookworm | included: /var/lib/zuul/builds/b3664eb3c375419691f8b0d5a5eca2f8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-22 09:29:32.842807 | 2026-09-22 09:29:32.842939 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-22 09:29:34.313470 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-22 09:29:34.313663 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b3664eb3c375419691f8b0d5a5eca2f8/work/b3664eb3c375419691f8b0d5a5eca2f8_id_rsa 2026-09-22 09:29:34.313700 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b3664eb3c375419691f8b0d5a5eca2f8/work/b3664eb3c375419691f8b0d5a5eca2f8_id_rsa.pub 2026-09-22 09:29:34.313726 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-22 09:29:34.313751 | debian-bookworm -> localhost | SHA256:TPXpbHd86uNw3fhXpSTYIFbdQXdRKkwY9R2Jt0LB4p4 zuul-build-sshkey 2026-09-22 09:29:34.313773 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-22 09:29:34.313805 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-22 09:29:34.313828 | debian-bookworm -> localhost | | .+=++=+B| 2026-09-22 09:29:34.313862 | debian-bookworm -> localhost | | o.o=.*.*o| 2026-09-22 09:29:34.313882 | debian-bookworm -> localhost | | ....+B + o| 2026-09-22 09:29:34.313902 | debian-bookworm -> localhost | | o .+oo.o.| 2026-09-22 09:29:34.313922 | debian-bookworm -> localhost | | S . =oo.=| 2026-09-22 09:29:34.313944 | debian-bookworm -> localhost | | E ..=+| 2026-09-22 09:29:34.313964 | debian-bookworm -> localhost | | . + +| 2026-09-22 09:29:34.313983 | debian-bookworm -> localhost | | +...| 2026-09-22 09:29:34.314004 | debian-bookworm -> localhost | | .o.o| 2026-09-22 09:29:34.314024 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-22 09:29:34.314073 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.026725 2026-09-22 09:29:34.320335 | 2026-09-22 09:29:34.320417 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-22 09:29:34.337279 | debian-bookworm | ok 2026-09-22 09:29:34.347720 | debian-bookworm | included: /var/lib/zuul/builds/b3664eb3c375419691f8b0d5a5eca2f8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-22 09:29:34.355721 | 2026-09-22 09:29:34.355802 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-22 09:29:34.368578 | debian-bookworm | skipping: Conditional result was False 2026-09-22 09:29:34.374320 | 2026-09-22 09:29:34.374406 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-22 09:29:35.068075 | debian-bookworm | changed 2026-09-22 09:29:35.075980 | 2026-09-22 09:29:35.076109 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-22 09:29:35.342987 | debian-bookworm | ok 2026-09-22 09:29:35.351666 | 2026-09-22 09:29:35.351801 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-22 09:29:35.999696 | debian-bookworm | changed 2026-09-22 09:29:36.004860 | 2026-09-22 09:29:36.004943 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-22 09:29:36.635034 | debian-bookworm | changed 2026-09-22 09:29:36.643540 | 2026-09-22 09:29:36.643652 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-22 09:29:36.677671 | debian-bookworm | skipping: Conditional result was False 2026-09-22 09:29:36.690945 | 2026-09-22 09:29:36.691088 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-22 09:29:37.137083 | debian-bookworm -> localhost | changed 2026-09-22 09:29:37.148742 | 2026-09-22 09:29:37.148828 | TASK [add-build-sshkey : Add back temp key] 2026-09-22 09:29:37.481975 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b3664eb3c375419691f8b0d5a5eca2f8/work/b3664eb3c375419691f8b0d5a5eca2f8_id_rsa (zuul-build-sshkey) 2026-09-22 09:29:37.482189 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014068 2026-09-22 09:29:37.489318 | 2026-09-22 09:29:37.489419 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-22 09:29:37.913578 | debian-bookworm | ok 2026-09-22 09:29:37.920131 | 2026-09-22 09:29:37.920234 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-22 09:29:37.944036 | debian-bookworm | skipping: Conditional result was False 2026-09-22 09:29:37.958117 | 2026-09-22 09:29:37.958221 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-22 09:29:38.362250 | debian-bookworm | ok 2026-09-22 09:29:38.372724 | 2026-09-22 09:29:38.372822 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-22 09:29:38.412687 | debian-bookworm | ok 2026-09-22 09:29:38.420238 | 2026-09-22 09:29:38.420433 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-22 09:29:38.668962 | debian-bookworm -> localhost | ok 2026-09-22 09:29:38.675183 | 2026-09-22 09:29:38.675271 | TASK [validate-host : Collect information about the host] 2026-09-22 09:29:39.781040 | debian-bookworm | ok 2026-09-22 09:29:39.799242 | 2026-09-22 09:29:39.799342 | TASK [validate-host : Sanitize hostname] 2026-09-22 09:29:39.904581 | debian-bookworm | ok 2026-09-22 09:29:39.909070 | 2026-09-22 09:29:39.909162 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-22 09:29:40.407536 | debian-bookworm -> localhost | changed 2026-09-22 09:29:40.412987 | 2026-09-22 09:29:40.413078 | TASK [validate-host : Collect information about zuul worker] 2026-09-22 09:29:40.827447 | debian-bookworm | ok 2026-09-22 09:29:40.832816 | 2026-09-22 09:29:40.832948 | TASK [validate-host : Write out all zuul information for each host] 2026-09-22 09:29:41.333475 | debian-bookworm -> localhost | changed 2026-09-22 09:29:41.343814 | 2026-09-22 09:29:41.343923 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-22 09:29:41.624653 | debian-bookworm | ok 2026-09-22 09:29:41.630317 | 2026-09-22 09:29:41.630404 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-22 09:29:42.905543 | debian-bookworm | changed: 2026-09-22 09:29:42.905914 | debian-bookworm | cd+++++++++ src/ 2026-09-22 09:29:42.906017 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-22 09:29:42.906045 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-22 09:29:42.906067 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-09-22 09:29:42.906087 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/b3664eb3c375419691f8b0d5a5eca2f8/work/logs" 2026-09-22 09:30:46.704302 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b3664eb3c375419691f8b0d5a5eca2f8/work/artifacts" 2026-09-22 09:30:46.973911 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b3664eb3c375419691f8b0d5a5eca2f8/work/docs" 2026-09-22 09:30:46.989143 | 2026-09-22 09:30:46.989286 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-22 09:30:47.742532 | debian-bookworm | changed: 2026-09-22 09:30:47.742853 | debian-bookworm | .d..t...... ./ 2026-09-22 09:30:47.742954 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-22 09:30:47.742997 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-22 09:30:47.743036 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-22 09:30:47.743075 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-22 09:30:47.743114 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-22 09:30:47.743177 | debian-bookworm | changed: All items complete 2026-09-22 09:30:47.743219 | 2026-09-22 09:30:48.333858 | debian-bookworm | changed: .d..t...... ./ 2026-09-22 09:30:48.926671 | debian-bookworm | changed: .d..t...... ./ 2026-09-22 09:30:48.941587 | 2026-09-22 09:30:48.941722 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-22 09:30:49.288979 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006737 2026-09-22 09:30:49.567515 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.014450 2026-09-22 09:30:49.581307 | 2026-09-22 09:30:49.581475 | PLAY RECAP 2026-09-22 09:30:49.581530 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-22 09:30:49.581612 | 2026-09-22 09:30:49.723758 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-22 09:30:49.724605 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-22 09:30:50.464539 | 2026-09-22 09:30:50.464702 | PLAY [Base post] 2026-09-22 09:30:50.479601 | 2026-09-22 09:30:50.479751 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-22 09:30:51.048045 | debian-bookworm | changed 2026-09-22 09:30:51.055130 | 2026-09-22 09:30:51.055249 | PLAY RECAP 2026-09-22 09:30:51.055309 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-22 09:30:51.055370 | 2026-09-22 09:30:51.183214 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-22 09:30:51.185451 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-22 09:30:52.043709 | 2026-09-22 09:30:52.043920 | PLAY [Base post-logs] 2026-09-22 09:30:52.055055 | 2026-09-22 09:30:52.055211 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-22 09:30:52.497297 | localhost | changed 2026-09-22 09:30:52.513334 | 2026-09-22 09:30:52.513506 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-22 09:30:52.539237 | localhost | ok 2026-09-22 09:30:52.542319 | 2026-09-22 09:30:52.542420 | TASK [Set zuul-log-path fact] 2026-09-22 09:30:52.558763 | localhost | ok 2026-09-22 09:30:52.567074 | 2026-09-22 09:30:52.567192 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-22 09:30:52.614909 | localhost | ok 2026-09-22 09:30:52.622264 | 2026-09-22 09:30:52.622456 | TASK [upload-logs : Create log directories] 2026-09-22 09:30:53.124695 | localhost | changed 2026-09-22 09:30:53.127625 | 2026-09-22 09:30:53.127742 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-22 09:30:53.689627 | localhost -> localhost | ok: Runtime: 0:00:00.004944 2026-09-22 09:30:53.693916 | 2026-09-22 09:30:53.694041 | TASK [upload-logs : Upload logs to log server] 2026-09-22 09:30:54.251343 | localhost | Output suppressed because no_log was given 2026-09-22 09:30:54.253189 | 2026-09-22 09:30:54.253301 | LOOP [upload-logs : Compress console log and json output] 2026-09-22 09:30:54.313141 | localhost | skipping: Conditional result was False 2026-09-22 09:30:54.318018 | localhost | skipping: Conditional result was False 2026-09-22 09:30:54.337362 | 2026-09-22 09:30:54.337475 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-22 09:30:54.383918 | localhost | skipping: Conditional result was False 2026-09-22 09:30:54.384192 | 2026-09-22 09:30:54.389218 | localhost | skipping: Conditional result was False 2026-09-22 09:30:54.402608 | 2026-09-22 09:30:54.402806 | LOOP [upload-logs : Upload console log and json output]