2026-05-17 04:34:39.965057 | Job console starting 2026-05-17 04:34:39.998648 | Updating git repos 2026-05-17 04:34:40.054542 | Cloning repos into workspace 2026-05-17 04:34:40.120135 | Restoring repo states 2026-05-17 04:34:40.130658 | Merging changes 2026-05-17 04:34:40.681681 | Checking out repos 2026-05-17 04:34:40.815875 | Preparing playbooks 2026-05-17 04:34:41.897393 | Running Ansible setup 2026-05-17 04:34:47.013340 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-17 04:34:48.127014 | 2026-05-17 04:34:48.127267 | PLAY [Base pre] 2026-05-17 04:34:48.146702 | 2026-05-17 04:34:48.146919 | TASK [Setup log path fact] 2026-05-17 04:34:48.167268 | debian-bookworm | ok 2026-05-17 04:34:48.187517 | 2026-05-17 04:34:48.187701 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-17 04:34:48.239819 | debian-bookworm | ok 2026-05-17 04:34:48.251081 | 2026-05-17 04:34:48.251267 | TASK [emit-job-header : Print job information] 2026-05-17 04:34:48.291715 | # Job Information 2026-05-17 04:34:48.291932 | Ansible Version: 2.16.14 2026-05-17 04:34:48.291967 | Job: python-black 2026-05-17 04:34:48.292002 | Pipeline: check 2026-05-17 04:34:48.292026 | Executor: 521e9411259a 2026-05-17 04:34:48.292048 | Triggered by: https://github.com/osism/openstack-project-manager/pull/276 2026-05-17 04:34:48.292071 | Event ID: b2143e30-51a9-11f1-84e3-c4628d5040fe 2026-05-17 04:34:48.297287 | 2026-05-17 04:34:48.297414 | LOOP [emit-job-header : Print node information] 2026-05-17 04:34:48.439565 | debian-bookworm | ok: 2026-05-17 04:34:48.439791 | debian-bookworm | # Node Information 2026-05-17 04:34:48.439827 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-17 04:34:48.439853 | debian-bookworm | Hostname: debian 2026-05-17 04:34:48.439876 | debian-bookworm | Username: zuul 2026-05-17 04:34:48.439896 | debian-bookworm | Distro: Debian 12.14 2026-05-17 04:34:48.439919 | debian-bookworm | Provider: regiocloud-a 2026-05-17 04:34:48.439941 | debian-bookworm | Region: 2026-05-17 04:34:48.439963 | debian-bookworm | Label: debian-bookworm 2026-05-17 04:34:48.439983 | debian-bookworm | Product Name: OpenStack Nova 2026-05-17 04:34:48.440003 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe89:15f6 2026-05-17 04:34:48.462945 | 2026-05-17 04:34:48.463187 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-17 04:34:49.357016 | debian-bookworm -> localhost | changed 2026-05-17 04:34:49.366333 | 2026-05-17 04:34:49.366472 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-17 04:34:50.666247 | debian-bookworm -> localhost | changed 2026-05-17 04:34:50.680095 | 2026-05-17 04:34:50.680263 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-17 04:34:51.115636 | debian-bookworm -> localhost | ok 2026-05-17 04:34:51.121110 | 2026-05-17 04:34:51.121222 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-17 04:34:51.150588 | debian-bookworm | ok 2026-05-17 04:34:51.163345 | debian-bookworm | included: /var/lib/zuul/builds/cd26bef5eeaa4e57a585916a84dd1d12/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-17 04:34:51.168224 | 2026-05-17 04:34:51.168307 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-17 04:34:52.532693 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-17 04:34:52.532873 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/cd26bef5eeaa4e57a585916a84dd1d12/work/cd26bef5eeaa4e57a585916a84dd1d12_id_rsa 2026-05-17 04:34:52.532905 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/cd26bef5eeaa4e57a585916a84dd1d12/work/cd26bef5eeaa4e57a585916a84dd1d12_id_rsa.pub 2026-05-17 04:34:52.532926 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-17 04:34:52.532947 | debian-bookworm -> localhost | SHA256:ap51MYDRBRyzUMiRg1ntFygDMwO1ZpkWu5hyMSgabFc zuul-build-sshkey 2026-05-17 04:34:52.532966 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-17 04:34:52.532992 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-17 04:34:52.533010 | debian-bookworm -> localhost | | .oBE=O==. | 2026-05-17 04:34:52.533029 | debian-bookworm -> localhost | |.. +XB+=o. | 2026-05-17 04:34:52.533046 | debian-bookworm -> localhost | |+oo.O .=o . | 2026-05-17 04:34:52.533063 | debian-bookworm -> localhost | |+..O . ... | 2026-05-17 04:34:52.533079 | debian-bookworm -> localhost | |o + . S.o | 2026-05-17 04:34:52.533099 | debian-bookworm -> localhost | | o . o | 2026-05-17 04:34:52.533116 | debian-bookworm -> localhost | | o . . | 2026-05-17 04:34:52.533132 | debian-bookworm -> localhost | | o o . | 2026-05-17 04:34:52.533150 | debian-bookworm -> localhost | | o | 2026-05-17 04:34:52.533192 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-17 04:34:52.533238 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.963140 2026-05-17 04:34:52.538268 | 2026-05-17 04:34:52.538347 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-17 04:34:52.555446 | debian-bookworm | ok 2026-05-17 04:34:52.562509 | debian-bookworm | included: /var/lib/zuul/builds/cd26bef5eeaa4e57a585916a84dd1d12/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-17 04:34:52.569549 | 2026-05-17 04:34:52.569617 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-17 04:34:52.583482 | debian-bookworm | skipping: Conditional result was False 2026-05-17 04:34:52.588422 | 2026-05-17 04:34:52.588497 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-17 04:34:53.100069 | debian-bookworm | changed 2026-05-17 04:34:53.104342 | 2026-05-17 04:34:53.104413 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-17 04:34:53.333819 | debian-bookworm | ok 2026-05-17 04:34:53.339149 | 2026-05-17 04:34:53.339250 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-17 04:34:53.927250 | debian-bookworm | changed 2026-05-17 04:34:53.933701 | 2026-05-17 04:34:53.933796 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-17 04:34:54.564526 | debian-bookworm | changed 2026-05-17 04:34:54.570261 | 2026-05-17 04:34:54.570370 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-17 04:34:54.594246 | debian-bookworm | skipping: Conditional result was False 2026-05-17 04:34:54.606417 | 2026-05-17 04:34:54.606561 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-17 04:34:55.014863 | debian-bookworm -> localhost | changed 2026-05-17 04:34:55.023700 | 2026-05-17 04:34:55.023799 | TASK [add-build-sshkey : Add back temp key] 2026-05-17 04:34:55.355010 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/cd26bef5eeaa4e57a585916a84dd1d12/work/cd26bef5eeaa4e57a585916a84dd1d12_id_rsa (zuul-build-sshkey) 2026-05-17 04:34:55.355225 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015579 2026-05-17 04:34:55.361564 | 2026-05-17 04:34:55.361653 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-17 04:34:55.746516 | debian-bookworm | ok 2026-05-17 04:34:55.754141 | 2026-05-17 04:34:55.754281 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-17 04:34:55.777965 | debian-bookworm | skipping: Conditional result was False 2026-05-17 04:34:55.790816 | 2026-05-17 04:34:55.790934 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-17 04:34:56.202234 | debian-bookworm | ok 2026-05-17 04:34:56.218470 | 2026-05-17 04:34:56.218598 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-17 04:34:56.247971 | debian-bookworm | ok 2026-05-17 04:34:56.253030 | 2026-05-17 04:34:56.253145 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-17 04:34:56.528951 | debian-bookworm -> localhost | ok 2026-05-17 04:34:56.537934 | 2026-05-17 04:34:56.538080 | TASK [validate-host : Collect information about the host] 2026-05-17 04:34:57.739270 | debian-bookworm | ok 2026-05-17 04:34:57.764917 | 2026-05-17 04:34:57.765093 | TASK [validate-host : Sanitize hostname] 2026-05-17 04:34:57.898554 | debian-bookworm | ok 2026-05-17 04:34:57.962867 | 2026-05-17 04:34:57.963071 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-17 04:34:58.640281 | debian-bookworm -> localhost | changed 2026-05-17 04:34:58.647676 | 2026-05-17 04:34:58.647828 | TASK [validate-host : Collect information about zuul worker] 2026-05-17 04:34:59.096797 | debian-bookworm | ok 2026-05-17 04:34:59.104919 | 2026-05-17 04:34:59.105198 | TASK [validate-host : Write out all zuul information for each host] 2026-05-17 04:34:59.772679 | debian-bookworm -> localhost | changed 2026-05-17 04:34:59.782759 | 2026-05-17 04:34:59.795019 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-17 04:35:00.068504 | debian-bookworm | ok 2026-05-17 04:35:00.075621 | 2026-05-17 04:35:00.075747 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-17 04:35:00.961597 | debian-bookworm | changed: 2026-05-17 04:35:00.961823 | debian-bookworm | cd+++++++++ src/ 2026-05-17 04:35:00.961860 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-17 04:35:00.961885 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-17 04:35:00.961907 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2026-05-17 04:35:00.961927 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/cd26bef5eeaa4e57a585916a84dd1d12/work/logs" 2026-05-17 04:35:27.805881 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/cd26bef5eeaa4e57a585916a84dd1d12/work/artifacts" 2026-05-17 04:35:28.125995 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/cd26bef5eeaa4e57a585916a84dd1d12/work/docs" 2026-05-17 04:35:28.143358 | 2026-05-17 04:35:28.143535 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-17 04:35:28.965982 | debian-bookworm | changed: 2026-05-17 04:35:28.966368 | debian-bookworm | .d..t...... ./ 2026-05-17 04:35:28.966425 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-17 04:35:28.966488 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-17 04:35:28.966538 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-17 04:35:28.966601 | debian-bookworm | changed: All items complete 2026-05-17 04:35:28.966638 | 2026-05-17 04:35:29.529590 | debian-bookworm | changed: .d..t...... ./ 2026-05-17 04:35:30.149121 | debian-bookworm | changed: .d..t...... ./ 2026-05-17 04:35:30.174778 | 2026-05-17 04:35:30.174953 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-17 04:35:30.704815 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.008559 2026-05-17 04:35:30.994303 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.017105 2026-05-17 04:35:31.004078 | 2026-05-17 04:35:31.004232 | PLAY RECAP 2026-05-17 04:35:31.004289 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-17 04:35:31.004314 | 2026-05-17 04:35:31.180567 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-17 04:35:31.181611 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-17 04:35:32.027466 | 2026-05-17 04:35:32.027755 | PLAY [Base post] 2026-05-17 04:35:32.062298 | 2026-05-17 04:35:32.062513 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-17 04:35:32.682517 | debian-bookworm | changed 2026-05-17 04:35:32.690683 | 2026-05-17 04:35:32.690863 | PLAY RECAP 2026-05-17 04:35:32.690937 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-17 04:35:32.691004 | 2026-05-17 04:35:32.851801 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-17 04:35:32.853448 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-17 04:35:33.687603 | 2026-05-17 04:35:33.687802 | PLAY [Base post-logs] 2026-05-17 04:35:33.698776 | 2026-05-17 04:35:33.698982 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-17 04:35:34.125254 | localhost | changed 2026-05-17 04:35:34.135590 | 2026-05-17 04:35:34.135756 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-17 04:35:34.173350 | localhost | ok 2026-05-17 04:35:34.179279 | 2026-05-17 04:35:34.179470 | TASK [Set zuul-log-path fact] 2026-05-17 04:35:34.196693 | localhost | ok 2026-05-17 04:35:34.208112 | 2026-05-17 04:35:34.208332 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-17 04:35:34.234579 | localhost | ok 2026-05-17 04:35:34.238811 | 2026-05-17 04:35:34.238982 | TASK [upload-logs : Create log directories] 2026-05-17 04:35:34.746471 | localhost | changed 2026-05-17 04:35:34.749396 | 2026-05-17 04:35:34.749510 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-17 04:35:35.316914 | localhost -> localhost | ok: Runtime: 0:00:00.007116 2026-05-17 04:35:35.324205 | 2026-05-17 04:35:35.324384 | TASK [upload-logs : Upload logs to log server] 2026-05-17 04:35:36.004663 | localhost | Output suppressed because no_log was given 2026-05-17 04:35:36.006670 | 2026-05-17 04:35:36.006785 | LOOP [upload-logs : Compress console log and json output] 2026-05-17 04:35:36.058886 | localhost | skipping: Conditional result was False 2026-05-17 04:35:36.067898 | localhost | skipping: Conditional result was False 2026-05-17 04:35:36.075711 | 2026-05-17 04:35:36.075914 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-17 04:35:36.128045 | localhost | skipping: Conditional result was False 2026-05-17 04:35:36.128392 | 2026-05-17 04:35:36.133394 | localhost | skipping: Conditional result was False 2026-05-17 04:35:36.148189 | 2026-05-17 04:35:36.148658 | LOOP [upload-logs : Upload console log and json output]