2026-05-15 13:17:42.505572 | Job console starting 2026-05-15 13:17:42.529789 | Updating git repos 2026-05-15 13:17:42.575821 | Cloning repos into workspace 2026-05-15 13:17:42.664118 | Restoring repo states 2026-05-15 13:17:42.684419 | Merging changes 2026-05-15 13:17:43.209777 | Checking out repos 2026-05-15 13:17:43.256582 | Preparing playbooks 2026-05-15 13:17:44.181384 | Running Ansible setup 2026-05-15 13:17:49.948502 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-15 13:17:50.828688 | 2026-05-15 13:17:50.828867 | PLAY [Base pre] 2026-05-15 13:17:50.873607 | 2026-05-15 13:17:50.873780 | TASK [Setup log path fact] 2026-05-15 13:17:50.939835 | debian-bookworm | ok 2026-05-15 13:17:50.974023 | 2026-05-15 13:17:50.974194 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-15 13:17:51.030867 | debian-bookworm | ok 2026-05-15 13:17:51.051782 | 2026-05-15 13:17:51.051936 | TASK [emit-job-header : Print job information] 2026-05-15 13:17:51.140277 | # Job Information 2026-05-15 13:17:51.140480 | Ansible Version: 2.16.14 2026-05-15 13:17:51.140518 | Job: flake8 2026-05-15 13:17:51.140554 | Pipeline: check 2026-05-15 13:17:51.140578 | Executor: 521e9411259a 2026-05-15 13:17:51.140599 | Triggered by: https://github.com/osism/testbed/pull/2890 2026-05-15 13:17:51.140622 | Event ID: 6e857ac0-5060-11f1-9ab8-97abe5d60244 2026-05-15 13:17:51.146065 | 2026-05-15 13:17:51.146198 | LOOP [emit-job-header : Print node information] 2026-05-15 13:17:51.267464 | debian-bookworm | ok: 2026-05-15 13:17:51.268047 | debian-bookworm | # Node Information 2026-05-15 13:17:51.268272 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-15 13:17:51.268553 | debian-bookworm | Hostname: debian 2026-05-15 13:17:51.268594 | debian-bookworm | Username: zuul 2026-05-15 13:17:51.268762 | debian-bookworm | Distro: Debian 12.13 2026-05-15 13:17:51.268800 | debian-bookworm | Provider: regiocloud-a 2026-05-15 13:17:51.268824 | debian-bookworm | Region: 2026-05-15 13:17:51.268847 | debian-bookworm | Label: debian-bookworm 2026-05-15 13:17:51.268868 | debian-bookworm | Product Name: OpenStack Nova 2026-05-15 13:17:51.268888 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe35:a6a7 2026-05-15 13:17:51.286993 | 2026-05-15 13:17:51.287178 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-15 13:17:51.971657 | debian-bookworm -> localhost | changed 2026-05-15 13:17:51.979091 | 2026-05-15 13:17:51.979226 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-15 13:17:53.228311 | debian-bookworm -> localhost | changed 2026-05-15 13:17:53.239230 | 2026-05-15 13:17:53.239369 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-15 13:17:53.518482 | debian-bookworm -> localhost | ok 2026-05-15 13:17:53.528447 | 2026-05-15 13:17:53.528618 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-15 13:17:53.576752 | debian-bookworm | ok 2026-05-15 13:17:53.594665 | debian-bookworm | included: /var/lib/zuul/builds/b264ec3a84b340e8819215fb7d6e2755/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-15 13:17:53.600895 | 2026-05-15 13:17:53.600993 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-15 13:17:54.787847 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-15 13:17:54.788439 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b264ec3a84b340e8819215fb7d6e2755/work/b264ec3a84b340e8819215fb7d6e2755_id_rsa 2026-05-15 13:17:54.788547 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b264ec3a84b340e8819215fb7d6e2755/work/b264ec3a84b340e8819215fb7d6e2755_id_rsa.pub 2026-05-15 13:17:54.788622 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-15 13:17:54.788691 | debian-bookworm -> localhost | SHA256:S2n3eLC72X7rv/4X1KVX56Rum9yxQEL3LxjQdUDycQM zuul-build-sshkey 2026-05-15 13:17:54.788754 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-15 13:17:54.788849 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-15 13:17:54.788914 | debian-bookworm -> localhost | | ..E*oo| 2026-05-15 13:17:54.788975 | debian-bookworm -> localhost | | ...+ +*| 2026-05-15 13:17:54.789066 | debian-bookworm -> localhost | | ... o==| 2026-05-15 13:17:54.789127 | debian-bookworm -> localhost | | . ...oo+| 2026-05-15 13:17:54.789184 | debian-bookworm -> localhost | | S o o+...| 2026-05-15 13:17:54.789256 | debian-bookworm -> localhost | | o o =..+o.| 2026-05-15 13:17:54.789314 | debian-bookworm -> localhost | | . o oo.=+| 2026-05-15 13:17:54.789369 | debian-bookworm -> localhost | | = =.o| 2026-05-15 13:17:54.789424 | debian-bookworm -> localhost | | +ooo+=*| 2026-05-15 13:17:54.789479 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-15 13:17:54.789617 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.600711 2026-05-15 13:17:54.803550 | 2026-05-15 13:17:54.803729 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-15 13:17:54.833467 | debian-bookworm | ok 2026-05-15 13:17:54.843672 | debian-bookworm | included: /var/lib/zuul/builds/b264ec3a84b340e8819215fb7d6e2755/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-15 13:17:54.853021 | 2026-05-15 13:17:54.853120 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-15 13:17:54.876809 | debian-bookworm | skipping: Conditional result was False 2026-05-15 13:17:54.883567 | 2026-05-15 13:17:54.883680 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-15 13:17:55.573530 | debian-bookworm | changed 2026-05-15 13:17:55.579250 | 2026-05-15 13:17:55.579375 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-15 13:17:55.832062 | debian-bookworm | ok 2026-05-15 13:17:55.845238 | 2026-05-15 13:17:55.845389 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-15 13:17:56.537949 | debian-bookworm | changed 2026-05-15 13:17:56.545251 | 2026-05-15 13:17:56.545385 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-15 13:17:57.232524 | debian-bookworm | changed 2026-05-15 13:17:57.238078 | 2026-05-15 13:17:57.238179 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-15 13:17:57.271091 | debian-bookworm | skipping: Conditional result was False 2026-05-15 13:17:57.277339 | 2026-05-15 13:17:57.277465 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-15 13:17:57.758728 | debian-bookworm -> localhost | changed 2026-05-15 13:17:57.773895 | 2026-05-15 13:17:57.774074 | TASK [add-build-sshkey : Add back temp key] 2026-05-15 13:17:58.126063 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b264ec3a84b340e8819215fb7d6e2755/work/b264ec3a84b340e8819215fb7d6e2755_id_rsa (zuul-build-sshkey) 2026-05-15 13:17:58.126314 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018440 2026-05-15 13:17:58.134560 | 2026-05-15 13:17:58.134688 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-15 13:17:58.561616 | debian-bookworm | ok 2026-05-15 13:17:58.567672 | 2026-05-15 13:17:58.567795 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-15 13:17:58.602438 | debian-bookworm | skipping: Conditional result was False 2026-05-15 13:17:58.613258 | 2026-05-15 13:17:58.613434 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-15 13:17:59.080266 | debian-bookworm | ok 2026-05-15 13:17:59.094605 | 2026-05-15 13:17:59.094744 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-15 13:17:59.124842 | debian-bookworm | ok 2026-05-15 13:17:59.130190 | 2026-05-15 13:17:59.130309 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-15 13:17:59.419029 | debian-bookworm -> localhost | ok 2026-05-15 13:17:59.427159 | 2026-05-15 13:17:59.427298 | TASK [validate-host : Collect information about the host] 2026-05-15 13:18:00.607605 | debian-bookworm | ok 2026-05-15 13:18:00.621275 | 2026-05-15 13:18:00.621411 | TASK [validate-host : Sanitize hostname] 2026-05-15 13:18:00.733221 | debian-bookworm | ok 2026-05-15 13:18:00.774247 | 2026-05-15 13:18:00.774382 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-15 13:18:01.385593 | debian-bookworm -> localhost | changed 2026-05-15 13:18:01.391784 | 2026-05-15 13:18:01.391910 | TASK [validate-host : Collect information about zuul worker] 2026-05-15 13:18:01.832421 | debian-bookworm | ok 2026-05-15 13:18:01.839544 | 2026-05-15 13:18:01.839685 | TASK [validate-host : Write out all zuul information for each host] 2026-05-15 13:18:02.455066 | debian-bookworm -> localhost | changed 2026-05-15 13:18:02.465624 | 2026-05-15 13:18:02.465752 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-15 13:18:02.739040 | debian-bookworm | ok 2026-05-15 13:18:02.748328 | 2026-05-15 13:18:02.748466 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-15 13:18:03.907176 | debian-bookworm | changed: 2026-05-15 13:18:03.907443 | debian-bookworm | cd+++++++++ src/ 2026-05-15 13:18:03.907495 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-15 13:18:03.907537 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-15 13:18:03.907574 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-05-15 13:18:03.907610 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/b264ec3a84b340e8819215fb7d6e2755/work/logs" 2026-05-15 13:18:29.475711 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b264ec3a84b340e8819215fb7d6e2755/work/artifacts" 2026-05-15 13:18:29.805381 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b264ec3a84b340e8819215fb7d6e2755/work/docs" 2026-05-15 13:18:29.826815 | 2026-05-15 13:18:29.827000 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-15 13:18:30.599787 | debian-bookworm | changed: 2026-05-15 13:18:30.600112 | debian-bookworm | .d..t...... ./ 2026-05-15 13:18:30.600161 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-15 13:18:30.600206 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-15 13:18:30.600234 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-15 13:18:30.600282 | debian-bookworm | changed: All items complete 2026-05-15 13:18:30.600309 | 2026-05-15 13:18:31.171563 | debian-bookworm | changed: .d..t...... ./ 2026-05-15 13:18:31.715436 | debian-bookworm | changed: .d..t...... ./ 2026-05-15 13:18:31.731634 | 2026-05-15 13:18:31.731769 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-15 13:18:32.257220 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009452 2026-05-15 13:18:32.518295 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010840 2026-05-15 13:18:32.536757 | 2026-05-15 13:18:32.536901 | PLAY RECAP 2026-05-15 13:18:32.536983 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-15 13:18:32.537042 | 2026-05-15 13:18:32.684769 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-15 13:18:32.685698 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-15 13:18:33.462516 | 2026-05-15 13:18:33.462696 | PLAY [Base post] 2026-05-15 13:18:33.476858 | 2026-05-15 13:18:33.477057 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-15 13:18:34.059765 | debian-bookworm | changed 2026-05-15 13:18:34.067195 | 2026-05-15 13:18:34.067322 | PLAY RECAP 2026-05-15 13:18:34.067388 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-15 13:18:34.067449 | 2026-05-15 13:18:34.214173 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-15 13:18:34.215694 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-15 13:18:35.021710 | 2026-05-15 13:18:35.021886 | PLAY [Base post-logs] 2026-05-15 13:18:35.032863 | 2026-05-15 13:18:35.033061 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-15 13:18:35.520712 | localhost | changed 2026-05-15 13:18:35.537719 | 2026-05-15 13:18:35.537947 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-15 13:18:35.566939 | localhost | ok 2026-05-15 13:18:35.574605 | 2026-05-15 13:18:35.574799 | TASK [Set zuul-log-path fact] 2026-05-15 13:18:35.593288 | localhost | ok 2026-05-15 13:18:35.605216 | 2026-05-15 13:18:35.605366 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-15 13:18:35.631459 | localhost | ok 2026-05-15 13:18:35.634624 | 2026-05-15 13:18:35.634735 | TASK [upload-logs : Create log directories] 2026-05-15 13:18:36.120376 | localhost | changed 2026-05-15 13:18:36.123247 | 2026-05-15 13:18:36.123354 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-15 13:18:36.741847 | localhost -> localhost | ok: Runtime: 0:00:00.009090 2026-05-15 13:18:36.745985 | 2026-05-15 13:18:36.746131 | TASK [upload-logs : Upload logs to log server] 2026-05-15 13:18:37.428032 | localhost | Output suppressed because no_log was given 2026-05-15 13:18:37.432411 | 2026-05-15 13:18:37.432632 | LOOP [upload-logs : Compress console log and json output] 2026-05-15 13:18:37.485420 | localhost | skipping: Conditional result was False 2026-05-15 13:18:37.491517 | localhost | skipping: Conditional result was False 2026-05-15 13:18:37.495818 | 2026-05-15 13:18:37.495925 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-15 13:18:37.553330 | localhost | skipping: Conditional result was False 2026-05-15 13:18:37.553770 | 2026-05-15 13:18:37.558763 | localhost | skipping: Conditional result was False 2026-05-15 13:18:37.568798 | 2026-05-15 13:18:37.569081 | LOOP [upload-logs : Upload console log and json output]