2026-05-30 03:05:02.844297 | Job console starting 2026-05-30 03:05:02.859714 | Updating git repos 2026-05-30 03:05:02.897170 | Cloning repos into workspace 2026-05-30 03:05:02.935187 | Restoring repo states 2026-05-30 03:05:02.956311 | Merging changes 2026-05-30 03:05:02.956327 | Checking out repos 2026-05-30 03:05:03.039791 | Preparing playbooks 2026-05-30 03:05:04.091592 | Running Ansible setup 2026-05-30 03:05:08.599853 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-30 03:05:09.984371 | 2026-05-30 03:05:09.984515 | PLAY [Base pre] 2026-05-30 03:05:10.010342 | 2026-05-30 03:05:10.010468 | TASK [Setup log path fact] 2026-05-30 03:05:10.061763 | debian-bookworm | ok 2026-05-30 03:05:10.077152 | 2026-05-30 03:05:10.077278 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-30 03:05:10.135519 | debian-bookworm | ok 2026-05-30 03:05:10.145059 | 2026-05-30 03:05:10.145164 | TASK [emit-job-header : Print job information] 2026-05-30 03:05:10.213799 | # Job Information 2026-05-30 03:05:10.213994 | Ansible Version: 2.16.14 2026-05-30 03:05:10.214028 | Job: python-black 2026-05-30 03:05:10.214060 | Pipeline: periodic-daily 2026-05-30 03:05:10.214083 | Executor: 521e9411259a 2026-05-30 03:05:10.214104 | Triggered by: https://github.com/osism/openstack-project-manager 2026-05-30 03:05:10.214126 | Event ID: 71c86f92e50f4613aa9a785181eeaf6a 2026-05-30 03:05:10.219050 | 2026-05-30 03:05:10.219149 | LOOP [emit-job-header : Print node information] 2026-05-30 03:05:10.442740 | debian-bookworm | ok: 2026-05-30 03:05:10.442996 | debian-bookworm | # Node Information 2026-05-30 03:05:10.443035 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-30 03:05:10.443060 | debian-bookworm | Hostname: debian 2026-05-30 03:05:10.443082 | debian-bookworm | Username: zuul 2026-05-30 03:05:10.443103 | debian-bookworm | Distro: Debian 12.14 2026-05-30 03:05:10.443127 | debian-bookworm | Provider: regiocloud-a 2026-05-30 03:05:10.443148 | debian-bookworm | Region: 2026-05-30 03:05:10.443169 | debian-bookworm | Label: debian-bookworm 2026-05-30 03:05:10.443188 | debian-bookworm | Product Name: OpenStack Nova 2026-05-30 03:05:10.443208 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fedd:5fc2 2026-05-30 03:05:10.463482 | 2026-05-30 03:05:10.463592 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-30 03:05:11.177558 | debian-bookworm -> localhost | changed 2026-05-30 03:05:11.185355 | 2026-05-30 03:05:11.185496 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-30 03:05:13.147198 | debian-bookworm -> localhost | changed 2026-05-30 03:05:13.158144 | 2026-05-30 03:05:13.158258 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-30 03:05:13.553753 | debian-bookworm -> localhost | ok 2026-05-30 03:05:13.563059 | 2026-05-30 03:05:13.563159 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-30 03:05:13.592802 | debian-bookworm | ok 2026-05-30 03:05:13.614461 | debian-bookworm | included: /var/lib/zuul/builds/a32749810dab44e7a6c918f0afc0dfd7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-30 03:05:13.625240 | 2026-05-30 03:05:13.625338 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-30 03:05:15.290964 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-30 03:05:15.291156 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a32749810dab44e7a6c918f0afc0dfd7/work/a32749810dab44e7a6c918f0afc0dfd7_id_rsa 2026-05-30 03:05:15.291194 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a32749810dab44e7a6c918f0afc0dfd7/work/a32749810dab44e7a6c918f0afc0dfd7_id_rsa.pub 2026-05-30 03:05:15.291220 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-30 03:05:15.291244 | debian-bookworm -> localhost | SHA256:VwYEt4wTXX+NM0z+DX68+AdziSCGDUvL2VAqhcdajPY zuul-build-sshkey 2026-05-30 03:05:15.291266 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-30 03:05:15.291296 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-30 03:05:15.291318 | debian-bookworm -> localhost | | =.+=+.. . | 2026-05-30 03:05:15.291338 | debian-bookworm -> localhost | | +.O.=.o = ..| 2026-05-30 03:05:15.291359 | debian-bookworm -> localhost | | ..B.% o o O o| 2026-05-30 03:05:15.291378 | debian-bookworm -> localhost | | ..E * + . B.| 2026-05-30 03:05:15.291398 | debian-bookworm -> localhost | | S o . o *| 2026-05-30 03:05:15.291421 | debian-bookworm -> localhost | | . .+oo| 2026-05-30 03:05:15.291441 | debian-bookworm -> localhost | | . = | 2026-05-30 03:05:15.291461 | debian-bookworm -> localhost | | . .| 2026-05-30 03:05:15.291481 | debian-bookworm -> localhost | | ..| 2026-05-30 03:05:15.291501 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-30 03:05:15.291555 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.200933 2026-05-30 03:05:15.297769 | 2026-05-30 03:05:15.297863 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-30 03:05:15.316184 | debian-bookworm | ok 2026-05-30 03:05:15.330053 | debian-bookworm | included: /var/lib/zuul/builds/a32749810dab44e7a6c918f0afc0dfd7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-30 03:05:15.339049 | 2026-05-30 03:05:15.339144 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-30 03:05:15.352219 | debian-bookworm | skipping: Conditional result was False 2026-05-30 03:05:15.358742 | 2026-05-30 03:05:15.358887 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-30 03:05:15.975986 | debian-bookworm | changed 2026-05-30 03:05:15.983788 | 2026-05-30 03:05:15.983898 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-30 03:05:16.250171 | debian-bookworm | ok 2026-05-30 03:05:16.255752 | 2026-05-30 03:05:16.255855 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-30 03:05:17.012329 | debian-bookworm | changed 2026-05-30 03:05:17.041248 | 2026-05-30 03:05:17.041395 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-30 03:05:17.824615 | debian-bookworm | changed 2026-05-30 03:05:17.836106 | 2026-05-30 03:05:17.836253 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-30 03:05:17.896417 | debian-bookworm | skipping: Conditional result was False 2026-05-30 03:05:17.903355 | 2026-05-30 03:05:17.903482 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-30 03:05:19.545988 | debian-bookworm -> localhost | changed 2026-05-30 03:05:19.574796 | 2026-05-30 03:05:19.575115 | TASK [add-build-sshkey : Add back temp key] 2026-05-30 03:05:20.961606 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a32749810dab44e7a6c918f0afc0dfd7/work/a32749810dab44e7a6c918f0afc0dfd7_id_rsa (zuul-build-sshkey) 2026-05-30 03:05:20.961869 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.036002 2026-05-30 03:05:20.972771 | 2026-05-30 03:05:20.972939 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-30 03:05:21.492373 | debian-bookworm | ok 2026-05-30 03:05:21.504078 | 2026-05-30 03:05:21.504190 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-30 03:05:21.573178 | debian-bookworm | skipping: Conditional result was False 2026-05-30 03:05:21.583422 | 2026-05-30 03:05:21.583536 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-30 03:05:22.393310 | debian-bookworm | ok 2026-05-30 03:05:22.406695 | 2026-05-30 03:05:22.406802 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-30 03:05:22.455771 | debian-bookworm | ok 2026-05-30 03:05:22.460465 | 2026-05-30 03:05:22.460542 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-30 03:05:22.843472 | debian-bookworm -> localhost | ok 2026-05-30 03:05:22.849135 | 2026-05-30 03:05:22.849222 | TASK [validate-host : Collect information about the host] 2026-05-30 03:05:23.907689 | debian-bookworm | ok 2026-05-30 03:05:23.932987 | 2026-05-30 03:05:23.933090 | TASK [validate-host : Sanitize hostname] 2026-05-30 03:05:24.069427 | debian-bookworm | ok 2026-05-30 03:05:24.172160 | 2026-05-30 03:05:24.172276 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-30 03:05:25.035086 | debian-bookworm -> localhost | changed 2026-05-30 03:05:25.039835 | 2026-05-30 03:05:25.039940 | TASK [validate-host : Collect information about zuul worker] 2026-05-30 03:05:25.449115 | debian-bookworm | ok 2026-05-30 03:05:25.455976 | 2026-05-30 03:05:25.456107 | TASK [validate-host : Write out all zuul information for each host] 2026-05-30 03:05:25.974812 | debian-bookworm -> localhost | changed 2026-05-30 03:05:25.988872 | 2026-05-30 03:05:25.988999 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-30 03:05:26.285658 | debian-bookworm | ok 2026-05-30 03:05:26.293442 | 2026-05-30 03:05:26.293558 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-30 03:05:27.109106 | debian-bookworm | changed: 2026-05-30 03:05:27.109309 | debian-bookworm | cd+++++++++ src/ 2026-05-30 03:05:27.109349 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-30 03:05:27.109377 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-30 03:05:27.109402 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2026-05-30 03:05:27.109425 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/a32749810dab44e7a6c918f0afc0dfd7/work/logs" 2026-05-30 03:05:54.464241 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a32749810dab44e7a6c918f0afc0dfd7/work/artifacts" 2026-05-30 03:05:54.895999 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a32749810dab44e7a6c918f0afc0dfd7/work/docs" 2026-05-30 03:05:54.921430 | 2026-05-30 03:05:54.921584 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-30 03:05:56.137338 | debian-bookworm | changed: 2026-05-30 03:05:56.137596 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-30 03:05:56.137633 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-30 03:05:56.137663 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-30 03:05:56.137708 | debian-bookworm | changed: All items complete 2026-05-30 03:05:56.137730 | 2026-05-30 03:05:57.035061 | debian-bookworm | changed: .d..t...... ./ 2026-05-30 03:05:57.690286 | debian-bookworm | changed: .d..t...... ./ 2026-05-30 03:05:57.712922 | 2026-05-30 03:05:57.713084 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-30 03:05:57.743696 | debian-bookworm | skipping: Conditional result was False 2026-05-30 03:05:57.747775 | debian-bookworm | skipping: Conditional result was False 2026-05-30 03:05:57.757803 | 2026-05-30 03:05:57.757926 | PLAY RECAP 2026-05-30 03:05:57.757980 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-30 03:05:57.758007 | 2026-05-30 03:05:57.940529 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-30 03:05:57.941441 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-30 03:05:59.364276 | 2026-05-30 03:05:59.364470 | PLAY [Base post] 2026-05-30 03:05:59.381105 | 2026-05-30 03:05:59.381266 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-30 03:06:00.001338 | debian-bookworm | changed 2026-05-30 03:06:00.018376 | 2026-05-30 03:06:00.018537 | PLAY RECAP 2026-05-30 03:06:00.018606 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-30 03:06:00.018671 | 2026-05-30 03:06:00.522313 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-30 03:06:00.524115 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-30 03:06:01.764624 | 2026-05-30 03:06:01.764783 | PLAY [Base post-logs] 2026-05-30 03:06:01.775358 | 2026-05-30 03:06:01.775490 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-30 03:06:02.244730 | localhost | changed 2026-05-30 03:06:02.263091 | 2026-05-30 03:06:02.263261 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-30 03:06:02.288452 | localhost | ok 2026-05-30 03:06:02.301768 | 2026-05-30 03:06:02.301864 | TASK [Set zuul-log-path fact] 2026-05-30 03:06:02.330611 | localhost | ok 2026-05-30 03:06:02.348188 | 2026-05-30 03:06:02.348380 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-30 03:06:02.384076 | localhost | ok 2026-05-30 03:06:02.387174 | 2026-05-30 03:06:02.387275 | TASK [upload-logs : Create log directories] 2026-05-30 03:06:02.892669 | localhost | changed 2026-05-30 03:06:02.895173 | 2026-05-30 03:06:02.895264 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-30 03:06:03.492113 | localhost -> localhost | ok: Runtime: 0:00:00.021514 2026-05-30 03:06:03.495163 | 2026-05-30 03:06:03.495253 | TASK [upload-logs : Upload logs to log server] 2026-05-30 03:06:04.197258 | localhost | Output suppressed because no_log was given 2026-05-30 03:06:04.198822 | 2026-05-30 03:06:04.199064 | LOOP [upload-logs : Compress console log and json output] 2026-05-30 03:06:04.290046 | localhost | skipping: Conditional result was False 2026-05-30 03:06:04.295761 | localhost | skipping: Conditional result was False 2026-05-30 03:06:04.305460 | 2026-05-30 03:06:04.305597 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-30 03:06:04.360792 | localhost | skipping: Conditional result was False 2026-05-30 03:06:04.361063 | 2026-05-30 03:06:04.367242 | localhost | skipping: Conditional result was False 2026-05-30 03:06:04.373934 | 2026-05-30 03:06:04.374054 | LOOP [upload-logs : Upload console log and json output]