2026-05-08 06:22:47.447427 | Job console starting 2026-05-08 06:22:47.466225 | Updating git repos 2026-05-08 06:22:47.493196 | Cloning repos into workspace 2026-05-08 06:22:47.549178 | Restoring repo states 2026-05-08 06:22:47.557341 | Merging changes 2026-05-08 06:22:48.043624 | Checking out repos 2026-05-08 06:22:48.076981 | Preparing playbooks 2026-05-08 06:22:48.842999 | Running Ansible setup 2026-05-08 06:22:53.412437 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-08 06:22:54.220040 | 2026-05-08 06:22:54.220217 | PLAY [Base pre] 2026-05-08 06:22:54.248277 | 2026-05-08 06:22:54.248440 | TASK [Setup log path fact] 2026-05-08 06:22:54.290539 | debian-bookworm | ok 2026-05-08 06:22:54.309638 | 2026-05-08 06:22:54.309805 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-08 06:22:54.360626 | debian-bookworm | ok 2026-05-08 06:22:54.373655 | 2026-05-08 06:22:54.373795 | TASK [emit-job-header : Print job information] 2026-05-08 06:22:54.451406 | # Job Information 2026-05-08 06:22:54.451596 | Ansible Version: 2.16.14 2026-05-08 06:22:54.451631 | Job: python-black 2026-05-08 06:22:54.451665 | Pipeline: check 2026-05-08 06:22:54.451689 | Executor: 521e9411259a 2026-05-08 06:22:54.451710 | Triggered by: https://github.com/osism/zuul-jobs/pull/185 2026-05-08 06:22:54.451731 | Event ID: 4f3eac50-4aa6-11f1-87dd-fd891dd92796 2026-05-08 06:22:54.464660 | 2026-05-08 06:22:54.464803 | LOOP [emit-job-header : Print node information] 2026-05-08 06:22:54.635358 | debian-bookworm | ok: 2026-05-08 06:22:54.635643 | debian-bookworm | # Node Information 2026-05-08 06:22:54.635681 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-08 06:22:54.635707 | debian-bookworm | Hostname: debian 2026-05-08 06:22:54.635730 | debian-bookworm | Username: zuul 2026-05-08 06:22:54.635751 | debian-bookworm | Distro: Debian 12.13 2026-05-08 06:22:54.635774 | debian-bookworm | Provider: regiocloud-a 2026-05-08 06:22:54.635796 | debian-bookworm | Region: 2026-05-08 06:22:54.635860 | debian-bookworm | Label: debian-bookworm 2026-05-08 06:22:54.635884 | debian-bookworm | Product Name: OpenStack Nova 2026-05-08 06:22:54.635905 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe65:afa6 2026-05-08 06:22:54.651667 | 2026-05-08 06:22:54.651808 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-08 06:22:55.205055 | debian-bookworm -> localhost | changed 2026-05-08 06:22:55.212525 | 2026-05-08 06:22:55.212650 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-08 06:22:56.482965 | debian-bookworm -> localhost | changed 2026-05-08 06:22:56.499797 | 2026-05-08 06:22:56.500058 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-08 06:22:56.808224 | debian-bookworm -> localhost | ok 2026-05-08 06:22:56.814642 | 2026-05-08 06:22:56.814774 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-08 06:22:56.845615 | debian-bookworm | ok 2026-05-08 06:22:56.861579 | debian-bookworm | included: /var/lib/zuul/builds/a90dd92d3cd94ce696aa22227fc6e159/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-08 06:22:56.868069 | 2026-05-08 06:22:56.868190 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-08 06:22:57.936868 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-08 06:22:57.937131 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a90dd92d3cd94ce696aa22227fc6e159/work/a90dd92d3cd94ce696aa22227fc6e159_id_rsa 2026-05-08 06:22:57.937173 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a90dd92d3cd94ce696aa22227fc6e159/work/a90dd92d3cd94ce696aa22227fc6e159_id_rsa.pub 2026-05-08 06:22:57.937201 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-08 06:22:57.937226 | debian-bookworm -> localhost | SHA256:VYvhAvLiPBGVMfz/OzKTVf+tF+InhCwhAU/VC8AUWUo zuul-build-sshkey 2026-05-08 06:22:57.937249 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-08 06:22:57.937283 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-08 06:22:57.937305 | debian-bookworm -> localhost | | o+OE*oo . | 2026-05-08 06:22:57.937326 | debian-bookworm -> localhost | | +**.o = . | 2026-05-08 06:22:57.937347 | debian-bookworm -> localhost | | o .+o = o | 2026-05-08 06:22:57.937367 | debian-bookworm -> localhost | | o o ..+ . . | 2026-05-08 06:22:57.937386 | debian-bookworm -> localhost | | + S.o .. . | 2026-05-08 06:22:57.937412 | debian-bookworm -> localhost | | . ..o.o ..| 2026-05-08 06:22:57.937432 | debian-bookworm -> localhost | | .+o . +| 2026-05-08 06:22:57.937452 | debian-bookworm -> localhost | | = oo .+| 2026-05-08 06:22:57.937473 | debian-bookworm -> localhost | | +.o+o | 2026-05-08 06:22:57.937493 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-08 06:22:57.937546 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.540559 2026-05-08 06:22:57.944245 | 2026-05-08 06:22:57.944353 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-08 06:22:57.974099 | debian-bookworm | ok 2026-05-08 06:22:57.983375 | debian-bookworm | included: /var/lib/zuul/builds/a90dd92d3cd94ce696aa22227fc6e159/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-08 06:22:57.992473 | 2026-05-08 06:22:57.992572 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-08 06:22:58.016619 | debian-bookworm | skipping: Conditional result was False 2026-05-08 06:22:58.029638 | 2026-05-08 06:22:58.029792 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-08 06:22:58.705008 | debian-bookworm | changed 2026-05-08 06:22:58.711476 | 2026-05-08 06:22:58.711590 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-08 06:22:58.973005 | debian-bookworm | ok 2026-05-08 06:22:58.984741 | 2026-05-08 06:22:58.985027 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-08 06:22:59.695389 | debian-bookworm | changed 2026-05-08 06:22:59.706309 | 2026-05-08 06:22:59.706455 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-08 06:23:00.439117 | debian-bookworm | changed 2026-05-08 06:23:00.445022 | 2026-05-08 06:23:00.445143 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-08 06:23:00.479378 | debian-bookworm | skipping: Conditional result was False 2026-05-08 06:23:00.486429 | 2026-05-08 06:23:00.486546 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-08 06:23:01.007347 | debian-bookworm -> localhost | changed 2026-05-08 06:23:01.023912 | 2026-05-08 06:23:01.024062 | TASK [add-build-sshkey : Add back temp key] 2026-05-08 06:23:01.384555 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a90dd92d3cd94ce696aa22227fc6e159/work/a90dd92d3cd94ce696aa22227fc6e159_id_rsa (zuul-build-sshkey) 2026-05-08 06:23:01.384855 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011519 2026-05-08 06:23:01.394753 | 2026-05-08 06:23:01.395003 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-08 06:23:01.812390 | debian-bookworm | ok 2026-05-08 06:23:01.818028 | 2026-05-08 06:23:01.818164 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-08 06:23:01.842112 | debian-bookworm | skipping: Conditional result was False 2026-05-08 06:23:01.853218 | 2026-05-08 06:23:01.853373 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-08 06:23:02.332799 | debian-bookworm | ok 2026-05-08 06:23:02.348523 | 2026-05-08 06:23:02.348664 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-08 06:23:02.378669 | debian-bookworm | ok 2026-05-08 06:23:02.384084 | 2026-05-08 06:23:02.384191 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-08 06:23:02.702795 | debian-bookworm -> localhost | ok 2026-05-08 06:23:02.712723 | 2026-05-08 06:23:02.712912 | TASK [validate-host : Collect information about the host] 2026-05-08 06:23:04.010640 | debian-bookworm | ok 2026-05-08 06:23:04.021011 | 2026-05-08 06:23:04.021132 | TASK [validate-host : Sanitize hostname] 2026-05-08 06:23:04.150232 | debian-bookworm | ok 2026-05-08 06:23:04.196006 | 2026-05-08 06:23:04.196153 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-08 06:23:04.782089 | debian-bookworm -> localhost | changed 2026-05-08 06:23:04.788147 | 2026-05-08 06:23:04.788263 | TASK [validate-host : Collect information about zuul worker] 2026-05-08 06:23:05.231368 | debian-bookworm | ok 2026-05-08 06:23:05.236345 | 2026-05-08 06:23:05.236458 | TASK [validate-host : Write out all zuul information for each host] 2026-05-08 06:23:05.828488 | debian-bookworm -> localhost | changed 2026-05-08 06:23:05.844116 | 2026-05-08 06:23:05.844256 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-08 06:23:06.181081 | debian-bookworm | ok 2026-05-08 06:23:06.187768 | 2026-05-08 06:23:06.187942 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-08 06:23:07.138993 | debian-bookworm | changed: 2026-05-08 06:23:07.139207 | debian-bookworm | cd+++++++++ src/ 2026-05-08 06:23:07.139242 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-08 06:23:07.139267 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-08 06:23:07.139290 | debian-bookworm | cd+++++++++ src/github.com/osism/zuul-jobs/ 2026-05-08 06:23:07.139310 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/a90dd92d3cd94ce696aa22227fc6e159/work/logs" 2026-05-08 06:23:33.138659 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a90dd92d3cd94ce696aa22227fc6e159/work/artifacts" 2026-05-08 06:23:33.391585 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a90dd92d3cd94ce696aa22227fc6e159/work/docs" 2026-05-08 06:23:33.414024 | 2026-05-08 06:23:33.414184 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-08 06:23:34.242108 | debian-bookworm | changed: 2026-05-08 06:23:34.242446 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-08 06:23:34.242507 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-08 06:23:34.242557 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-08 06:23:34.242631 | debian-bookworm | changed: All items complete 2026-05-08 06:23:34.242677 | 2026-05-08 06:23:34.818899 | debian-bookworm | changed: .d..t...... ./ 2026-05-08 06:23:35.411802 | debian-bookworm | changed: .d..t...... ./ 2026-05-08 06:23:35.437784 | 2026-05-08 06:23:35.438078 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-08 06:23:35.979609 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011083 2026-05-08 06:23:36.291091 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.013544 2026-05-08 06:23:36.304519 | 2026-05-08 06:23:36.304645 | PLAY RECAP 2026-05-08 06:23:36.304703 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-08 06:23:36.304729 | 2026-05-08 06:23:36.453229 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-08 06:23:36.455609 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-08 06:23:37.252510 | 2026-05-08 06:23:37.252681 | PLAY [Base post] 2026-05-08 06:23:37.267566 | 2026-05-08 06:23:37.267719 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-08 06:23:37.908470 | debian-bookworm | changed 2026-05-08 06:23:37.914882 | 2026-05-08 06:23:37.914996 | PLAY RECAP 2026-05-08 06:23:37.915059 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-08 06:23:37.915121 | 2026-05-08 06:23:38.043408 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-08 06:23:38.044363 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-08 06:23:38.874878 | 2026-05-08 06:23:38.875657 | PLAY [Base post-logs] 2026-05-08 06:23:38.886890 | 2026-05-08 06:23:38.887054 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-08 06:23:39.351695 | localhost | changed 2026-05-08 06:23:39.368587 | 2026-05-08 06:23:39.368766 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-08 06:23:39.404852 | localhost | ok 2026-05-08 06:23:39.408398 | 2026-05-08 06:23:39.408512 | TASK [Set zuul-log-path fact] 2026-05-08 06:23:39.434657 | localhost | ok 2026-05-08 06:23:39.443226 | 2026-05-08 06:23:39.443371 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-08 06:23:39.476652 | localhost | ok 2026-05-08 06:23:39.480085 | 2026-05-08 06:23:39.480199 | TASK [upload-logs : Create log directories] 2026-05-08 06:23:40.016558 | localhost | changed 2026-05-08 06:23:40.021442 | 2026-05-08 06:23:40.021599 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-08 06:23:40.655102 | localhost -> localhost | ok: Runtime: 0:00:00.009273 2026-05-08 06:23:40.661164 | 2026-05-08 06:23:40.661297 | TASK [upload-logs : Upload logs to log server] 2026-05-08 06:23:41.259333 | localhost | Output suppressed because no_log was given 2026-05-08 06:23:41.261351 | 2026-05-08 06:23:41.261468 | LOOP [upload-logs : Compress console log and json output] 2026-05-08 06:23:41.318642 | localhost | skipping: Conditional result was False 2026-05-08 06:23:41.323941 | localhost | skipping: Conditional result was False 2026-05-08 06:23:41.337214 | 2026-05-08 06:23:41.337430 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-08 06:23:41.395759 | localhost | skipping: Conditional result was False 2026-05-08 06:23:41.396628 | 2026-05-08 06:23:41.399408 | localhost | skipping: Conditional result was False 2026-05-08 06:23:41.415224 | 2026-05-08 06:23:41.415567 | LOOP [upload-logs : Upload console log and json output]