2026-05-03 03:07:43.826474 | Job console starting 2026-05-03 03:07:43.835321 | Updating git repos 2026-05-03 03:07:43.861351 | Cloning repos into workspace 2026-05-03 03:07:43.893414 | Restoring repo states 2026-05-03 03:07:43.902022 | Merging changes 2026-05-03 03:07:43.902039 | Checking out repos 2026-05-03 03:07:43.949602 | Preparing playbooks 2026-05-03 03:07:44.553410 | Running Ansible setup 2026-05-03 03:07:48.933812 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-03 03:07:49.752769 | 2026-05-03 03:07:49.752899 | PLAY [Base pre] 2026-05-03 03:07:49.769318 | 2026-05-03 03:07:49.769439 | TASK [Setup log path fact] 2026-05-03 03:07:49.788595 | debian-bookworm | ok 2026-05-03 03:07:49.807897 | 2026-05-03 03:07:49.808045 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-03 03:07:49.836652 | debian-bookworm | ok 2026-05-03 03:07:49.846324 | 2026-05-03 03:07:49.846439 | TASK [emit-job-header : Print job information] 2026-05-03 03:07:49.885940 | # Job Information 2026-05-03 03:07:49.886104 | Ansible Version: 2.16.14 2026-05-03 03:07:49.886164 | Job: python-black 2026-05-03 03:07:49.886200 | Pipeline: periodic-daily 2026-05-03 03:07:49.886223 | Executor: 521e9411259a 2026-05-03 03:07:49.886244 | Triggered by: https://github.com/osism/generics 2026-05-03 03:07:49.886265 | Event ID: 0aea623a29b44030acb025d5a51287d1 2026-05-03 03:07:49.890973 | 2026-05-03 03:07:49.891064 | LOOP [emit-job-header : Print node information] 2026-05-03 03:07:50.054625 | debian-bookworm | ok: 2026-05-03 03:07:50.054901 | debian-bookworm | # Node Information 2026-05-03 03:07:50.054941 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-03 03:07:50.054966 | debian-bookworm | Hostname: debian 2026-05-03 03:07:50.054988 | debian-bookworm | Username: zuul 2026-05-03 03:07:50.055009 | debian-bookworm | Distro: Debian 12.13 2026-05-03 03:07:50.055038 | debian-bookworm | Provider: regiocloud-a 2026-05-03 03:07:50.055064 | debian-bookworm | Region: 2026-05-03 03:07:50.055085 | debian-bookworm | Label: debian-bookworm 2026-05-03 03:07:50.055105 | debian-bookworm | Product Name: OpenStack Nova 2026-05-03 03:07:50.055148 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee9:529 2026-05-03 03:07:50.069256 | 2026-05-03 03:07:50.069372 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-03 03:07:50.557579 | debian-bookworm -> localhost | changed 2026-05-03 03:07:50.564772 | 2026-05-03 03:07:50.564883 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-03 03:07:52.458647 | debian-bookworm -> localhost | changed 2026-05-03 03:07:52.477367 | 2026-05-03 03:07:52.477627 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-03 03:07:53.268872 | debian-bookworm -> localhost | ok 2026-05-03 03:07:53.277230 | 2026-05-03 03:07:53.277386 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-03 03:07:53.329660 | debian-bookworm | ok 2026-05-03 03:07:53.362815 | debian-bookworm | included: /var/lib/zuul/builds/15ce442331204c3096b20671991671a9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-03 03:07:53.389196 | 2026-05-03 03:07:53.389340 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-03 03:07:56.223397 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-03 03:07:56.223627 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/15ce442331204c3096b20671991671a9/work/15ce442331204c3096b20671991671a9_id_rsa 2026-05-03 03:07:56.223666 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/15ce442331204c3096b20671991671a9/work/15ce442331204c3096b20671991671a9_id_rsa.pub 2026-05-03 03:07:56.223693 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-03 03:07:56.223718 | debian-bookworm -> localhost | SHA256:PUcMzfj7yG2ijPxKBvJy5iA4ig8HmTG0xweaRpss8jA zuul-build-sshkey 2026-05-03 03:07:56.223740 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-03 03:07:56.223771 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-03 03:07:56.223794 | debian-bookworm -> localhost | | o . .+ | 2026-05-03 03:07:56.223817 | debian-bookworm -> localhost | |+ B . .oo | 2026-05-03 03:07:56.223837 | debian-bookworm -> localhost | |EO o . .o | 2026-05-03 03:07:56.223857 | debian-bookworm -> localhost | |+O. . . .. | 2026-05-03 03:07:56.223877 | debian-bookworm -> localhost | |+ . . . S o .. | 2026-05-03 03:07:56.223904 | debian-bookworm -> localhost | | o o . o. | 2026-05-03 03:07:56.223925 | debian-bookworm -> localhost | |+ o o + o . + | 2026-05-03 03:07:56.223945 | debian-bookworm -> localhost | |o+ . * + o + + | 2026-05-03 03:07:56.223965 | debian-bookworm -> localhost | |o.. . +o+. o | 2026-05-03 03:07:56.223986 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-03 03:07:56.224037 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.615027 2026-05-03 03:07:56.231168 | 2026-05-03 03:07:56.231273 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-03 03:07:56.289994 | debian-bookworm | ok 2026-05-03 03:07:56.313540 | debian-bookworm | included: /var/lib/zuul/builds/15ce442331204c3096b20671991671a9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-03 03:07:56.341785 | 2026-05-03 03:07:56.341904 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-03 03:07:56.383175 | debian-bookworm | skipping: Conditional result was False 2026-05-03 03:07:56.390272 | 2026-05-03 03:07:56.390375 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-03 03:07:57.117870 | debian-bookworm | changed 2026-05-03 03:07:57.131268 | 2026-05-03 03:07:57.131396 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-03 03:07:57.417922 | debian-bookworm | ok 2026-05-03 03:07:57.424540 | 2026-05-03 03:07:57.424655 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-03 03:07:58.097784 | debian-bookworm | changed 2026-05-03 03:07:58.105321 | 2026-05-03 03:07:58.105423 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-03 03:07:58.737985 | debian-bookworm | changed 2026-05-03 03:07:58.772879 | 2026-05-03 03:07:58.773004 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-03 03:07:58.796588 | debian-bookworm | skipping: Conditional result was False 2026-05-03 03:07:58.803094 | 2026-05-03 03:07:58.803210 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-03 03:07:59.587282 | debian-bookworm -> localhost | changed 2026-05-03 03:07:59.610090 | 2026-05-03 03:07:59.610212 | TASK [add-build-sshkey : Add back temp key] 2026-05-03 03:08:00.130205 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/15ce442331204c3096b20671991671a9/work/15ce442331204c3096b20671991671a9_id_rsa (zuul-build-sshkey) 2026-05-03 03:08:00.130424 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012089 2026-05-03 03:08:00.139627 | 2026-05-03 03:08:00.139746 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-03 03:08:00.820308 | debian-bookworm | ok 2026-05-03 03:08:00.835615 | 2026-05-03 03:08:00.835730 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-03 03:08:00.874263 | debian-bookworm | skipping: Conditional result was False 2026-05-03 03:08:00.884458 | 2026-05-03 03:08:00.884567 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-03 03:08:01.373731 | debian-bookworm | ok 2026-05-03 03:08:01.396277 | 2026-05-03 03:08:01.396401 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-03 03:08:01.479791 | debian-bookworm | ok 2026-05-03 03:08:01.485822 | 2026-05-03 03:08:01.485919 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-03 03:08:02.562122 | debian-bookworm -> localhost | ok 2026-05-03 03:08:02.578509 | 2026-05-03 03:08:02.578648 | TASK [validate-host : Collect information about the host] 2026-05-03 03:08:04.289744 | debian-bookworm | ok 2026-05-03 03:08:04.306396 | 2026-05-03 03:08:04.306500 | TASK [validate-host : Sanitize hostname] 2026-05-03 03:08:04.504295 | debian-bookworm | ok 2026-05-03 03:08:04.568848 | 2026-05-03 03:08:04.568950 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-03 03:08:05.630301 | debian-bookworm -> localhost | changed 2026-05-03 03:08:05.634868 | 2026-05-03 03:08:05.634952 | TASK [validate-host : Collect information about zuul worker] 2026-05-03 03:08:06.067782 | debian-bookworm | ok 2026-05-03 03:08:06.071626 | 2026-05-03 03:08:06.071706 | TASK [validate-host : Write out all zuul information for each host] 2026-05-03 03:08:08.057259 | debian-bookworm -> localhost | changed 2026-05-03 03:08:08.065240 | 2026-05-03 03:08:08.065325 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-03 03:08:08.354492 | debian-bookworm | ok 2026-05-03 03:08:08.358910 | 2026-05-03 03:08:08.358983 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-03 03:08:09.310234 | debian-bookworm | changed: 2026-05-03 03:08:09.310390 | debian-bookworm | cd+++++++++ src/ 2026-05-03 03:08:09.310418 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-03 03:08:09.310752 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-03 03:08:09.310802 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-05-03 03:08:09.310821 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/15ce442331204c3096b20671991671a9/work/logs" 2026-05-03 03:08:36.965527 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/15ce442331204c3096b20671991671a9/work/artifacts" 2026-05-03 03:08:37.243163 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/15ce442331204c3096b20671991671a9/work/docs" 2026-05-03 03:08:37.254539 | 2026-05-03 03:08:37.254699 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-03 03:08:38.111105 | debian-bookworm | changed: 2026-05-03 03:08:38.111484 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-03 03:08:38.111549 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-03 03:08:38.111596 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-03 03:08:38.111673 | debian-bookworm | changed: All items complete 2026-05-03 03:08:38.111715 | 2026-05-03 03:08:38.747263 | debian-bookworm | changed: .d..t...... ./ 2026-05-03 03:08:39.331392 | debian-bookworm | changed: .d..t...... ./ 2026-05-03 03:08:39.356143 | 2026-05-03 03:08:39.356285 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-03 03:08:39.391039 | debian-bookworm | skipping: Conditional result was False 2026-05-03 03:08:39.393752 | debian-bookworm | skipping: Conditional result was False 2026-05-03 03:08:39.416047 | 2026-05-03 03:08:39.416157 | PLAY RECAP 2026-05-03 03:08:39.416224 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-03 03:08:39.416255 | 2026-05-03 03:08:39.581037 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-03 03:08:39.582476 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-03 03:08:40.672759 | 2026-05-03 03:08:40.673135 | PLAY [Base post] 2026-05-03 03:08:40.687729 | 2026-05-03 03:08:40.687884 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-03 03:08:41.377561 | debian-bookworm | changed 2026-05-03 03:08:41.390374 | 2026-05-03 03:08:41.390502 | PLAY RECAP 2026-05-03 03:08:41.390564 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-03 03:08:41.390625 | 2026-05-03 03:08:41.541852 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-03 03:08:41.542742 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-03 03:08:42.635329 | 2026-05-03 03:08:42.635560 | PLAY [Base post-logs] 2026-05-03 03:08:42.657886 | 2026-05-03 03:08:42.658096 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-03 03:08:43.359692 | localhost | changed 2026-05-03 03:08:43.372660 | 2026-05-03 03:08:43.372843 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-03 03:08:43.414607 | localhost | ok 2026-05-03 03:08:43.417965 | 2026-05-03 03:08:43.418096 | TASK [Set zuul-log-path fact] 2026-05-03 03:08:43.458099 | localhost | ok 2026-05-03 03:08:43.466900 | 2026-05-03 03:08:43.467071 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-03 03:08:43.498439 | localhost | ok 2026-05-03 03:08:43.501736 | 2026-05-03 03:08:43.501848 | TASK [upload-logs : Create log directories] 2026-05-03 03:08:44.200445 | localhost | changed 2026-05-03 03:08:44.202524 | 2026-05-03 03:08:44.202597 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-03 03:08:44.685555 | localhost -> localhost | ok: Runtime: 0:00:00.004011 2026-05-03 03:08:44.689565 | 2026-05-03 03:08:44.689666 | TASK [upload-logs : Upload logs to log server] 2026-05-03 03:08:45.443024 | localhost | Output suppressed because no_log was given 2026-05-03 03:08:45.444639 | 2026-05-03 03:08:45.444723 | LOOP [upload-logs : Compress console log and json output] 2026-05-03 03:08:45.555714 | localhost | skipping: Conditional result was False 2026-05-03 03:08:45.573870 | localhost | skipping: Conditional result was False 2026-05-03 03:08:45.577159 | 2026-05-03 03:08:45.577249 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-03 03:08:45.664334 | localhost | skipping: Conditional result was False 2026-05-03 03:08:45.664582 | 2026-05-03 03:08:45.673268 | localhost | skipping: Conditional result was False 2026-05-03 03:08:45.683192 | 2026-05-03 03:08:45.683297 | LOOP [upload-logs : Upload console log and json output]