2026-05-18 09:35:49.780522 | Job console starting 2026-05-18 09:35:49.797339 | Updating git repos 2026-05-18 09:35:50.339350 | Cloning repos into workspace 2026-05-18 09:35:50.385891 | Restoring repo states 2026-05-18 09:35:50.423888 | Merging changes 2026-05-18 09:35:51.186491 | Checking out repos 2026-05-18 09:35:51.264969 | Preparing playbooks 2026-05-18 09:35:52.740820 | Running Ansible setup 2026-05-18 09:35:58.577411 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-18 09:35:59.473224 | 2026-05-18 09:35:59.473349 | PLAY [Base pre] 2026-05-18 09:35:59.486821 | 2026-05-18 09:35:59.486942 | TASK [Setup log path fact] 2026-05-18 09:35:59.503904 | debian-bookworm | ok 2026-05-18 09:35:59.516585 | 2026-05-18 09:35:59.516695 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 09:35:59.543788 | debian-bookworm | ok 2026-05-18 09:35:59.553537 | 2026-05-18 09:35:59.553637 | TASK [emit-job-header : Print job information] 2026-05-18 09:35:59.616303 | # Job Information 2026-05-18 09:35:59.616446 | Ansible Version: 2.16.14 2026-05-18 09:35:59.616474 | Job: flake8 2026-05-18 09:35:59.616500 | Pipeline: check 2026-05-18 09:35:59.616518 | Executor: 521e9411259a 2026-05-18 09:35:59.616535 | Triggered by: https://github.com/osism/openstack-sandbox-manager/pull/111 2026-05-18 09:35:59.616553 | Event ID: ee459770-529c-11f1-9600-e4531790ac09 2026-05-18 09:35:59.620551 | 2026-05-18 09:35:59.620637 | LOOP [emit-job-header : Print node information] 2026-05-18 09:35:59.842401 | debian-bookworm | ok: 2026-05-18 09:35:59.842622 | debian-bookworm | # Node Information 2026-05-18 09:35:59.842655 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-18 09:35:59.842676 | debian-bookworm | Hostname: debian 2026-05-18 09:35:59.842694 | debian-bookworm | Username: zuul 2026-05-18 09:35:59.842710 | debian-bookworm | Distro: Debian 12.14 2026-05-18 09:35:59.842732 | debian-bookworm | Provider: regiocloud-a 2026-05-18 09:35:59.842750 | debian-bookworm | Region: 2026-05-18 09:35:59.842767 | debian-bookworm | Label: debian-bookworm 2026-05-18 09:35:59.842783 | debian-bookworm | Product Name: OpenStack Nova 2026-05-18 09:35:59.842798 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe59:fbc7 2026-05-18 09:35:59.861478 | 2026-05-18 09:35:59.861579 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-18 09:36:01.069600 | debian-bookworm -> localhost | changed 2026-05-18 09:36:01.075361 | 2026-05-18 09:36:01.075455 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-18 09:36:03.256124 | debian-bookworm -> localhost | changed 2026-05-18 09:36:03.264808 | 2026-05-18 09:36:03.264899 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-18 09:36:03.889889 | debian-bookworm -> localhost | ok 2026-05-18 09:36:03.894892 | 2026-05-18 09:36:03.895311 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-18 09:36:03.933336 | debian-bookworm | ok 2026-05-18 09:36:03.958684 | debian-bookworm | included: /var/lib/zuul/builds/4958efba5a6b478a9d70ce1348f04409/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-18 09:36:03.975570 | 2026-05-18 09:36:03.975709 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-18 09:36:05.957105 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-18 09:36:05.957280 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4958efba5a6b478a9d70ce1348f04409/work/4958efba5a6b478a9d70ce1348f04409_id_rsa 2026-05-18 09:36:05.957313 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4958efba5a6b478a9d70ce1348f04409/work/4958efba5a6b478a9d70ce1348f04409_id_rsa.pub 2026-05-18 09:36:05.957336 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-18 09:36:05.957356 | debian-bookworm -> localhost | SHA256:Zny/K5MadEnzDXdq5SbcJhQqh0PtTYoGY1txQyXpObc zuul-build-sshkey 2026-05-18 09:36:05.957374 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-18 09:36:05.957401 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-18 09:36:05.957420 | debian-bookworm -> localhost | | o+=oo | 2026-05-18 09:36:05.957438 | debian-bookworm -> localhost | | +..oo+.. | 2026-05-18 09:36:05.957456 | debian-bookworm -> localhost | | . =*++=o o| 2026-05-18 09:36:05.957473 | debian-bookworm -> localhost | | ...oB**o* | 2026-05-18 09:36:05.957490 | debian-bookworm -> localhost | | S.+ .oB.=| 2026-05-18 09:36:05.957512 | debian-bookworm -> localhost | | + o . .E= | 2026-05-18 09:36:05.957530 | debian-bookworm -> localhost | | . .. | 2026-05-18 09:36:05.957546 | debian-bookworm -> localhost | | .+ . | 2026-05-18 09:36:05.957563 | debian-bookworm -> localhost | | .. oo. | 2026-05-18 09:36:05.957580 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-18 09:36:05.957622 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.331448 2026-05-18 09:36:05.962792 | 2026-05-18 09:36:05.962916 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-18 09:36:05.984068 | debian-bookworm | ok 2026-05-18 09:36:05.994114 | debian-bookworm | included: /var/lib/zuul/builds/4958efba5a6b478a9d70ce1348f04409/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-18 09:36:06.001636 | 2026-05-18 09:36:06.001720 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-18 09:36:06.046355 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:36:06.051609 | 2026-05-18 09:36:06.051702 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-18 09:36:06.733425 | debian-bookworm | changed 2026-05-18 09:36:06.738781 | 2026-05-18 09:36:06.738884 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-18 09:36:06.990370 | debian-bookworm | ok 2026-05-18 09:36:06.994792 | 2026-05-18 09:36:06.994894 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-18 09:36:07.675222 | debian-bookworm | changed 2026-05-18 09:36:07.681953 | 2026-05-18 09:36:07.682041 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-18 09:36:08.380515 | debian-bookworm | changed 2026-05-18 09:36:08.385446 | 2026-05-18 09:36:08.385534 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-18 09:36:08.425191 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:36:08.431012 | 2026-05-18 09:36:08.431104 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-18 09:36:09.173557 | debian-bookworm -> localhost | changed 2026-05-18 09:36:09.182577 | 2026-05-18 09:36:09.182682 | TASK [add-build-sshkey : Add back temp key] 2026-05-18 09:36:09.489024 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4958efba5a6b478a9d70ce1348f04409/work/4958efba5a6b478a9d70ce1348f04409_id_rsa (zuul-build-sshkey) 2026-05-18 09:36:09.489212 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015811 2026-05-18 09:36:09.495786 | 2026-05-18 09:36:09.495869 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-18 09:36:09.848180 | debian-bookworm | ok 2026-05-18 09:36:09.852383 | 2026-05-18 09:36:09.852477 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-18 09:36:09.879890 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:36:09.888357 | 2026-05-18 09:36:09.888457 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-18 09:36:10.323003 | debian-bookworm | ok 2026-05-18 09:36:10.347319 | 2026-05-18 09:36:10.347419 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-18 09:36:10.417522 | debian-bookworm | ok 2026-05-18 09:36:10.422505 | 2026-05-18 09:36:10.422611 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-18 09:36:11.072336 | debian-bookworm -> localhost | ok 2026-05-18 09:36:11.078607 | 2026-05-18 09:36:11.078724 | TASK [validate-host : Collect information about the host] 2026-05-18 09:36:12.442625 | debian-bookworm | ok 2026-05-18 09:36:12.457066 | 2026-05-18 09:36:12.457181 | TASK [validate-host : Sanitize hostname] 2026-05-18 09:36:12.647966 | debian-bookworm | ok 2026-05-18 09:36:12.696403 | 2026-05-18 09:36:12.696512 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-18 09:36:13.818935 | debian-bookworm -> localhost | changed 2026-05-18 09:36:13.824360 | 2026-05-18 09:36:13.824451 | TASK [validate-host : Collect information about zuul worker] 2026-05-18 09:36:14.271095 | debian-bookworm | ok 2026-05-18 09:36:14.275874 | 2026-05-18 09:36:14.275959 | TASK [validate-host : Write out all zuul information for each host] 2026-05-18 09:36:14.796058 | debian-bookworm -> localhost | changed 2026-05-18 09:36:14.804651 | 2026-05-18 09:36:14.804756 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-18 09:36:15.065881 | debian-bookworm | ok 2026-05-18 09:36:15.070726 | 2026-05-18 09:36:15.070854 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-18 09:36:15.781491 | debian-bookworm | changed: 2026-05-18 09:36:15.781660 | debian-bookworm | cd+++++++++ src/ 2026-05-18 09:36:15.781693 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-18 09:36:15.781716 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-18 09:36:15.781737 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2026-05-18 09:36:15.781756 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/4958efba5a6b478a9d70ce1348f04409/work/logs" 2026-05-18 09:36:42.073201 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/4958efba5a6b478a9d70ce1348f04409/work/artifacts" 2026-05-18 09:36:42.556929 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/4958efba5a6b478a9d70ce1348f04409/work/docs" 2026-05-18 09:36:42.570323 | 2026-05-18 09:36:42.570443 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-18 09:36:43.805720 | debian-bookworm | changed: 2026-05-18 09:36:43.805896 | debian-bookworm | .d..t...... ./ 2026-05-18 09:36:43.805925 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-18 09:36:43.805951 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-18 09:36:43.805972 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-18 09:36:43.806003 | debian-bookworm | changed: All items complete 2026-05-18 09:36:43.806028 | 2026-05-18 09:36:44.772475 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 09:36:45.953789 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 09:36:45.973849 | 2026-05-18 09:36:45.973952 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-18 09:36:47.310260 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.020332 2026-05-18 09:36:47.940979 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.017353 2026-05-18 09:36:47.954357 | 2026-05-18 09:36:47.954444 | PLAY RECAP 2026-05-18 09:36:47.954486 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-18 09:36:47.954508 | 2026-05-18 09:36:48.343142 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-18 09:36:48.343918 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 09:36:50.105068 | 2026-05-18 09:36:50.105193 | PLAY [Base post] 2026-05-18 09:36:50.132663 | 2026-05-18 09:36:50.132776 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-18 09:36:50.821326 | debian-bookworm | changed 2026-05-18 09:36:50.830959 | 2026-05-18 09:36:50.831054 | PLAY RECAP 2026-05-18 09:36:50.831105 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-18 09:36:50.831156 | 2026-05-18 09:36:50.967498 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 09:36:50.968263 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-18 09:36:52.767255 | 2026-05-18 09:36:52.767382 | PLAY [Base post-logs] 2026-05-18 09:36:52.775445 | 2026-05-18 09:36:52.775555 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-18 09:36:53.717861 | localhost | changed 2026-05-18 09:36:53.732893 | 2026-05-18 09:36:53.733092 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-18 09:36:53.769510 | localhost | ok 2026-05-18 09:36:53.773764 | 2026-05-18 09:36:53.773857 | TASK [Set zuul-log-path fact] 2026-05-18 09:36:53.800448 | localhost | ok 2026-05-18 09:36:53.813957 | 2026-05-18 09:36:53.814956 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 09:36:53.851285 | localhost | ok 2026-05-18 09:36:53.855261 | 2026-05-18 09:36:53.855355 | TASK [upload-logs : Create log directories] 2026-05-18 09:36:54.630023 | localhost | changed 2026-05-18 09:36:54.637523 | 2026-05-18 09:36:54.637622 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-18 09:36:55.397076 | localhost -> localhost | ok: Runtime: 0:00:00.011906 2026-05-18 09:36:55.404935 | 2026-05-18 09:36:55.405091 | TASK [upload-logs : Upload logs to log server] 2026-05-18 09:36:56.130638 | localhost | Output suppressed because no_log was given 2026-05-18 09:36:56.132748 | 2026-05-18 09:36:56.132846 | LOOP [upload-logs : Compress console log and json output] 2026-05-18 09:36:56.201842 | localhost | skipping: Conditional result was False 2026-05-18 09:36:56.210872 | localhost | skipping: Conditional result was False 2026-05-18 09:36:56.220064 | 2026-05-18 09:36:56.220157 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-18 09:36:56.287720 | localhost | skipping: Conditional result was False 2026-05-18 09:36:56.287949 | 2026-05-18 09:36:56.297894 | localhost | skipping: Conditional result was False 2026-05-18 09:36:56.312544 | 2026-05-18 09:36:56.312647 | LOOP [upload-logs : Upload console log and json output]