2026-05-16 03:15:21.690487 | Job console starting 2026-05-16 03:15:21.719983 | Updating git repos 2026-05-16 03:15:21.749269 | Cloning repos into workspace 2026-05-16 03:15:21.809179 | Restoring repo states 2026-05-16 03:15:21.815007 | Merging changes 2026-05-16 03:15:21.815023 | Checking out repos 2026-05-16 03:15:21.881862 | Preparing playbooks 2026-05-16 03:15:22.874826 | Running Ansible setup 2026-05-16 03:15:27.015857 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-16 03:15:27.932331 | 2026-05-16 03:15:27.932544 | PLAY [Base pre] 2026-05-16 03:15:27.950566 | 2026-05-16 03:15:27.950725 | TASK [Setup log path fact] 2026-05-16 03:15:27.980352 | debian-bookworm | ok 2026-05-16 03:15:28.003484 | 2026-05-16 03:15:28.003816 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-16 03:15:28.064393 | debian-bookworm | ok 2026-05-16 03:15:28.085147 | 2026-05-16 03:15:28.085295 | TASK [emit-job-header : Print job information] 2026-05-16 03:15:28.166650 | # Job Information 2026-05-16 03:15:28.166980 | Ansible Version: 2.16.14 2026-05-16 03:15:28.167024 | Job: python-black 2026-05-16 03:15:28.167066 | Pipeline: periodic-daily 2026-05-16 03:15:28.167094 | Executor: 521e9411259a 2026-05-16 03:15:28.167115 | Triggered by: https://github.com/osism/openstack-simple-stress 2026-05-16 03:15:28.167137 | Event ID: 155a09b25cd34096adf6bd850a32c1df 2026-05-16 03:15:28.178130 | 2026-05-16 03:15:28.178282 | LOOP [emit-job-header : Print node information] 2026-05-16 03:15:28.362765 | debian-bookworm | ok: 2026-05-16 03:15:28.363298 | debian-bookworm | # Node Information 2026-05-16 03:15:28.363343 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-16 03:15:28.363369 | debian-bookworm | Hostname: debian 2026-05-16 03:15:28.363392 | debian-bookworm | Username: zuul 2026-05-16 03:15:28.363413 | debian-bookworm | Distro: Debian 12.13 2026-05-16 03:15:28.363437 | debian-bookworm | Provider: regiocloud-a 2026-05-16 03:15:28.363499 | debian-bookworm | Region: 2026-05-16 03:15:28.363521 | debian-bookworm | Label: debian-bookworm 2026-05-16 03:15:28.363541 | debian-bookworm | Product Name: OpenStack Nova 2026-05-16 03:15:28.363561 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe59:16cb 2026-05-16 03:15:28.384814 | 2026-05-16 03:15:28.384953 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-16 03:15:29.097233 | debian-bookworm -> localhost | changed 2026-05-16 03:15:29.105250 | 2026-05-16 03:15:29.105385 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-16 03:15:30.492207 | debian-bookworm -> localhost | changed 2026-05-16 03:15:30.505188 | 2026-05-16 03:15:30.505339 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-16 03:15:30.833537 | debian-bookworm -> localhost | ok 2026-05-16 03:15:30.840714 | 2026-05-16 03:15:30.840853 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-16 03:15:30.873114 | debian-bookworm | ok 2026-05-16 03:15:30.889229 | debian-bookworm | included: /var/lib/zuul/builds/3310621d1e864d2781b561263d160b33/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-16 03:15:30.896220 | 2026-05-16 03:15:30.896346 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-16 03:15:32.803616 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-16 03:15:32.803908 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3310621d1e864d2781b561263d160b33/work/3310621d1e864d2781b561263d160b33_id_rsa 2026-05-16 03:15:32.803950 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3310621d1e864d2781b561263d160b33/work/3310621d1e864d2781b561263d160b33_id_rsa.pub 2026-05-16 03:15:32.803976 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-16 03:15:32.804000 | debian-bookworm -> localhost | SHA256:OnBZ2bVLEu7AdR6RvdMuf4kbqbtP6om8vSKUURoyiPs zuul-build-sshkey 2026-05-16 03:15:32.804023 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-16 03:15:32.804288 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-16 03:15:32.804347 | debian-bookworm -> localhost | | . . o =+ | 2026-05-16 03:15:32.804373 | debian-bookworm -> localhost | | . . o o * =.o. | 2026-05-16 03:15:32.804395 | debian-bookworm -> localhost | | . o O + + o | 2026-05-16 03:15:32.804415 | debian-bookworm -> localhost | | . = o o .o .| 2026-05-16 03:15:32.804486 | debian-bookworm -> localhost | | . . o S . . o | 2026-05-16 03:15:32.804518 | debian-bookworm -> localhost | | E o + o .| 2026-05-16 03:15:32.804539 | debian-bookworm -> localhost | | + +.o.| 2026-05-16 03:15:32.804560 | debian-bookworm -> localhost | | o..o =...o| 2026-05-16 03:15:32.804581 | debian-bookworm -> localhost | | .++X=o. .| 2026-05-16 03:15:32.804602 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-16 03:15:32.804670 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.343632 2026-05-16 03:15:32.814106 | 2026-05-16 03:15:32.814242 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-16 03:15:32.847053 | debian-bookworm | ok 2026-05-16 03:15:32.860276 | debian-bookworm | included: /var/lib/zuul/builds/3310621d1e864d2781b561263d160b33/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-16 03:15:32.895670 | 2026-05-16 03:15:32.895824 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-16 03:15:32.927312 | debian-bookworm | skipping: Conditional result was False 2026-05-16 03:15:32.936216 | 2026-05-16 03:15:32.936354 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-16 03:15:33.685079 | debian-bookworm | changed 2026-05-16 03:15:33.691497 | 2026-05-16 03:15:33.691626 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-16 03:15:33.976964 | debian-bookworm | ok 2026-05-16 03:15:33.996547 | 2026-05-16 03:15:33.996771 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-16 03:15:34.696873 | debian-bookworm | changed 2026-05-16 03:15:34.714367 | 2026-05-16 03:15:34.714503 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-16 03:15:35.327739 | debian-bookworm | changed 2026-05-16 03:15:35.333994 | 2026-05-16 03:15:35.334100 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-16 03:15:35.357151 | debian-bookworm | skipping: Conditional result was False 2026-05-16 03:15:35.362956 | 2026-05-16 03:15:35.363054 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-16 03:15:36.016462 | debian-bookworm -> localhost | changed 2026-05-16 03:15:36.032106 | 2026-05-16 03:15:36.032219 | TASK [add-build-sshkey : Add back temp key] 2026-05-16 03:15:36.517053 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3310621d1e864d2781b561263d160b33/work/3310621d1e864d2781b561263d160b33_id_rsa (zuul-build-sshkey) 2026-05-16 03:15:36.517266 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025323 2026-05-16 03:15:36.527728 | 2026-05-16 03:15:36.527829 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-16 03:15:36.923498 | debian-bookworm | ok 2026-05-16 03:15:36.936352 | 2026-05-16 03:15:36.936483 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-16 03:15:36.975041 | debian-bookworm | skipping: Conditional result was False 2026-05-16 03:15:36.989457 | 2026-05-16 03:15:36.989555 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-16 03:15:37.444342 | debian-bookworm | ok 2026-05-16 03:15:37.460887 | 2026-05-16 03:15:37.460992 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-16 03:15:37.515083 | debian-bookworm | ok 2026-05-16 03:15:37.521359 | 2026-05-16 03:15:37.521500 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-16 03:15:38.154102 | debian-bookworm -> localhost | ok 2026-05-16 03:15:38.161474 | 2026-05-16 03:15:38.161604 | TASK [validate-host : Collect information about the host] 2026-05-16 03:15:39.669131 | debian-bookworm | ok 2026-05-16 03:15:39.692951 | 2026-05-16 03:15:39.693103 | TASK [validate-host : Sanitize hostname] 2026-05-16 03:15:39.979718 | debian-bookworm | ok 2026-05-16 03:15:40.061486 | 2026-05-16 03:15:40.061584 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-16 03:15:41.494495 | debian-bookworm -> localhost | changed 2026-05-16 03:15:41.499073 | 2026-05-16 03:15:41.499151 | TASK [validate-host : Collect information about zuul worker] 2026-05-16 03:15:42.003700 | debian-bookworm | ok 2026-05-16 03:15:42.009552 | 2026-05-16 03:15:42.009700 | TASK [validate-host : Write out all zuul information for each host] 2026-05-16 03:15:42.808012 | debian-bookworm -> localhost | changed 2026-05-16 03:15:42.817237 | 2026-05-16 03:15:42.817335 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-16 03:15:43.056281 | debian-bookworm | ok 2026-05-16 03:15:43.061089 | 2026-05-16 03:15:43.061166 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-16 03:15:44.031769 | debian-bookworm | changed: 2026-05-16 03:15:44.031911 | debian-bookworm | cd+++++++++ src/ 2026-05-16 03:15:44.031938 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-16 03:15:44.031957 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-16 03:15:44.031974 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2026-05-16 03:15:44.031991 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/3310621d1e864d2781b561263d160b33/work/logs" 2026-05-16 03:16:10.258121 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3310621d1e864d2781b561263d160b33/work/artifacts" 2026-05-16 03:16:10.542529 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3310621d1e864d2781b561263d160b33/work/docs" 2026-05-16 03:16:10.556209 | 2026-05-16 03:16:10.556356 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-16 03:16:11.440564 | debian-bookworm | changed: 2026-05-16 03:16:11.440750 | debian-bookworm | .d..t...... ./ 2026-05-16 03:16:11.440785 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-16 03:16:11.440815 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-16 03:16:11.440841 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-16 03:16:11.440879 | debian-bookworm | changed: All items complete 2026-05-16 03:16:11.440912 | 2026-05-16 03:16:12.219447 | debian-bookworm | changed: .d..t...... ./ 2026-05-16 03:16:12.785420 | debian-bookworm | changed: .d..t...... ./ 2026-05-16 03:16:12.817360 | 2026-05-16 03:16:12.817515 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-16 03:16:12.842768 | debian-bookworm | skipping: Conditional result was False 2026-05-16 03:16:12.844712 | debian-bookworm | skipping: Conditional result was False 2026-05-16 03:16:12.852946 | 2026-05-16 03:16:12.853010 | PLAY RECAP 2026-05-16 03:16:12.853057 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-16 03:16:12.853082 | 2026-05-16 03:16:12.993449 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-16 03:16:12.995524 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-16 03:16:13.730438 | 2026-05-16 03:16:13.730586 | PLAY [Base post] 2026-05-16 03:16:13.743290 | 2026-05-16 03:16:13.743417 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-16 03:16:14.267893 | debian-bookworm | changed 2026-05-16 03:16:14.274010 | 2026-05-16 03:16:14.274108 | PLAY RECAP 2026-05-16 03:16:14.274167 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-16 03:16:14.274227 | 2026-05-16 03:16:14.365312 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-16 03:16:14.369014 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-16 03:16:15.601082 | 2026-05-16 03:16:15.601227 | PLAY [Base post-logs] 2026-05-16 03:16:15.635173 | 2026-05-16 03:16:15.635345 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-16 03:16:16.720840 | localhost | changed 2026-05-16 03:16:16.757980 | 2026-05-16 03:16:16.758193 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-16 03:16:16.806362 | localhost | ok 2026-05-16 03:16:16.811859 | 2026-05-16 03:16:16.812040 | TASK [Set zuul-log-path fact] 2026-05-16 03:16:16.858609 | localhost | ok 2026-05-16 03:16:16.873175 | 2026-05-16 03:16:16.874124 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-16 03:16:16.913867 | localhost | ok 2026-05-16 03:16:16.916643 | 2026-05-16 03:16:16.916726 | TASK [upload-logs : Create log directories] 2026-05-16 03:16:17.964315 | localhost | changed 2026-05-16 03:16:17.967779 | 2026-05-16 03:16:17.967967 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-16 03:16:18.887585 | localhost -> localhost | ok: Runtime: 0:00:00.006881 2026-05-16 03:16:18.895577 | 2026-05-16 03:16:18.895725 | TASK [upload-logs : Upload logs to log server] 2026-05-16 03:16:19.650940 | localhost | Output suppressed because no_log was given 2026-05-16 03:16:19.652595 | 2026-05-16 03:16:19.652679 | LOOP [upload-logs : Compress console log and json output] 2026-05-16 03:16:19.742641 | localhost | skipping: Conditional result was False 2026-05-16 03:16:19.751620 | localhost | skipping: Conditional result was False 2026-05-16 03:16:19.758764 | 2026-05-16 03:16:19.758890 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-16 03:16:19.805303 | localhost | skipping: Conditional result was False 2026-05-16 03:16:19.805530 | 2026-05-16 03:16:19.810242 | localhost | skipping: Conditional result was False 2026-05-16 03:16:19.818384 | 2026-05-16 03:16:19.818571 | LOOP [upload-logs : Upload console log and json output]