2026-05-25 03:01:32.619244 | Job console starting 2026-05-25 03:01:32.625864 | Updating git repos 2026-05-25 03:01:32.925308 | Cloning repos into workspace 2026-05-25 03:01:33.030147 | Restoring repo states 2026-05-25 03:01:33.052485 | Merging changes 2026-05-25 03:01:33.052500 | Checking out repos 2026-05-25 03:01:33.145785 | Preparing playbooks 2026-05-25 03:01:35.446949 | Running Ansible setup 2026-05-25 03:01:47.930111 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-25 03:01:50.546126 | 2026-05-25 03:01:50.546262 | PLAY [Base pre] 2026-05-25 03:01:50.599916 | 2026-05-25 03:01:50.600726 | TASK [Setup log path fact] 2026-05-25 03:01:50.646745 | debian-bookworm | ok 2026-05-25 03:01:50.687294 | 2026-05-25 03:01:50.687453 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-25 03:01:50.735664 | debian-bookworm | ok 2026-05-25 03:01:50.781333 | 2026-05-25 03:01:50.781481 | TASK [emit-job-header : Print job information] 2026-05-25 03:01:50.860633 | # Job Information 2026-05-25 03:01:50.860793 | Ansible Version: 2.16.14 2026-05-25 03:01:50.860823 | Job: openstack-project-manager-mypy 2026-05-25 03:01:50.860852 | Pipeline: periodic-daily 2026-05-25 03:01:50.860871 | Executor: 521e9411259a 2026-05-25 03:01:50.860888 | Triggered by: https://github.com/osism/openstack-project-manager 2026-05-25 03:01:50.860906 | Event ID: aadcc380ddb6452e9f9b2d8bb8f4f7e8 2026-05-25 03:01:50.866394 | 2026-05-25 03:01:50.866512 | LOOP [emit-job-header : Print node information] 2026-05-25 03:01:51.003461 | debian-bookworm | ok: 2026-05-25 03:01:51.003661 | debian-bookworm | # Node Information 2026-05-25 03:01:51.003693 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-25 03:01:51.003715 | debian-bookworm | Hostname: debian 2026-05-25 03:01:51.003733 | debian-bookworm | Username: zuul 2026-05-25 03:01:51.003750 | debian-bookworm | Distro: Debian 12.14 2026-05-25 03:01:51.003769 | debian-bookworm | Provider: regiocloud-a 2026-05-25 03:01:51.003787 | debian-bookworm | Region: 2026-05-25 03:01:51.003804 | debian-bookworm | Label: debian-bookworm 2026-05-25 03:01:51.003925 | debian-bookworm | Product Name: OpenStack Nova 2026-05-25 03:01:51.003948 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe17:d81f 2026-05-25 03:01:51.015347 | 2026-05-25 03:01:51.015670 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-25 03:01:51.503666 | debian-bookworm -> localhost | changed 2026-05-25 03:01:51.510774 | 2026-05-25 03:01:51.510910 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-25 03:01:53.358119 | debian-bookworm -> localhost | changed 2026-05-25 03:01:53.368319 | 2026-05-25 03:01:53.368426 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-25 03:01:53.856471 | debian-bookworm -> localhost | ok 2026-05-25 03:01:53.861603 | 2026-05-25 03:01:53.861713 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-25 03:01:53.881106 | debian-bookworm | ok 2026-05-25 03:01:53.905677 | debian-bookworm | included: /var/lib/zuul/builds/6a58f3df029f45f599f83bfbbc01b5e7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-25 03:01:53.911723 | 2026-05-25 03:01:53.911838 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-25 03:01:57.666268 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-25 03:01:57.666507 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6a58f3df029f45f599f83bfbbc01b5e7/work/6a58f3df029f45f599f83bfbbc01b5e7_id_rsa 2026-05-25 03:01:57.666546 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6a58f3df029f45f599f83bfbbc01b5e7/work/6a58f3df029f45f599f83bfbbc01b5e7_id_rsa.pub 2026-05-25 03:01:57.666572 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-25 03:01:57.666596 | debian-bookworm -> localhost | SHA256:Blgx7h4BizDmH/RRXNuMeLZvAU8OJAjV62J0cWdzfGI zuul-build-sshkey 2026-05-25 03:01:57.666636 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-25 03:01:57.666659 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-25 03:01:57.666679 | debian-bookworm -> localhost | |o. o+oO+.o . | 2026-05-25 03:01:57.666701 | debian-bookworm -> localhost | |oo...B.=+.=+ E . | 2026-05-25 03:01:57.666721 | debian-bookworm -> localhost | | ...o.+.+Bo++ o | 2026-05-25 03:01:57.666741 | debian-bookworm -> localhost | | . .o =o B | 2026-05-25 03:01:57.666761 | debian-bookworm -> localhost | | .. = S. + | 2026-05-25 03:01:57.666787 | debian-bookworm -> localhost | | + + . . | 2026-05-25 03:01:57.666808 | debian-bookworm -> localhost | | . o o | 2026-05-25 03:01:57.666827 | debian-bookworm -> localhost | | . | 2026-05-25 03:01:57.666863 | debian-bookworm -> localhost | | | 2026-05-25 03:01:57.666885 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-25 03:01:57.666943 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.977174 2026-05-25 03:01:57.673699 | 2026-05-25 03:01:57.673806 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-25 03:01:57.705580 | debian-bookworm | ok 2026-05-25 03:01:57.715598 | debian-bookworm | included: /var/lib/zuul/builds/6a58f3df029f45f599f83bfbbc01b5e7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-25 03:01:57.724157 | 2026-05-25 03:01:57.724248 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-25 03:01:57.747224 | debian-bookworm | skipping: Conditional result was False 2026-05-25 03:01:57.752694 | 2026-05-25 03:01:57.752778 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-25 03:01:58.462489 | debian-bookworm | changed 2026-05-25 03:01:58.467470 | 2026-05-25 03:01:58.467565 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-25 03:01:58.729114 | debian-bookworm | ok 2026-05-25 03:01:58.734263 | 2026-05-25 03:01:58.734357 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-25 03:01:59.446809 | debian-bookworm | changed 2026-05-25 03:01:59.453165 | 2026-05-25 03:01:59.453271 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-25 03:02:00.093236 | debian-bookworm | changed 2026-05-25 03:02:00.097743 | 2026-05-25 03:02:00.097827 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-25 03:02:00.127648 | debian-bookworm | skipping: Conditional result was False 2026-05-25 03:02:00.132903 | 2026-05-25 03:02:00.132989 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-25 03:02:00.666113 | debian-bookworm -> localhost | changed 2026-05-25 03:02:00.696696 | 2026-05-25 03:02:00.696888 | TASK [add-build-sshkey : Add back temp key] 2026-05-25 03:02:00.994610 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6a58f3df029f45f599f83bfbbc01b5e7/work/6a58f3df029f45f599f83bfbbc01b5e7_id_rsa (zuul-build-sshkey) 2026-05-25 03:02:00.994910 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008536 2026-05-25 03:02:01.003783 | 2026-05-25 03:02:01.003904 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-25 03:02:01.392588 | debian-bookworm | ok 2026-05-25 03:02:01.399683 | 2026-05-25 03:02:01.399805 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-25 03:02:01.439282 | debian-bookworm | skipping: Conditional result was False 2026-05-25 03:02:01.450080 | 2026-05-25 03:02:01.450191 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-25 03:02:01.902005 | debian-bookworm | ok 2026-05-25 03:02:01.914576 | 2026-05-25 03:02:01.914806 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-25 03:02:01.943730 | debian-bookworm | ok 2026-05-25 03:02:01.948549 | 2026-05-25 03:02:01.948630 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-25 03:02:02.540644 | debian-bookworm -> localhost | ok 2026-05-25 03:02:02.547080 | 2026-05-25 03:02:02.547190 | TASK [validate-host : Collect information about the host] 2026-05-25 03:02:03.975530 | debian-bookworm | ok 2026-05-25 03:02:03.987922 | 2026-05-25 03:02:03.988022 | TASK [validate-host : Sanitize hostname] 2026-05-25 03:02:04.094188 | debian-bookworm | ok 2026-05-25 03:02:04.196013 | 2026-05-25 03:02:04.196137 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-25 03:02:05.431053 | debian-bookworm -> localhost | changed 2026-05-25 03:02:05.436689 | 2026-05-25 03:02:05.436802 | TASK [validate-host : Collect information about zuul worker] 2026-05-25 03:02:05.861823 | debian-bookworm | ok 2026-05-25 03:02:05.866450 | 2026-05-25 03:02:05.866580 | TASK [validate-host : Write out all zuul information for each host] 2026-05-25 03:02:06.392087 | debian-bookworm -> localhost | changed 2026-05-25 03:02:06.410254 | 2026-05-25 03:02:06.410374 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-25 03:02:06.695332 | debian-bookworm | ok 2026-05-25 03:02:06.703491 | 2026-05-25 03:02:06.703608 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-25 03:02:07.569937 | debian-bookworm | changed: 2026-05-25 03:02:07.570219 | debian-bookworm | cd+++++++++ src/ 2026-05-25 03:02:07.570282 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-25 03:02:07.570335 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-25 03:02:07.570386 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2026-05-25 03:02:07.570420 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/6a58f3df029f45f599f83bfbbc01b5e7/work/logs" 2026-05-25 03:03:23.173355 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6a58f3df029f45f599f83bfbbc01b5e7/work/artifacts" 2026-05-25 03:03:24.242682 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6a58f3df029f45f599f83bfbbc01b5e7/work/docs" 2026-05-25 03:03:24.257958 | 2026-05-25 03:03:24.258058 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-25 03:03:26.003528 | debian-bookworm | changed: 2026-05-25 03:03:26.003703 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-25 03:03:26.003734 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-25 03:03:26.003759 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-25 03:03:26.003793 | debian-bookworm | changed: All items complete 2026-05-25 03:03:26.003811 | 2026-05-25 03:03:27.211948 | debian-bookworm | changed: .d..t...... ./ 2026-05-25 03:03:28.133841 | debian-bookworm | changed: .d..t...... ./ 2026-05-25 03:03:28.154138 | 2026-05-25 03:03:28.154247 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-25 03:03:28.208194 | debian-bookworm | skipping: Conditional result was False 2026-05-25 03:03:28.217214 | debian-bookworm | skipping: Conditional result was False 2026-05-25 03:03:28.230352 | 2026-05-25 03:03:28.230424 | PLAY RECAP 2026-05-25 03:03:28.230467 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-25 03:03:28.230489 | 2026-05-25 03:03:28.697438 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-25 03:03:28.699822 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-25 03:03:30.880345 | 2026-05-25 03:03:30.880481 | PLAY [Base post] 2026-05-25 03:03:30.923671 | 2026-05-25 03:03:30.923800 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-25 03:03:32.111116 | debian-bookworm | changed 2026-05-25 03:03:32.116938 | 2026-05-25 03:03:32.117013 | PLAY RECAP 2026-05-25 03:03:32.117063 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-25 03:03:32.117115 | 2026-05-25 03:03:32.631668 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-25 03:03:32.632319 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-25 03:03:35.510217 | 2026-05-25 03:03:35.514590 | PLAY [Base post-logs] 2026-05-25 03:03:35.573219 | 2026-05-25 03:03:35.573346 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-25 03:03:36.816505 | localhost | changed 2026-05-25 03:03:36.828395 | 2026-05-25 03:03:36.828541 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-25 03:03:36.880263 | localhost | ok 2026-05-25 03:03:36.883396 | 2026-05-25 03:03:36.883486 | TASK [Set zuul-log-path fact] 2026-05-25 03:03:36.920041 | localhost | ok 2026-05-25 03:03:36.929024 | 2026-05-25 03:03:36.929127 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-25 03:03:36.985452 | localhost | ok 2026-05-25 03:03:36.987994 | 2026-05-25 03:03:36.988075 | TASK [upload-logs : Create log directories] 2026-05-25 03:03:38.002887 | localhost | changed 2026-05-25 03:03:38.005174 | 2026-05-25 03:03:38.005259 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-25 03:03:39.357849 | localhost -> localhost | ok: Runtime: 0:00:00.027294 2026-05-25 03:03:39.361304 | 2026-05-25 03:03:39.361398 | TASK [upload-logs : Upload logs to log server] 2026-05-25 03:03:40.009143 | localhost | Output suppressed because no_log was given 2026-05-25 03:03:40.011395 | 2026-05-25 03:03:40.011484 | LOOP [upload-logs : Compress console log and json output] 2026-05-25 03:03:40.115258 | localhost | skipping: Conditional result was False 2026-05-25 03:03:40.157546 | localhost | skipping: Conditional result was False 2026-05-25 03:03:40.161025 | 2026-05-25 03:03:40.161134 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-25 03:03:40.284087 | localhost | skipping: Conditional result was False 2026-05-25 03:03:40.285858 | 2026-05-25 03:03:40.292937 | localhost | skipping: Conditional result was False 2026-05-25 03:03:40.303421 | 2026-05-25 03:03:40.303528 | LOOP [upload-logs : Upload console log and json output]