2026-05-04 03:01:54.386567 | Job console starting 2026-05-04 03:01:54.399448 | Updating git repos 2026-05-04 03:01:54.471079 | Cloning repos into workspace 2026-05-04 03:01:54.571396 | Restoring repo states 2026-05-04 03:01:54.580783 | Merging changes 2026-05-04 03:01:54.580802 | Checking out repos 2026-05-04 03:01:54.666480 | Preparing playbooks 2026-05-04 03:01:55.645217 | Running Ansible setup 2026-05-04 03:02:01.535743 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-04 03:02:02.489575 | 2026-05-04 03:02:02.489697 | PLAY [Base pre] 2026-05-04 03:02:02.524014 | 2026-05-04 03:02:02.524126 | TASK [Setup log path fact] 2026-05-04 03:02:02.552174 | debian-bookworm | ok 2026-05-04 03:02:02.576319 | 2026-05-04 03:02:02.576440 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-04 03:02:02.603930 | debian-bookworm | ok 2026-05-04 03:02:02.612022 | 2026-05-04 03:02:02.612117 | TASK [emit-job-header : Print job information] 2026-05-04 03:02:02.639159 | # Job Information 2026-05-04 03:02:02.639313 | Ansible Version: 2.16.14 2026-05-04 03:02:02.639344 | Job: python-black 2026-05-04 03:02:02.639371 | Pipeline: periodic-daily 2026-05-04 03:02:02.639391 | Executor: 521e9411259a 2026-05-04 03:02:02.639408 | Triggered by: https://github.com/osism/openstack-simple-stress 2026-05-04 03:02:02.639426 | Event ID: a34d4b9afb6f4305a6783894f717cff5 2026-05-04 03:02:02.643391 | 2026-05-04 03:02:02.643469 | LOOP [emit-job-header : Print node information] 2026-05-04 03:02:02.731263 | debian-bookworm | ok: 2026-05-04 03:02:02.731645 | debian-bookworm | # Node Information 2026-05-04 03:02:02.731690 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-04 03:02:02.731717 | debian-bookworm | Hostname: debian 2026-05-04 03:02:02.731741 | debian-bookworm | Username: zuul 2026-05-04 03:02:02.731763 | debian-bookworm | Distro: Debian 12.13 2026-05-04 03:02:02.731787 | debian-bookworm | Provider: regiocloud-a 2026-05-04 03:02:02.731808 | debian-bookworm | Region: 2026-05-04 03:02:02.731829 | debian-bookworm | Label: debian-bookworm 2026-05-04 03:02:02.731849 | debian-bookworm | Product Name: OpenStack Nova 2026-05-04 03:02:02.731868 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe37:f037 2026-05-04 03:02:02.747839 | 2026-05-04 03:02:02.747935 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-04 03:02:03.509208 | debian-bookworm -> localhost | changed 2026-05-04 03:02:03.515002 | 2026-05-04 03:02:03.515094 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-04 03:02:06.114961 | debian-bookworm -> localhost | changed 2026-05-04 03:02:06.124666 | 2026-05-04 03:02:06.124825 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-04 03:02:06.740525 | debian-bookworm -> localhost | ok 2026-05-04 03:02:06.753450 | 2026-05-04 03:02:06.753551 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-04 03:02:06.793434 | debian-bookworm | ok 2026-05-04 03:02:06.834913 | debian-bookworm | included: /var/lib/zuul/builds/c9c89046baf04bbe93f28233bdeef6d5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-04 03:02:06.855843 | 2026-05-04 03:02:06.855945 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-04 03:02:08.265296 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-04 03:02:08.265482 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c9c89046baf04bbe93f28233bdeef6d5/work/c9c89046baf04bbe93f28233bdeef6d5_id_rsa 2026-05-04 03:02:08.265512 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c9c89046baf04bbe93f28233bdeef6d5/work/c9c89046baf04bbe93f28233bdeef6d5_id_rsa.pub 2026-05-04 03:02:08.265533 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-04 03:02:08.265552 | debian-bookworm -> localhost | SHA256:aJEU9xILllCcHvCdmGUAiYF8jf6b0FCKF7x6znOa0js zuul-build-sshkey 2026-05-04 03:02:08.265571 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-04 03:02:08.265595 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-04 03:02:08.265614 | debian-bookworm -> localhost | |..oo*BB== | 2026-05-04 03:02:08.265631 | debian-bookworm -> localhost | |...=.*=X = | 2026-05-04 03:02:08.265648 | debian-bookworm -> localhost | | + =.*.= . | 2026-05-04 03:02:08.265665 | debian-bookworm -> localhost | | . * .o . | 2026-05-04 03:02:08.265681 | debian-bookworm -> localhost | | o + o S | 2026-05-04 03:02:08.265702 | debian-bookworm -> localhost | | . o + | 2026-05-04 03:02:08.265719 | debian-bookworm -> localhost | | = . o | 2026-05-04 03:02:08.265735 | debian-bookworm -> localhost | | . E.+ | 2026-05-04 03:02:08.265752 | debian-bookworm -> localhost | | .+* | 2026-05-04 03:02:08.265768 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-04 03:02:08.265810 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.636923 2026-05-04 03:02:08.271258 | 2026-05-04 03:02:08.271343 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-04 03:02:08.311812 | debian-bookworm | ok 2026-05-04 03:02:08.321763 | debian-bookworm | included: /var/lib/zuul/builds/c9c89046baf04bbe93f28233bdeef6d5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-04 03:02:08.330595 | 2026-05-04 03:02:08.331385 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-04 03:02:08.344596 | debian-bookworm | skipping: Conditional result was False 2026-05-04 03:02:08.363961 | 2026-05-04 03:02:08.366390 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-04 03:02:09.310074 | debian-bookworm | changed 2026-05-04 03:02:09.321794 | 2026-05-04 03:02:09.321910 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-04 03:02:09.581936 | debian-bookworm | ok 2026-05-04 03:02:09.587643 | 2026-05-04 03:02:09.587742 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-04 03:02:10.168523 | debian-bookworm | changed 2026-05-04 03:02:10.180827 | 2026-05-04 03:02:10.180948 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-04 03:02:10.839161 | debian-bookworm | changed 2026-05-04 03:02:10.844407 | 2026-05-04 03:02:10.844501 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-04 03:02:10.891366 | debian-bookworm | skipping: Conditional result was False 2026-05-04 03:02:10.897187 | 2026-05-04 03:02:10.897294 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-04 03:02:12.099072 | debian-bookworm -> localhost | changed 2026-05-04 03:02:12.109389 | 2026-05-04 03:02:12.109493 | TASK [add-build-sshkey : Add back temp key] 2026-05-04 03:02:12.716601 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c9c89046baf04bbe93f28233bdeef6d5/work/c9c89046baf04bbe93f28233bdeef6d5_id_rsa (zuul-build-sshkey) 2026-05-04 03:02:12.716777 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014955 2026-05-04 03:02:12.723855 | 2026-05-04 03:02:12.723939 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-04 03:02:13.191746 | debian-bookworm | ok 2026-05-04 03:02:13.196927 | 2026-05-04 03:02:13.197039 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-04 03:02:13.219951 | debian-bookworm | skipping: Conditional result was False 2026-05-04 03:02:13.237359 | 2026-05-04 03:02:13.237464 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-04 03:02:13.747841 | debian-bookworm | ok 2026-05-04 03:02:13.761826 | 2026-05-04 03:02:13.761932 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-04 03:02:13.805673 | debian-bookworm | ok 2026-05-04 03:02:13.811404 | 2026-05-04 03:02:13.811501 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-04 03:02:14.295175 | debian-bookworm -> localhost | ok 2026-05-04 03:02:14.302461 | 2026-05-04 03:02:14.302550 | TASK [validate-host : Collect information about the host] 2026-05-04 03:02:15.863182 | debian-bookworm | ok 2026-05-04 03:02:15.896984 | 2026-05-04 03:02:15.897163 | TASK [validate-host : Sanitize hostname] 2026-05-04 03:02:16.118550 | debian-bookworm | ok 2026-05-04 03:02:16.207202 | 2026-05-04 03:02:16.207309 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-04 03:02:18.240576 | debian-bookworm -> localhost | changed 2026-05-04 03:02:18.246400 | 2026-05-04 03:02:18.246505 | TASK [validate-host : Collect information about zuul worker] 2026-05-04 03:02:19.017082 | debian-bookworm | ok 2026-05-04 03:02:19.021826 | 2026-05-04 03:02:19.021926 | TASK [validate-host : Write out all zuul information for each host] 2026-05-04 03:02:20.177475 | debian-bookworm -> localhost | changed 2026-05-04 03:02:20.186543 | 2026-05-04 03:02:20.186642 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-04 03:02:20.511754 | debian-bookworm | ok 2026-05-04 03:02:20.520099 | 2026-05-04 03:02:20.520213 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-04 03:02:21.771261 | debian-bookworm | changed: 2026-05-04 03:02:21.771409 | debian-bookworm | cd+++++++++ src/ 2026-05-04 03:02:21.771437 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-04 03:02:21.771457 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-04 03:02:21.771475 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2026-05-04 03:02:21.771492 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/c9c89046baf04bbe93f28233bdeef6d5/work/logs" 2026-05-04 03:02:50.580641 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c9c89046baf04bbe93f28233bdeef6d5/work/artifacts" 2026-05-04 03:02:50.939087 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c9c89046baf04bbe93f28233bdeef6d5/work/docs" 2026-05-04 03:02:50.955706 | 2026-05-04 03:02:50.955806 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-04 03:02:51.957511 | debian-bookworm | changed: 2026-05-04 03:02:51.957695 | debian-bookworm | .d..t...... ./ 2026-05-04 03:02:51.957728 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-04 03:02:51.957757 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-04 03:02:51.957783 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-04 03:02:51.957821 | debian-bookworm | changed: All items complete 2026-05-04 03:02:51.957847 | 2026-05-04 03:02:52.696256 | debian-bookworm | changed: .d..t...... ./ 2026-05-04 03:02:53.674399 | debian-bookworm | changed: .d..t...... ./ 2026-05-04 03:02:53.698014 | 2026-05-04 03:02:53.698146 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-04 03:02:53.751173 | debian-bookworm | skipping: Conditional result was False 2026-05-04 03:02:53.762247 | debian-bookworm | skipping: Conditional result was False 2026-05-04 03:02:53.780762 | 2026-05-04 03:02:53.780847 | PLAY RECAP 2026-05-04 03:02:53.780900 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-04 03:02:53.780926 | 2026-05-04 03:02:54.097048 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-04 03:02:54.097967 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-04 03:02:56.040857 | 2026-05-04 03:02:56.041089 | PLAY [Base post] 2026-05-04 03:02:56.062334 | 2026-05-04 03:02:56.062531 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-04 03:02:56.898624 | debian-bookworm | changed 2026-05-04 03:02:56.908679 | 2026-05-04 03:02:56.908880 | PLAY RECAP 2026-05-04 03:02:56.909211 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-04 03:02:56.909279 | 2026-05-04 03:02:57.060712 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-04 03:02:57.061642 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-04 03:02:58.403354 | 2026-05-04 03:02:58.403489 | PLAY [Base post-logs] 2026-05-04 03:02:58.425429 | 2026-05-04 03:02:58.425561 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-04 03:02:59.356748 | localhost | changed 2026-05-04 03:02:59.366217 | 2026-05-04 03:02:59.366355 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-04 03:02:59.423439 | localhost | ok 2026-05-04 03:02:59.426384 | 2026-05-04 03:02:59.426472 | TASK [Set zuul-log-path fact] 2026-05-04 03:02:59.451431 | localhost | ok 2026-05-04 03:02:59.460442 | 2026-05-04 03:02:59.460554 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-04 03:02:59.505296 | localhost | ok 2026-05-04 03:02:59.508203 | 2026-05-04 03:02:59.508298 | TASK [upload-logs : Create log directories] 2026-05-04 03:03:00.314622 | localhost | changed 2026-05-04 03:03:00.317179 | 2026-05-04 03:03:00.317277 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-04 03:03:01.256926 | localhost -> localhost | ok: Runtime: 0:00:00.019276 2026-05-04 03:03:01.260509 | 2026-05-04 03:03:01.260609 | TASK [upload-logs : Upload logs to log server] 2026-05-04 03:03:02.619724 | localhost | Output suppressed because no_log was given 2026-05-04 03:03:02.621377 | 2026-05-04 03:03:02.621465 | LOOP [upload-logs : Compress console log and json output] 2026-05-04 03:03:02.702524 | localhost | skipping: Conditional result was False 2026-05-04 03:03:02.721999 | localhost | skipping: Conditional result was False 2026-05-04 03:03:02.727492 | 2026-05-04 03:03:02.727588 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-04 03:03:02.821877 | localhost | skipping: Conditional result was False 2026-05-04 03:03:02.822109 | 2026-05-04 03:03:02.826006 | localhost | skipping: Conditional result was False 2026-05-04 03:03:02.836324 | 2026-05-04 03:03:02.836431 | LOOP [upload-logs : Upload console log and json output]