2025-05-29 03:26:58.475597 | Job console starting 2025-05-29 03:26:58.491124 | Updating git repos 2025-05-29 03:26:58.531448 | Cloning repos into workspace 2025-05-29 03:26:58.572185 | Restoring repo states 2025-05-29 03:26:58.579683 | Merging changes 2025-05-29 03:26:58.579701 | Checking out repos 2025-05-29 03:26:58.627590 | Preparing playbooks 2025-05-29 03:26:59.319651 | Running Ansible setup 2025-05-29 03:27:03.590310 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-29 03:27:04.463030 | 2025-05-29 03:27:04.463253 | PLAY [Base pre] 2025-05-29 03:27:04.485089 | 2025-05-29 03:27:04.485257 | TASK [Setup log path fact] 2025-05-29 03:27:04.515473 | debian-bookworm | ok 2025-05-29 03:27:04.530947 | 2025-05-29 03:27:04.531104 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-29 03:27:04.579403 | debian-bookworm | ok 2025-05-29 03:27:04.593901 | 2025-05-29 03:27:04.594050 | TASK [emit-job-header : Print job information] 2025-05-29 03:27:04.651837 | # Job Information 2025-05-29 03:27:04.652134 | Ansible Version: 2.16.14 2025-05-29 03:27:04.652197 | Job: python-black 2025-05-29 03:27:04.652254 | Pipeline: periodic-daily 2025-05-29 03:27:04.652294 | Executor: 521e9411259a 2025-05-29 03:27:04.652331 | Triggered by: https://github.com/osism/node-image 2025-05-29 03:27:04.652371 | Event ID: 49d8d61f1f2c4529ac5f2a973e7914ca 2025-05-29 03:27:04.660241 | 2025-05-29 03:27:04.660424 | LOOP [emit-job-header : Print node information] 2025-05-29 03:27:04.799709 | debian-bookworm | ok: 2025-05-29 03:27:04.800014 | debian-bookworm | # Node Information 2025-05-29 03:27:04.800063 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-29 03:27:04.800090 | debian-bookworm | Hostname: debian 2025-05-29 03:27:04.800112 | debian-bookworm | Username: zuul 2025-05-29 03:27:04.800133 | debian-bookworm | Distro: Debian 12.11 2025-05-29 03:27:04.800155 | debian-bookworm | Provider: regiocloud-a 2025-05-29 03:27:04.800176 | debian-bookworm | Region: 2025-05-29 03:27:04.800197 | debian-bookworm | Label: debian-bookworm 2025-05-29 03:27:04.800217 | debian-bookworm | Product Name: OpenStack Nova 2025-05-29 03:27:04.800236 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed8:b38c 2025-05-29 03:27:04.820986 | 2025-05-29 03:27:04.821132 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-29 03:27:05.363527 | debian-bookworm -> localhost | changed 2025-05-29 03:27:05.375483 | 2025-05-29 03:27:05.375664 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-29 03:27:06.488255 | debian-bookworm -> localhost | changed 2025-05-29 03:27:06.510118 | 2025-05-29 03:27:06.510280 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-29 03:27:06.821320 | debian-bookworm -> localhost | ok 2025-05-29 03:27:06.827904 | 2025-05-29 03:27:06.828024 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-29 03:27:06.857260 | debian-bookworm | ok 2025-05-29 03:27:06.874889 | debian-bookworm | included: /var/lib/zuul/builds/a89b19be028e4b14adf33c6a4369d15a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-29 03:27:06.881458 | 2025-05-29 03:27:06.881561 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-29 03:27:08.277742 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-29 03:27:08.278368 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a89b19be028e4b14adf33c6a4369d15a/work/a89b19be028e4b14adf33c6a4369d15a_id_rsa 2025-05-29 03:27:08.278497 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a89b19be028e4b14adf33c6a4369d15a/work/a89b19be028e4b14adf33c6a4369d15a_id_rsa.pub 2025-05-29 03:27:08.278567 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-29 03:27:08.278630 | debian-bookworm -> localhost | SHA256:AnL6jwrJccdOQPSN6VZNzwdw6v0lAjW6S/Fukq9oeNI zuul-build-sshkey 2025-05-29 03:27:08.278687 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-29 03:27:08.278766 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-29 03:27:08.278895 | debian-bookworm -> localhost | | .o o.= | 2025-05-29 03:27:08.278959 | debian-bookworm -> localhost | | . . + o B o | 2025-05-29 03:27:08.279013 | debian-bookworm -> localhost | | ..o+ o * o . | 2025-05-29 03:27:08.279066 | debian-bookworm -> localhost | | ++.. . * . | 2025-05-29 03:27:08.279119 | debian-bookworm -> localhost | | ... *. S+ + . . | 2025-05-29 03:27:08.279191 | debian-bookworm -> localhost | |..o.= .. + o o | 2025-05-29 03:27:08.279246 | debian-bookworm -> localhost | |o. ..o + o . | 2025-05-29 03:27:08.279300 | debian-bookworm -> localhost | | . = E. + | 2025-05-29 03:27:08.279354 | debian-bookworm -> localhost | | ... =. ... | 2025-05-29 03:27:08.279468 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-29 03:27:08.279605 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.833629 2025-05-29 03:27:08.291274 | 2025-05-29 03:27:08.291520 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-29 03:27:08.334067 | debian-bookworm | ok 2025-05-29 03:27:08.344318 | debian-bookworm | included: /var/lib/zuul/builds/a89b19be028e4b14adf33c6a4369d15a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-29 03:27:08.353512 | 2025-05-29 03:27:08.353612 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-29 03:27:08.379207 | debian-bookworm | skipping: Conditional result was False 2025-05-29 03:27:08.385620 | 2025-05-29 03:27:08.385724 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-29 03:27:09.056434 | debian-bookworm | changed 2025-05-29 03:27:09.062465 | 2025-05-29 03:27:09.062589 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-29 03:27:09.330967 | debian-bookworm | ok 2025-05-29 03:27:09.336838 | 2025-05-29 03:27:09.336948 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-29 03:27:09.970490 | debian-bookworm | changed 2025-05-29 03:27:09.981050 | 2025-05-29 03:27:09.981182 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-29 03:27:10.672729 | debian-bookworm | changed 2025-05-29 03:27:10.680360 | 2025-05-29 03:27:10.680519 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-29 03:27:10.705485 | debian-bookworm | skipping: Conditional result was False 2025-05-29 03:27:10.716251 | 2025-05-29 03:27:10.716620 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-29 03:27:11.182271 | debian-bookworm -> localhost | changed 2025-05-29 03:27:11.202256 | 2025-05-29 03:27:11.202450 | TASK [add-build-sshkey : Add back temp key] 2025-05-29 03:27:11.557174 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a89b19be028e4b14adf33c6a4369d15a/work/a89b19be028e4b14adf33c6a4369d15a_id_rsa (zuul-build-sshkey) 2025-05-29 03:27:11.557727 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016466 2025-05-29 03:27:11.568850 | 2025-05-29 03:27:11.568983 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-29 03:27:11.982175 | debian-bookworm | ok 2025-05-29 03:27:11.991027 | 2025-05-29 03:27:11.991190 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-29 03:27:12.017640 | debian-bookworm | skipping: Conditional result was False 2025-05-29 03:27:12.038187 | 2025-05-29 03:27:12.038349 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-29 03:27:12.471918 | debian-bookworm | ok 2025-05-29 03:27:12.488019 | 2025-05-29 03:27:12.488162 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-29 03:27:12.530890 | debian-bookworm | ok 2025-05-29 03:27:12.539212 | 2025-05-29 03:27:12.539360 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-29 03:27:12.909142 | debian-bookworm -> localhost | ok 2025-05-29 03:27:12.924792 | 2025-05-29 03:27:12.924995 | TASK [validate-host : Collect information about the host] 2025-05-29 03:27:14.131031 | debian-bookworm | ok 2025-05-29 03:27:14.148033 | 2025-05-29 03:27:14.148171 | TASK [validate-host : Sanitize hostname] 2025-05-29 03:27:14.270345 | debian-bookworm | ok 2025-05-29 03:27:14.342557 | 2025-05-29 03:27:14.342725 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-29 03:27:14.986692 | debian-bookworm -> localhost | changed 2025-05-29 03:27:14.993774 | 2025-05-29 03:27:14.993896 | TASK [validate-host : Collect information about zuul worker] 2025-05-29 03:27:15.482422 | debian-bookworm | ok 2025-05-29 03:27:15.493791 | 2025-05-29 03:27:15.497075 | TASK [validate-host : Write out all zuul information for each host] 2025-05-29 03:27:16.143248 | debian-bookworm -> localhost | changed 2025-05-29 03:27:16.163483 | 2025-05-29 03:27:16.163666 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-29 03:27:16.446021 | debian-bookworm | ok 2025-05-29 03:27:16.456646 | 2025-05-29 03:27:16.456776 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-29 03:27:18.159502 | debian-bookworm | changed: 2025-05-29 03:27:18.159785 | debian-bookworm | cd+++++++++ src/ 2025-05-29 03:27:18.159843 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-29 03:27:18.159881 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-29 03:27:18.159918 | debian-bookworm | cd+++++++++ src/github.com/osism/node-image/ 2025-05-29 03:27:18.159955 | debian-bookworm | Containerfile 2025-05-29 03:27:18.160184 | debian-bookworm | localhost | ok: Runtime: 0:00:00.026544 2025-05-29 03:27:44.696837 | 2025-05-29 03:27:44.697032 | TASK [upload-logs : Upload logs to log server] 2025-05-29 03:27:46.337422 | localhost | Output suppressed because no_log was given 2025-05-29 03:27:46.341079 | 2025-05-29 03:27:46.341219 | LOOP [upload-logs : Compress console log and json output] 2025-05-29 03:27:46.436567 | localhost | skipping: Conditional result was False 2025-05-29 03:27:46.443017 | localhost | skipping: Conditional result was False 2025-05-29 03:27:46.451960 | 2025-05-29 03:27:46.452249 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-29 03:27:46.553694 | localhost | skipping: Conditional result was False 2025-05-29 03:27:46.554019 | 2025-05-29 03:27:46.561368 | localhost | skipping: Conditional result was False 2025-05-29 03:27:46.574993 | 2025-05-29 03:27:46.575131 | LOOP [upload-logs : Upload console log and json output]