2025-12-02 20:59:11.747991 | Job console starting 2025-12-02 20:59:11.820362 | Updating git repos 2025-12-02 20:59:11.893788 | Cloning repos into workspace 2025-12-02 20:59:11.978226 | Restoring repo states 2025-12-02 20:59:11.999974 | Merging changes 2025-12-02 20:59:12.755451 | Checking out repos 2025-12-02 20:59:12.904156 | Preparing playbooks 2025-12-02 20:59:14.153812 | Running Ansible setup 2025-12-02 20:59:19.893354 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-02 20:59:21.321514 | 2025-12-02 20:59:21.321639 | PLAY [Base pre] 2025-12-02 20:59:21.352056 | 2025-12-02 20:59:21.352169 | TASK [Setup log path fact] 2025-12-02 20:59:21.379639 | debian-bookworm | ok 2025-12-02 20:59:21.401952 | 2025-12-02 20:59:21.402075 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-02 20:59:21.449776 | debian-bookworm | ok 2025-12-02 20:59:21.467639 | 2025-12-02 20:59:21.467734 | TASK [emit-job-header : Print job information] 2025-12-02 20:59:21.516225 | # Job Information 2025-12-02 20:59:21.516425 | Ansible Version: 2.16.14 2025-12-02 20:59:21.516460 | Job: python-black 2025-12-02 20:59:21.516487 | Pipeline: check 2025-12-02 20:59:21.516506 | Executor: 521e9411259a 2025-12-02 20:59:21.516524 | Triggered by: https://github.com/osism/python-osism/pull/1876 2025-12-02 20:59:21.516543 | Event ID: bb6d8500-cfc1-11f0-865c-ce1f0be5c984 2025-12-02 20:59:21.521439 | 2025-12-02 20:59:21.521533 | LOOP [emit-job-header : Print node information] 2025-12-02 20:59:21.723376 | debian-bookworm | ok: 2025-12-02 20:59:21.723634 | debian-bookworm | # Node Information 2025-12-02 20:59:21.723672 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-02 20:59:21.723698 | debian-bookworm | Hostname: debian 2025-12-02 20:59:21.723721 | debian-bookworm | Username: zuul 2025-12-02 20:59:21.723741 | debian-bookworm | Distro: Debian 12.12 2025-12-02 20:59:21.723764 | debian-bookworm | Provider: regiocloud-a 2025-12-02 20:59:21.723785 | debian-bookworm | Region: 2025-12-02 20:59:21.723806 | debian-bookworm | Label: debian-bookworm 2025-12-02 20:59:21.723826 | debian-bookworm | Product Name: OpenStack Nova 2025-12-02 20:59:21.723846 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe47:6b86 2025-12-02 20:59:21.752472 | 2025-12-02 20:59:21.752588 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-02 20:59:22.498821 | debian-bookworm -> localhost | changed 2025-12-02 20:59:22.506434 | 2025-12-02 20:59:22.506545 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-02 20:59:24.168695 | debian-bookworm -> localhost | changed 2025-12-02 20:59:24.185383 | 2025-12-02 20:59:24.185494 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-02 20:59:24.748735 | debian-bookworm -> localhost | ok 2025-12-02 20:59:24.753952 | 2025-12-02 20:59:24.754084 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-02 20:59:24.790580 | debian-bookworm | ok 2025-12-02 20:59:24.821861 | debian-bookworm | included: /var/lib/zuul/builds/5726b4eac1654c7981c9baee92690691/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-02 20:59:24.838942 | 2025-12-02 20:59:24.839043 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-02 20:59:27.453559 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-02 20:59:27.453762 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5726b4eac1654c7981c9baee92690691/work/5726b4eac1654c7981c9baee92690691_id_rsa 2025-12-02 20:59:27.453800 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5726b4eac1654c7981c9baee92690691/work/5726b4eac1654c7981c9baee92690691_id_rsa.pub 2025-12-02 20:59:27.453826 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-02 20:59:27.453851 | debian-bookworm -> localhost | SHA256:gbK56XfE/PZGT+9edI5XKfjzV2NBsgl/ZDnr6mfGINg zuul-build-sshkey 2025-12-02 20:59:27.453874 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-02 20:59:27.453905 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-02 20:59:27.453926 | debian-bookworm -> localhost | | .| 2025-12-02 20:59:27.453946 | debian-bookworm -> localhost | | . . . * | 2025-12-02 20:59:27.453966 | debian-bookworm -> localhost | | . . . o B o| 2025-12-02 20:59:27.453986 | debian-bookworm -> localhost | | + . .+ +.| 2025-12-02 20:59:27.454005 | debian-bookworm -> localhost | | o oS o. .o.=| 2025-12-02 20:59:27.454027 | debian-bookworm -> localhost | | o +. Eo.oB+| 2025-12-02 20:59:27.454047 | debian-bookworm -> localhost | | o . . ..=*.*| 2025-12-02 20:59:27.454067 | debian-bookworm -> localhost | | . . . o ..+*+| 2025-12-02 20:59:27.454088 | debian-bookworm -> localhost | | .. . . oo.+++| 2025-12-02 20:59:27.454109 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-02 20:59:27.454155 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.660382 2025-12-02 20:59:27.460295 | 2025-12-02 20:59:27.460385 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-02 20:59:27.477432 | debian-bookworm | ok 2025-12-02 20:59:27.486328 | debian-bookworm | included: /var/lib/zuul/builds/5726b4eac1654c7981c9baee92690691/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-02 20:59:27.495311 | 2025-12-02 20:59:27.495396 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-02 20:59:27.508056 | debian-bookworm | skipping: Conditional result was False 2025-12-02 20:59:27.513565 | 2025-12-02 20:59:27.513648 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-02 20:59:28.175411 | debian-bookworm | changed 2025-12-02 20:59:28.183749 | 2025-12-02 20:59:28.183896 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-02 20:59:28.439509 | debian-bookworm | ok 2025-12-02 20:59:28.445785 | 2025-12-02 20:59:28.445883 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-02 20:59:29.078660 | debian-bookworm | changed 2025-12-02 20:59:29.085198 | 2025-12-02 20:59:29.085319 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-02 20:59:29.770901 | debian-bookworm | changed 2025-12-02 20:59:29.776753 | 2025-12-02 20:59:29.776849 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-02 20:59:29.799746 | debian-bookworm | skipping: Conditional result was False 2025-12-02 20:59:29.805888 | 2025-12-02 20:59:29.805999 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-02 20:59:30.294010 | debian-bookworm -> localhost | changed 2025-12-02 20:59:30.309474 | 2025-12-02 20:59:30.309606 | TASK [add-build-sshkey : Add back temp key] 2025-12-02 20:59:30.830943 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5726b4eac1654c7981c9baee92690691/work/5726b4eac1654c7981c9baee92690691_id_rsa (zuul-build-sshkey) 2025-12-02 20:59:30.831202 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.048069 2025-12-02 20:59:30.839965 | 2025-12-02 20:59:30.840102 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-02 20:59:31.477086 | debian-bookworm | ok 2025-12-02 20:59:31.488760 | 2025-12-02 20:59:31.488911 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-02 20:59:31.534105 | debian-bookworm | skipping: Conditional result was False 2025-12-02 20:59:31.545550 | 2025-12-02 20:59:31.545681 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-02 20:59:32.048802 | debian-bookworm | ok 2025-12-02 20:59:32.063880 | 2025-12-02 20:59:32.064012 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-02 20:59:32.120767 | debian-bookworm | ok 2025-12-02 20:59:32.128162 | 2025-12-02 20:59:32.128350 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-02 20:59:32.420947 | debian-bookworm -> localhost | ok 2025-12-02 20:59:32.427911 | 2025-12-02 20:59:32.428033 | TASK [validate-host : Collect information about the host] 2025-12-02 20:59:33.646790 | debian-bookworm | ok 2025-12-02 20:59:33.659728 | 2025-12-02 20:59:33.659878 | TASK [validate-host : Sanitize hostname] 2025-12-02 20:59:33.771691 | debian-bookworm | ok 2025-12-02 20:59:33.840508 | 2025-12-02 20:59:33.840651 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-02 20:59:34.537303 | debian-bookworm -> localhost | changed 2025-12-02 20:59:34.566752 | 2025-12-02 20:59:34.566909 | TASK [validate-host : Collect information about zuul worker] 2025-12-02 20:59:35.018075 | debian-bookworm | ok 2025-12-02 20:59:35.033746 | 2025-12-02 20:59:35.033889 | TASK [validate-host : Write out all zuul information for each host] 2025-12-02 20:59:35.967078 | debian-bookworm -> localhost | changed 2025-12-02 20:59:35.986447 | 2025-12-02 20:59:35.986642 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-02 20:59:36.333367 | debian-bookworm | ok 2025-12-02 20:59:36.340557 | 2025-12-02 20:59:36.340678 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-02 20:59:37.705080 | debian-bookworm | changed: 2025-12-02 20:59:37.705328 | debian-bookworm | cd+++++++++ src/ 2025-12-02 20:59:37.705367 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-02 20:59:37.705391 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-02 20:59:37.705412 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-02 20:59:37.705432 | debian-bookworm | Containerfile 2025-12-02 20:59:37.705544 | debian-bookworm | Containerfile 2025-12-02 20:59:37.767362 | debian-bookworm | localhost | ok: Runtime: 0:00:00.016791 2025-12-02 21:00:05.696437 | 2025-12-02 21:00:05.696560 | TASK [upload-logs : Upload logs to log server] 2025-12-02 21:00:06.319014 | localhost | Output suppressed because no_log was given 2025-12-02 21:00:06.321011 | 2025-12-02 21:00:06.321120 | LOOP [upload-logs : Compress console log and json output] 2025-12-02 21:00:06.380236 | localhost | skipping: Conditional result was False 2025-12-02 21:00:06.386511 | localhost | skipping: Conditional result was False 2025-12-02 21:00:06.397863 | 2025-12-02 21:00:06.397971 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-02 21:00:06.443256 | localhost | skipping: Conditional result was False 2025-12-02 21:00:06.443604 | 2025-12-02 21:00:06.450253 | localhost | skipping: Conditional result was False 2025-12-02 21:00:06.454966 | 2025-12-02 21:00:06.455093 | LOOP [upload-logs : Upload console log and json output]