2025-06-02 03:04:15.409190 | Job console starting 2025-06-02 03:04:15.420063 | Updating git repos 2025-06-02 03:04:15.449768 | Cloning repos into workspace 2025-06-02 03:04:15.501383 | Restoring repo states 2025-06-02 03:04:15.521432 | Merging changes 2025-06-02 03:04:15.521448 | Checking out repos 2025-06-02 03:04:15.579385 | Preparing playbooks 2025-06-02 03:04:16.627605 | Running Ansible setup 2025-06-02 03:04:22.307023 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-02 03:04:23.165776 | 2025-06-02 03:04:23.166016 | PLAY [Base pre] 2025-06-02 03:04:23.200580 | 2025-06-02 03:04:23.200892 | TASK [Setup log path fact] 2025-06-02 03:04:23.233445 | debian-bookworm | ok 2025-06-02 03:04:23.250203 | 2025-06-02 03:04:23.250368 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-02 03:04:23.283929 | debian-bookworm | ok 2025-06-02 03:04:23.294492 | 2025-06-02 03:04:23.294611 | TASK [emit-job-header : Print job information] 2025-06-02 03:04:23.335174 | # Job Information 2025-06-02 03:04:23.335359 | Ansible Version: 2.16.14 2025-06-02 03:04:23.335395 | Job: python-black 2025-06-02 03:04:23.335427 | Pipeline: periodic-daily 2025-06-02 03:04:23.335451 | Executor: 521e9411259a 2025-06-02 03:04:23.335471 | Triggered by: https://github.com/osism/netbox-plugin-osism 2025-06-02 03:04:23.335493 | Event ID: cf6fae4a043d4a28ad27caa610559348 2025-06-02 03:04:23.340435 | 2025-06-02 03:04:23.340540 | LOOP [emit-job-header : Print node information] 2025-06-02 03:04:23.468281 | debian-bookworm | ok: 2025-06-02 03:04:23.468617 | debian-bookworm | # Node Information 2025-06-02 03:04:23.468659 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-02 03:04:23.468685 | debian-bookworm | Hostname: debian 2025-06-02 03:04:23.468707 | debian-bookworm | Username: zuul 2025-06-02 03:04:23.468729 | debian-bookworm | Distro: Debian 12.11 2025-06-02 03:04:23.468753 | debian-bookworm | Provider: regiocloud-a 2025-06-02 03:04:23.468774 | debian-bookworm | Region: 2025-06-02 03:04:23.468796 | debian-bookworm | Label: debian-bookworm 2025-06-02 03:04:23.468824 | debian-bookworm | Product Name: OpenStack Nova 2025-06-02 03:04:23.468870 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe27:6af3 2025-06-02 03:04:23.490525 | 2025-06-02 03:04:23.490658 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-02 03:04:24.041587 | debian-bookworm -> localhost | changed 2025-06-02 03:04:24.049392 | 2025-06-02 03:04:24.049519 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-02 03:04:25.136323 | debian-bookworm -> localhost | changed 2025-06-02 03:04:25.154411 | 2025-06-02 03:04:25.154616 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-02 03:04:25.474296 | debian-bookworm -> localhost | ok 2025-06-02 03:04:25.487271 | 2025-06-02 03:04:25.487451 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-02 03:04:25.522438 | debian-bookworm | ok 2025-06-02 03:04:25.544116 | debian-bookworm | included: /var/lib/zuul/builds/a8146ea562f64689b1f8eaf309d4032c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-02 03:04:25.550543 | 2025-06-02 03:04:25.550644 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-02 03:04:27.403194 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-02 03:04:27.403645 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a8146ea562f64689b1f8eaf309d4032c/work/a8146ea562f64689b1f8eaf309d4032c_id_rsa 2025-06-02 03:04:27.403711 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a8146ea562f64689b1f8eaf309d4032c/work/a8146ea562f64689b1f8eaf309d4032c_id_rsa.pub 2025-06-02 03:04:27.403755 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-02 03:04:27.403796 | debian-bookworm -> localhost | SHA256:ONu5H9GYTYHDkXCleAA/5pZsXnxTFNRGmdpVqeX9rUU zuul-build-sshkey 2025-06-02 03:04:27.403856 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-02 03:04:27.403914 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-02 03:04:27.403952 | debian-bookworm -> localhost | | ..ooo=o.++B| 2025-06-02 03:04:27.403987 | debian-bookworm -> localhost | | . +=. o =+| 2025-06-02 03:04:27.404020 | debian-bookworm -> localhost | | = o.. B.o| 2025-06-02 03:04:27.404053 | debian-bookworm -> localhost | | = = * + oE| 2025-06-02 03:04:27.404085 | debian-bookworm -> localhost | | o S * = .o| 2025-06-02 03:04:27.404120 | debian-bookworm -> localhost | | B o o . +| 2025-06-02 03:04:27.404153 | debian-bookworm -> localhost | | . + . o | 2025-06-02 03:04:27.404184 | debian-bookworm -> localhost | | . . . | 2025-06-02 03:04:27.404218 | debian-bookworm -> localhost | | ... | 2025-06-02 03:04:27.404250 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-02 03:04:27.404360 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.331847 2025-06-02 03:04:27.413918 | 2025-06-02 03:04:27.414089 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-02 03:04:27.445971 | debian-bookworm | ok 2025-06-02 03:04:27.457084 | debian-bookworm | included: /var/lib/zuul/builds/a8146ea562f64689b1f8eaf309d4032c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-02 03:04:27.467396 | 2025-06-02 03:04:27.467561 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-02 03:04:27.492685 | debian-bookworm | skipping: Conditional result was False 2025-06-02 03:04:27.499586 | 2025-06-02 03:04:27.499730 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-02 03:04:28.192143 | debian-bookworm | changed 2025-06-02 03:04:28.201303 | 2025-06-02 03:04:28.201527 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-02 03:04:28.485536 | debian-bookworm | ok 2025-06-02 03:04:28.491395 | 2025-06-02 03:04:28.491514 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-02 03:04:29.140814 | debian-bookworm | changed 2025-06-02 03:04:29.148709 | 2025-06-02 03:04:29.148845 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-02 03:04:29.851310 | debian-bookworm | changed 2025-06-02 03:04:29.859653 | 2025-06-02 03:04:29.859775 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-02 03:04:29.885176 | debian-bookworm | skipping: Conditional result was False 2025-06-02 03:04:29.896560 | 2025-06-02 03:04:29.897924 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-02 03:04:30.397063 | debian-bookworm -> localhost | changed 2025-06-02 03:04:30.416074 | 2025-06-02 03:04:30.416222 | TASK [add-build-sshkey : Add back temp key] 2025-06-02 03:04:30.949283 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a8146ea562f64689b1f8eaf309d4032c/work/a8146ea562f64689b1f8eaf309d4032c_id_rsa (zuul-build-sshkey) 2025-06-02 03:04:30.949651 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025908 2025-06-02 03:04:30.963877 | 2025-06-02 03:04:30.964061 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-02 03:04:31.440595 | debian-bookworm | ok 2025-06-02 03:04:31.446166 | 2025-06-02 03:04:31.446300 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-02 03:04:31.477014 | debian-bookworm | skipping: Conditional result was False 2025-06-02 03:04:31.493375 | 2025-06-02 03:04:31.493591 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-02 03:04:31.981301 | debian-bookworm | ok 2025-06-02 03:04:32.009826 | 2025-06-02 03:04:32.010140 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-02 03:04:32.056064 | debian-bookworm | ok 2025-06-02 03:04:32.066010 | 2025-06-02 03:04:32.066267 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-02 03:04:32.461121 | debian-bookworm -> localhost | ok 2025-06-02 03:04:32.469066 | 2025-06-02 03:04:32.469190 | TASK [validate-host : Collect information about the host] 2025-06-02 03:04:33.605473 | debian-bookworm | ok 2025-06-02 03:04:33.620397 | 2025-06-02 03:04:33.620658 | TASK [validate-host : Sanitize hostname] 2025-06-02 03:04:33.766134 | debian-bookworm | ok 2025-06-02 03:04:33.826938 | 2025-06-02 03:04:33.827080 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-02 03:04:34.844676 | debian-bookworm -> localhost | changed 2025-06-02 03:04:34.851588 | 2025-06-02 03:04:34.851730 | TASK [validate-host : Collect information about zuul worker] 2025-06-02 03:04:35.301235 | debian-bookworm | ok 2025-06-02 03:04:35.319400 | 2025-06-02 03:04:35.320583 | TASK [validate-host : Write out all zuul information for each host] 2025-06-02 03:04:36.108395 | debian-bookworm -> localhost | changed 2025-06-02 03:04:36.125779 | 2025-06-02 03:04:36.126029 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-02 03:04:36.400740 | debian-bookworm | ok 2025-06-02 03:04:36.406896 | 2025-06-02 03:04:36.407014 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-02 03:04:37.218476 | debian-bookworm | changed: 2025-06-02 03:04:37.218696 | debian-bookworm | cd+++++++++ src/ 2025-06-02 03:04:37.218734 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-02 03:04:37.218762 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-02 03:04:37.218787 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-plugin-osism/ 2025-06-02 03:04:37.218810 | debian-bookworm | localhost | ok: Runtime: 0:00:00.003913 2025-06-02 03:05:02.797372 | 2025-06-02 03:05:02.797470 | TASK [upload-logs : Upload logs to log server] 2025-06-02 03:05:03.311581 | localhost | Output suppressed because no_log was given 2025-06-02 03:05:03.315656 | 2025-06-02 03:05:03.315877 | LOOP [upload-logs : Compress console log and json output] 2025-06-02 03:05:03.361196 | localhost | skipping: Conditional result was False 2025-06-02 03:05:03.368410 | localhost | skipping: Conditional result was False 2025-06-02 03:05:03.375650 | 2025-06-02 03:05:03.375817 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-02 03:05:03.417499 | localhost | skipping: Conditional result was False 2025-06-02 03:05:03.417760 | 2025-06-02 03:05:03.424252 | localhost | skipping: Conditional result was False 2025-06-02 03:05:03.432968 | 2025-06-02 03:05:03.433086 | LOOP [upload-logs : Upload console log and json output]