2026-07-16 16:52:32.240553 | Job console starting 2026-07-16 16:52:32.250904 | Updating git repos 2026-07-16 16:52:32.301110 | Cloning repos into workspace 2026-07-16 16:52:32.487418 | Restoring repo states 2026-07-16 16:52:32.515162 | Merging changes 2026-07-16 16:52:33.208832 | Checking out repos 2026-07-16 16:52:33.229938 | Preparing playbooks 2026-07-16 16:52:34.228307 | Running Ansible setup 2026-07-16 16:52:39.821998 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-16 16:52:41.194582 | 2026-07-16 16:52:41.194772 | PLAY [Base pre] 2026-07-16 16:52:41.219782 | 2026-07-16 16:52:41.220132 | TASK [Setup log path fact] 2026-07-16 16:52:41.260051 | debian-bookworm | ok 2026-07-16 16:52:41.308287 | 2026-07-16 16:52:41.308476 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-16 16:52:41.376095 | debian-bookworm | ok 2026-07-16 16:52:41.395871 | 2026-07-16 16:52:41.396060 | TASK [emit-job-header : Print job information] 2026-07-16 16:52:41.476397 | # Job Information 2026-07-16 16:52:41.476595 | Ansible Version: 2.16.14 2026-07-16 16:52:41.476632 | Job: flake8 2026-07-16 16:52:41.476668 | Pipeline: check 2026-07-16 16:52:41.476691 | Executor: 521e9411259a 2026-07-16 16:52:41.476712 | Triggered by: https://github.com/osism/testbed/pull/2930 2026-07-16 16:52:41.476736 | Event ID: 74027050-8136-11f1-9fc7-fac9a2c29af2 2026-07-16 16:52:41.482459 | 2026-07-16 16:52:41.482590 | LOOP [emit-job-header : Print node information] 2026-07-16 16:52:41.616894 | debian-bookworm | ok: 2026-07-16 16:52:41.617106 | debian-bookworm | # Node Information 2026-07-16 16:52:41.617141 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-16 16:52:41.617167 | debian-bookworm | Hostname: debian 2026-07-16 16:52:41.617189 | debian-bookworm | Username: zuul 2026-07-16 16:52:41.617210 | debian-bookworm | Distro: Debian 12.15 2026-07-16 16:52:41.617257 | debian-bookworm | Provider: regiocloud-a 2026-07-16 16:52:41.617279 | debian-bookworm | Region: 2026-07-16 16:52:41.617301 | debian-bookworm | Label: debian-bookworm 2026-07-16 16:52:41.617321 | debian-bookworm | Product Name: OpenStack Nova 2026-07-16 16:52:41.617340 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fead:9d52 2026-07-16 16:52:41.639328 | 2026-07-16 16:52:41.650939 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-16 16:52:42.843439 | debian-bookworm -> localhost | changed 2026-07-16 16:52:42.852036 | 2026-07-16 16:52:42.852194 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-16 16:52:44.211463 | debian-bookworm -> localhost | changed 2026-07-16 16:52:44.221698 | 2026-07-16 16:52:44.221801 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-16 16:52:44.479122 | debian-bookworm -> localhost | ok 2026-07-16 16:52:44.490024 | 2026-07-16 16:52:44.490284 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-16 16:52:44.528473 | debian-bookworm | ok 2026-07-16 16:52:44.549506 | debian-bookworm | included: /var/lib/zuul/builds/fc2871817ff2439a86e0feb21e11b6de/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-16 16:52:44.555855 | 2026-07-16 16:52:44.555949 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-16 16:52:46.060703 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-16 16:52:46.061434 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fc2871817ff2439a86e0feb21e11b6de/work/fc2871817ff2439a86e0feb21e11b6de_id_rsa 2026-07-16 16:52:46.061555 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fc2871817ff2439a86e0feb21e11b6de/work/fc2871817ff2439a86e0feb21e11b6de_id_rsa.pub 2026-07-16 16:52:46.061627 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-16 16:52:46.061693 | debian-bookworm -> localhost | SHA256:w5qRQctPtCCpZiyZjLG86j4lT5xdc3xjy6g3DtdzbsM zuul-build-sshkey 2026-07-16 16:52:46.061751 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-16 16:52:46.061864 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-16 16:52:46.061932 | debian-bookworm -> localhost | | ..o . | 2026-07-16 16:52:46.061993 | debian-bookworm -> localhost | |. .+ + . | 2026-07-16 16:52:46.062051 | debian-bookworm -> localhost | |+* . + + | 2026-07-16 16:52:46.062135 | debian-bookworm -> localhost | |*o= O o + | 2026-07-16 16:52:46.062196 | debian-bookworm -> localhost | | +o o + S = o | 2026-07-16 16:52:46.062280 | debian-bookworm -> localhost | | o = . + o.o | 2026-07-16 16:52:46.062334 | debian-bookworm -> localhost | |. = o... o.. | 2026-07-16 16:52:46.062385 | debian-bookworm -> localhost | |.. . .oo +E | 2026-07-16 16:52:46.062542 | debian-bookworm -> localhost | |oo. o.. ... | 2026-07-16 16:52:46.063032 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-16 16:52:46.063272 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.960389 2026-07-16 16:52:46.076429 | 2026-07-16 16:52:46.076564 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-16 16:52:46.107055 | debian-bookworm | ok 2026-07-16 16:52:46.118350 | debian-bookworm | included: /var/lib/zuul/builds/fc2871817ff2439a86e0feb21e11b6de/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-16 16:52:46.128875 | 2026-07-16 16:52:46.128963 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-16 16:52:46.152092 | debian-bookworm | skipping: Conditional result was False 2026-07-16 16:52:46.158538 | 2026-07-16 16:52:46.158629 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-16 16:52:46.818499 | debian-bookworm | changed 2026-07-16 16:52:46.826292 | 2026-07-16 16:52:46.826407 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-16 16:52:47.070803 | debian-bookworm | ok 2026-07-16 16:52:47.076558 | 2026-07-16 16:52:47.076660 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-16 16:52:47.723183 | debian-bookworm | changed 2026-07-16 16:52:47.729987 | 2026-07-16 16:52:47.730121 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-16 16:52:48.406771 | debian-bookworm | changed 2026-07-16 16:52:48.414097 | 2026-07-16 16:52:48.414285 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-16 16:52:48.439209 | debian-bookworm | skipping: Conditional result was False 2026-07-16 16:52:48.449139 | 2026-07-16 16:52:48.449317 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-16 16:52:49.132040 | debian-bookworm -> localhost | changed 2026-07-16 16:52:49.147141 | 2026-07-16 16:52:49.147655 | TASK [add-build-sshkey : Add back temp key] 2026-07-16 16:52:49.545286 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fc2871817ff2439a86e0feb21e11b6de/work/fc2871817ff2439a86e0feb21e11b6de_id_rsa (zuul-build-sshkey) 2026-07-16 16:52:49.545540 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020392 2026-07-16 16:52:49.557887 | 2026-07-16 16:52:49.558003 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-16 16:52:50.041589 | debian-bookworm | ok 2026-07-16 16:52:50.049994 | 2026-07-16 16:52:50.050140 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-16 16:52:50.129169 | debian-bookworm | skipping: Conditional result was False 2026-07-16 16:52:50.147066 | 2026-07-16 16:52:50.147718 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-16 16:52:50.598626 | debian-bookworm | ok 2026-07-16 16:52:50.610362 | 2026-07-16 16:52:50.610500 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-16 16:52:50.650048 | debian-bookworm | ok 2026-07-16 16:52:50.655613 | 2026-07-16 16:52:50.655725 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-16 16:52:50.973112 | debian-bookworm -> localhost | ok 2026-07-16 16:52:50.989983 | 2026-07-16 16:52:50.990158 | TASK [validate-host : Collect information about the host] 2026-07-16 16:52:52.171681 | debian-bookworm | ok 2026-07-16 16:52:52.185480 | 2026-07-16 16:52:52.185609 | TASK [validate-host : Sanitize hostname] 2026-07-16 16:52:52.338000 | debian-bookworm | ok 2026-07-16 16:52:52.342996 | 2026-07-16 16:52:52.343112 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-16 16:52:52.985332 | debian-bookworm -> localhost | changed 2026-07-16 16:52:52.991930 | 2026-07-16 16:52:52.992058 | TASK [validate-host : Collect information about zuul worker] 2026-07-16 16:52:53.504062 | debian-bookworm | ok 2026-07-16 16:52:53.513182 | 2026-07-16 16:52:53.513361 | TASK [validate-host : Write out all zuul information for each host] 2026-07-16 16:52:54.175680 | debian-bookworm -> localhost | changed 2026-07-16 16:52:54.211793 | 2026-07-16 16:52:54.211956 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-16 16:52:54.505679 | debian-bookworm | ok 2026-07-16 16:52:54.514327 | 2026-07-16 16:52:54.514666 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-16 16:52:56.087565 | debian-bookworm | changed: 2026-07-16 16:52:56.087791 | debian-bookworm | cd+++++++++ src/ 2026-07-16 16:52:56.087828 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-16 16:52:56.087853 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-16 16:52:56.087875 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-07-16 16:52:56.087896 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/fc2871817ff2439a86e0feb21e11b6de/work/logs" 2026-07-16 16:53:58.796198 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/fc2871817ff2439a86e0feb21e11b6de/work/artifacts" 2026-07-16 16:53:59.183835 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/fc2871817ff2439a86e0feb21e11b6de/work/docs" 2026-07-16 16:53:59.204751 | 2026-07-16 16:53:59.204924 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-16 16:54:00.146269 | debian-bookworm | changed: 2026-07-16 16:54:00.146874 | debian-bookworm | .d..t...... ./ 2026-07-16 16:54:00.146948 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-16 16:54:00.146976 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-16 16:54:00.146999 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-16 16:54:00.147020 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-16 16:54:00.147040 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-16 16:54:00.147095 | debian-bookworm | changed: All items complete 2026-07-16 16:54:00.147123 | 2026-07-16 16:54:00.737943 | debian-bookworm | changed: .d..t...... ./ 2026-07-16 16:54:01.352486 | debian-bookworm | changed: .d..t...... ./ 2026-07-16 16:54:01.377797 | 2026-07-16 16:54:01.378033 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-16 16:54:01.717143 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.008321 2026-07-16 16:54:02.088484 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.012333 2026-07-16 16:54:02.115189 | 2026-07-16 16:54:02.115414 | PLAY RECAP 2026-07-16 16:54:02.115531 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-16 16:54:02.115588 | 2026-07-16 16:54:02.274015 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-16 16:54:02.275193 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-16 16:54:03.115694 | 2026-07-16 16:54:03.115911 | PLAY [Base post] 2026-07-16 16:54:03.134551 | 2026-07-16 16:54:03.134721 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-16 16:54:03.808240 | debian-bookworm | changed 2026-07-16 16:54:03.814787 | 2026-07-16 16:54:03.814931 | PLAY RECAP 2026-07-16 16:54:03.814999 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-16 16:54:03.815062 | 2026-07-16 16:54:03.948685 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-16 16:54:03.949604 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-16 16:54:04.750727 | 2026-07-16 16:54:04.750918 | PLAY [Base post-logs] 2026-07-16 16:54:04.762038 | 2026-07-16 16:54:04.762198 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-16 16:54:05.283012 | localhost | changed 2026-07-16 16:54:05.295288 | 2026-07-16 16:54:05.295500 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-16 16:54:05.336301 | localhost | ok 2026-07-16 16:54:05.343614 | 2026-07-16 16:54:05.343799 | TASK [Set zuul-log-path fact] 2026-07-16 16:54:05.362794 | localhost | ok 2026-07-16 16:54:05.376787 | 2026-07-16 16:54:05.376948 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-16 16:54:05.425227 | localhost | ok 2026-07-16 16:54:05.431385 | 2026-07-16 16:54:05.432903 | TASK [upload-logs : Create log directories] 2026-07-16 16:54:06.087362 | localhost | changed 2026-07-16 16:54:06.091261 | 2026-07-16 16:54:06.091396 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-16 16:54:06.664502 | localhost -> localhost | ok: Runtime: 0:00:00.006327 2026-07-16 16:54:06.669565 | 2026-07-16 16:54:06.669712 | TASK [upload-logs : Upload logs to log server] 2026-07-16 16:54:07.299804 | localhost | Output suppressed because no_log was given 2026-07-16 16:54:07.302000 | 2026-07-16 16:54:07.302140 | LOOP [upload-logs : Compress console log and json output] 2026-07-16 16:54:07.362720 | localhost | skipping: Conditional result was False 2026-07-16 16:54:07.370678 | localhost | skipping: Conditional result was False 2026-07-16 16:54:07.382078 | 2026-07-16 16:54:07.382327 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-16 16:54:07.435826 | localhost | skipping: Conditional result was False 2026-07-16 16:54:07.436133 | 2026-07-16 16:54:07.441135 | localhost | skipping: Conditional result was False 2026-07-16 16:54:07.447865 | 2026-07-16 16:54:07.448103 | LOOP [upload-logs : Upload console log and json output]