2026-05-06 00:54:29.064947 | Job console starting 2026-05-06 00:54:29.091423 | Updating git repos 2026-05-06 00:54:29.163201 | Cloning repos into workspace 2026-05-06 00:54:29.256564 | Restoring repo states 2026-05-06 00:54:29.298658 | Merging changes 2026-05-06 00:54:30.081813 | Checking out repos 2026-05-06 00:54:30.149640 | Preparing playbooks 2026-05-06 00:54:31.074227 | Running Ansible setup 2026-05-06 00:54:36.991452 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-06 00:54:38.429384 | 2026-05-06 00:54:38.429559 | PLAY [Base pre] 2026-05-06 00:54:38.448952 | 2026-05-06 00:54:38.449109 | TASK [Setup log path fact] 2026-05-06 00:54:38.475560 | debian-bookworm | ok 2026-05-06 00:54:38.517779 | 2026-05-06 00:54:38.517960 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-06 00:54:38.598796 | debian-bookworm | ok 2026-05-06 00:54:38.609697 | 2026-05-06 00:54:38.609852 | TASK [emit-job-header : Print job information] 2026-05-06 00:54:38.704743 | # Job Information 2026-05-06 00:54:38.704953 | Ansible Version: 2.16.14 2026-05-06 00:54:38.704990 | Job: python-black 2026-05-06 00:54:38.705024 | Pipeline: check 2026-05-06 00:54:38.705048 | Executor: 521e9411259a 2026-05-06 00:54:38.705070 | Triggered by: https://github.com/osism/generics/pull/592 2026-05-06 00:54:38.705093 | Event ID: 1c0e4050-48e6-11f1-9953-1215d715fa57 2026-05-06 00:54:38.715897 | 2026-05-06 00:54:38.716056 | LOOP [emit-job-header : Print node information] 2026-05-06 00:54:38.847935 | debian-bookworm | ok: 2026-05-06 00:54:38.848210 | debian-bookworm | # Node Information 2026-05-06 00:54:38.848245 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-06 00:54:38.848269 | debian-bookworm | Hostname: debian 2026-05-06 00:54:38.848291 | debian-bookworm | Username: zuul 2026-05-06 00:54:38.848313 | debian-bookworm | Distro: Debian 12.13 2026-05-06 00:54:38.848356 | debian-bookworm | Provider: regiocloud-a 2026-05-06 00:54:38.848378 | debian-bookworm | Region: 2026-05-06 00:54:38.848399 | debian-bookworm | Label: debian-bookworm 2026-05-06 00:54:38.848419 | debian-bookworm | Product Name: OpenStack Nova 2026-05-06 00:54:38.848440 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe53:6bed 2026-05-06 00:54:38.865156 | 2026-05-06 00:54:38.865305 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-06 00:54:39.884733 | debian-bookworm -> localhost | changed 2026-05-06 00:54:39.893755 | 2026-05-06 00:54:39.893913 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-06 00:54:42.149417 | debian-bookworm -> localhost | changed 2026-05-06 00:54:42.163009 | 2026-05-06 00:54:42.163123 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-06 00:54:42.806641 | debian-bookworm -> localhost | ok 2026-05-06 00:54:42.812565 | 2026-05-06 00:54:42.812699 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-06 00:54:42.851018 | debian-bookworm | ok 2026-05-06 00:54:42.891502 | debian-bookworm | included: /var/lib/zuul/builds/d9981d2821714f87a9b538129de245d1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-06 00:54:42.906062 | 2026-05-06 00:54:42.906166 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-06 00:54:45.165148 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-06 00:54:45.165316 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d9981d2821714f87a9b538129de245d1/work/d9981d2821714f87a9b538129de245d1_id_rsa 2026-05-06 00:54:45.165368 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d9981d2821714f87a9b538129de245d1/work/d9981d2821714f87a9b538129de245d1_id_rsa.pub 2026-05-06 00:54:45.165393 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-06 00:54:45.165414 | debian-bookworm -> localhost | SHA256:XtFsnPr9LYizJ27in7JqXme9ObFJVGLyAt3Wh1japPw zuul-build-sshkey 2026-05-06 00:54:45.165433 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-06 00:54:45.165460 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-06 00:54:45.165479 | debian-bookworm -> localhost | | . . +o. | 2026-05-06 00:54:45.165497 | debian-bookworm -> localhost | | . o=**+ .| 2026-05-06 00:54:45.165514 | debian-bookworm -> localhost | | ..=Xo.. | 2026-05-06 00:54:45.165530 | debian-bookworm -> localhost | | .+o. | 2026-05-06 00:54:45.165547 | debian-bookworm -> localhost | | S oo E | 2026-05-06 00:54:45.165569 | debian-bookworm -> localhost | | . . oo. | 2026-05-06 00:54:45.165586 | debian-bookworm -> localhost | | o ooo=. | 2026-05-06 00:54:45.165602 | debian-bookworm -> localhost | | ..oo=.*o...| 2026-05-06 00:54:45.165619 | debian-bookworm -> localhost | | ooooB==o. .o| 2026-05-06 00:54:45.165636 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-06 00:54:45.165683 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.235204 2026-05-06 00:54:45.170745 | 2026-05-06 00:54:45.170826 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-06 00:54:45.208123 | debian-bookworm | ok 2026-05-06 00:54:45.220571 | debian-bookworm | included: /var/lib/zuul/builds/d9981d2821714f87a9b538129de245d1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-06 00:54:45.233537 | 2026-05-06 00:54:45.233638 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-06 00:54:45.256797 | debian-bookworm | skipping: Conditional result was False 2026-05-06 00:54:45.261721 | 2026-05-06 00:54:45.261813 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-06 00:54:45.950415 | debian-bookworm | changed 2026-05-06 00:54:45.963971 | 2026-05-06 00:54:45.964129 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-06 00:54:46.238032 | debian-bookworm | ok 2026-05-06 00:54:46.243121 | 2026-05-06 00:54:46.243216 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-06 00:54:46.973447 | debian-bookworm | changed 2026-05-06 00:54:46.981139 | 2026-05-06 00:54:46.981244 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-06 00:54:47.673878 | debian-bookworm | changed 2026-05-06 00:54:47.681813 | 2026-05-06 00:54:47.681935 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-06 00:54:47.705447 | debian-bookworm | skipping: Conditional result was False 2026-05-06 00:54:47.711581 | 2026-05-06 00:54:47.711683 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-06 00:54:48.185639 | debian-bookworm -> localhost | changed 2026-05-06 00:54:48.196419 | 2026-05-06 00:54:48.196526 | TASK [add-build-sshkey : Add back temp key] 2026-05-06 00:54:48.614606 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d9981d2821714f87a9b538129de245d1/work/d9981d2821714f87a9b538129de245d1_id_rsa (zuul-build-sshkey) 2026-05-06 00:54:48.614823 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010411 2026-05-06 00:54:48.622589 | 2026-05-06 00:54:48.622680 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-06 00:54:49.140574 | debian-bookworm | ok 2026-05-06 00:54:49.145869 | 2026-05-06 00:54:49.145977 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-06 00:54:49.189665 | debian-bookworm | skipping: Conditional result was False 2026-05-06 00:54:49.200718 | 2026-05-06 00:54:49.200853 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-06 00:54:49.720867 | debian-bookworm | ok 2026-05-06 00:54:49.741530 | 2026-05-06 00:54:49.741658 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-06 00:54:49.781015 | debian-bookworm | ok 2026-05-06 00:54:49.787013 | 2026-05-06 00:54:49.787129 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-06 00:54:50.095276 | debian-bookworm -> localhost | ok 2026-05-06 00:54:50.101602 | 2026-05-06 00:54:50.101692 | TASK [validate-host : Collect information about the host] 2026-05-06 00:54:51.554909 | debian-bookworm | ok 2026-05-06 00:54:51.573443 | 2026-05-06 00:54:51.573621 | TASK [validate-host : Sanitize hostname] 2026-05-06 00:54:51.719273 | debian-bookworm | ok 2026-05-06 00:54:51.769320 | 2026-05-06 00:54:51.769504 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-06 00:54:52.877770 | debian-bookworm -> localhost | changed 2026-05-06 00:54:52.884517 | 2026-05-06 00:54:52.884661 | TASK [validate-host : Collect information about zuul worker] 2026-05-06 00:54:53.442200 | debian-bookworm | ok 2026-05-06 00:54:53.447734 | 2026-05-06 00:54:53.447869 | TASK [validate-host : Write out all zuul information for each host] 2026-05-06 00:54:54.293784 | debian-bookworm -> localhost | changed 2026-05-06 00:54:54.306121 | 2026-05-06 00:54:54.306262 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-06 00:54:54.624431 | debian-bookworm | ok 2026-05-06 00:54:54.632113 | 2026-05-06 00:54:54.632265 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-06 00:54:55.542672 | debian-bookworm | changed: 2026-05-06 00:54:55.545321 | debian-bookworm | cd+++++++++ src/ 2026-05-06 00:54:55.546934 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-06 00:54:55.547024 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-06 00:54:55.547054 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-05-06 00:54:55.547078 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/d9981d2821714f87a9b538129de245d1/work/logs" 2026-05-06 00:55:24.664960 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d9981d2821714f87a9b538129de245d1/work/artifacts" 2026-05-06 00:55:24.933111 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d9981d2821714f87a9b538129de245d1/work/docs" 2026-05-06 00:55:24.973621 | 2026-05-06 00:55:24.973790 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-06 00:55:25.880890 | debian-bookworm | changed: 2026-05-06 00:55:25.881140 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-06 00:55:25.881176 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-06 00:55:25.881206 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-06 00:55:25.881250 | debian-bookworm | changed: All items complete 2026-05-06 00:55:25.881277 | 2026-05-06 00:55:26.506622 | debian-bookworm | changed: .d..t...... ./ 2026-05-06 00:55:27.094176 | debian-bookworm | changed: .d..t...... ./ 2026-05-06 00:55:27.109955 | 2026-05-06 00:55:27.110090 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-06 00:55:27.722037 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.039380 2026-05-06 00:55:28.109813 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.030038 2026-05-06 00:55:28.126138 | 2026-05-06 00:55:28.126377 | PLAY RECAP 2026-05-06 00:55:28.126460 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-06 00:55:28.126498 | 2026-05-06 00:55:28.308875 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-06 00:55:28.309824 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-06 00:55:29.114969 | 2026-05-06 00:55:29.115156 | PLAY [Base post] 2026-05-06 00:55:29.130018 | 2026-05-06 00:55:29.130206 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-06 00:55:29.763949 | debian-bookworm | changed 2026-05-06 00:55:29.777116 | 2026-05-06 00:55:29.777334 | PLAY RECAP 2026-05-06 00:55:29.777448 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-06 00:55:29.777558 | 2026-05-06 00:55:29.935702 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-06 00:55:29.936622 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-06 00:55:30.803890 | 2026-05-06 00:55:30.804072 | PLAY [Base post-logs] 2026-05-06 00:55:30.821542 | 2026-05-06 00:55:30.821840 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-06 00:55:31.369144 | localhost | changed 2026-05-06 00:55:31.395269 | 2026-05-06 00:55:31.395489 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-06 00:55:31.433712 | localhost | ok 2026-05-06 00:55:31.439821 | 2026-05-06 00:55:31.439983 | TASK [Set zuul-log-path fact] 2026-05-06 00:55:31.460057 | localhost | ok 2026-05-06 00:55:31.471068 | 2026-05-06 00:55:31.471218 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-06 00:55:31.497563 | localhost | ok 2026-05-06 00:55:31.500795 | 2026-05-06 00:55:31.500902 | TASK [upload-logs : Create log directories] 2026-05-06 00:55:32.006586 | localhost | changed 2026-05-06 00:55:32.010305 | 2026-05-06 00:55:32.010494 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-06 00:55:32.685953 | localhost -> localhost | ok: Runtime: 0:00:00.004350 2026-05-06 00:55:32.693094 | 2026-05-06 00:55:32.693222 | TASK [upload-logs : Upload logs to log server] 2026-05-06 00:55:33.338112 | localhost | Output suppressed because no_log was given 2026-05-06 00:55:33.340480 | 2026-05-06 00:55:33.340613 | LOOP [upload-logs : Compress console log and json output] 2026-05-06 00:55:33.400037 | localhost | skipping: Conditional result was False 2026-05-06 00:55:33.408299 | localhost | skipping: Conditional result was False 2026-05-06 00:55:33.422246 | 2026-05-06 00:55:33.422704 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-06 00:55:33.470765 | localhost | skipping: Conditional result was False 2026-05-06 00:55:33.471102 | 2026-05-06 00:55:33.478189 | localhost | skipping: Conditional result was False 2026-05-06 00:55:33.485995 | 2026-05-06 00:55:33.486259 | LOOP [upload-logs : Upload console log and json output]