2025-05-13 12:02:18.324193 | Job console starting 2025-05-13 12:02:18.354254 | Updating git repos 2025-05-13 12:02:18.403242 | Cloning repos into workspace 2025-05-13 12:02:18.489238 | Restoring repo states 2025-05-13 12:02:18.515178 | Merging changes 2025-05-13 12:02:18.515205 | Checking out repos 2025-05-13 12:02:18.603568 | Preparing playbooks 2025-05-13 12:02:20.104125 | Running Ansible setup 2025-05-13 12:02:27.044335 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-13 12:02:27.824921 | 2025-05-13 12:02:27.825085 | PLAY [Base pre] 2025-05-13 12:02:27.843317 | 2025-05-13 12:02:27.843489 | TASK [Setup log path fact] 2025-05-13 12:02:27.875150 | ubuntu-noble | ok 2025-05-13 12:02:27.893760 | 2025-05-13 12:02:27.893931 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-13 12:02:27.925633 | ubuntu-noble | ok 2025-05-13 12:02:27.939464 | 2025-05-13 12:02:27.939610 | TASK [emit-job-header : Print job information] 2025-05-13 12:02:27.990791 | # Job Information 2025-05-13 12:02:27.991118 | Ansible Version: 2.16.14 2025-05-13 12:02:27.991164 | Job: python-black 2025-05-13 12:02:27.991198 | Pipeline: periodic-daily 2025-05-13 12:02:27.991222 | Executor: 521e9411259a 2025-05-13 12:02:27.991243 | Triggered by: https://github.com/osism/node-image 2025-05-13 12:02:27.991266 | Event ID: 3a38d3e1091347cd8255861859c65b6e 2025-05-13 12:02:27.997150 | 2025-05-13 12:02:27.997317 | LOOP [emit-job-header : Print node information] 2025-05-13 12:02:28.163289 | ubuntu-noble | ok: 2025-05-13 12:02:28.163614 | ubuntu-noble | # Node Information 2025-05-13 12:02:28.163652 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-05-13 12:02:28.163677 | ubuntu-noble | Hostname: ubuntu 2025-05-13 12:02:28.163700 | ubuntu-noble | Username: zuul 2025-05-13 12:02:28.163721 | ubuntu-noble | Distro: Ubuntu 24.04 2025-05-13 12:02:28.163746 | ubuntu-noble | Provider: regiocloud-a 2025-05-13 12:02:28.163766 | ubuntu-noble | Region: 2025-05-13 12:02:28.163787 | ubuntu-noble | Label: ubuntu-noble 2025-05-13 12:02:28.163808 | ubuntu-noble | Product Name: OpenStack Nova 2025-05-13 12:02:28.163828 | ubuntu-noble | Interface IP: 81.163.192.131 2025-05-13 12:02:28.189774 | 2025-05-13 12:02:28.190075 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-13 12:02:29.200331 | ubuntu-noble -> localhost | changed 2025-05-13 12:02:29.208800 | 2025-05-13 12:02:29.208972 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-13 12:02:31.030032 | ubuntu-noble -> localhost | changed 2025-05-13 12:02:31.047424 | 2025-05-13 12:02:31.047740 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-13 12:02:31.574223 | ubuntu-noble -> localhost | ok 2025-05-13 12:02:31.580737 | 2025-05-13 12:02:31.580861 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-13 12:02:31.641075 | ubuntu-noble | ok 2025-05-13 12:02:31.685659 | ubuntu-noble | included: /var/lib/zuul/builds/b899b6f2a3134030b401a072b81b34ff/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-13 12:02:31.707755 | 2025-05-13 12:02:31.707912 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-13 12:02:34.639229 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-05-13 12:02:34.639646 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/b899b6f2a3134030b401a072b81b34ff/work/b899b6f2a3134030b401a072b81b34ff_id_rsa 2025-05-13 12:02:34.639784 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/b899b6f2a3134030b401a072b81b34ff/work/b899b6f2a3134030b401a072b81b34ff_id_rsa.pub 2025-05-13 12:02:34.639818 | ubuntu-noble -> localhost | The key fingerprint is: 2025-05-13 12:02:34.639845 | ubuntu-noble -> localhost | SHA256:VscQvrr08lmFfW7wLdEqz6u9mJek/iFLR9rSxK+KTKU zuul-build-sshkey 2025-05-13 12:02:34.639869 | ubuntu-noble -> localhost | The key's randomart image is: 2025-05-13 12:02:34.639929 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-05-13 12:02:34.639970 | ubuntu-noble -> localhost | | o. | 2025-05-13 12:02:34.639995 | ubuntu-noble -> localhost | | . o | 2025-05-13 12:02:34.640017 | ubuntu-noble -> localhost | | o o | 2025-05-13 12:02:34.640092 | ubuntu-noble -> localhost | | . o + . | 2025-05-13 12:02:34.640117 | ubuntu-noble -> localhost | | S . o O o| 2025-05-13 12:02:34.640147 | ubuntu-noble -> localhost | | . . o B.O.| 2025-05-13 12:02:34.640169 | ubuntu-noble -> localhost | | o E BoB.*| 2025-05-13 12:02:34.640190 | ubuntu-noble -> localhost | | ..= =.%o= | 2025-05-13 12:02:34.640212 | ubuntu-noble -> localhost | | .o*.B=Oo | 2025-05-13 12:02:34.640234 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-05-13 12:02:34.640305 | ubuntu-noble -> localhost | ok: Runtime: 0:00:01.735412 2025-05-13 12:02:34.650119 | 2025-05-13 12:02:34.650270 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-13 12:02:34.732940 | ubuntu-noble | ok 2025-05-13 12:02:34.761616 | ubuntu-noble | included: /var/lib/zuul/builds/b899b6f2a3134030b401a072b81b34ff/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-13 12:02:34.775178 | 2025-05-13 12:02:34.775399 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-13 12:02:34.801725 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:02:34.814362 | 2025-05-13 12:02:34.814613 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-13 12:02:36.158256 | ubuntu-noble | changed 2025-05-13 12:02:36.300929 | 2025-05-13 12:02:36.301344 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-13 12:02:36.696002 | ubuntu-noble | ok 2025-05-13 12:02:36.709022 | 2025-05-13 12:02:36.709173 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-13 12:02:37.530183 | ubuntu-noble | changed 2025-05-13 12:02:37.537023 | 2025-05-13 12:02:37.537138 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-13 12:02:38.290378 | ubuntu-noble | changed 2025-05-13 12:02:38.302642 | 2025-05-13 12:02:38.302752 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-13 12:02:38.356241 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:02:38.366306 | 2025-05-13 12:02:38.366492 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-13 12:02:39.242330 | ubuntu-noble -> localhost | changed 2025-05-13 12:02:39.261662 | 2025-05-13 12:02:39.262109 | TASK [add-build-sshkey : Add back temp key] 2025-05-13 12:02:39.890205 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/b899b6f2a3134030b401a072b81b34ff/work/b899b6f2a3134030b401a072b81b34ff_id_rsa (zuul-build-sshkey) 2025-05-13 12:02:39.890476 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.042552 2025-05-13 12:02:39.896463 | 2025-05-13 12:02:39.896554 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-13 12:02:40.544213 | ubuntu-noble | ok 2025-05-13 12:02:40.573977 | 2025-05-13 12:02:40.575402 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-13 12:02:40.723349 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:02:40.747853 | 2025-05-13 12:02:40.747976 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-13 12:02:41.269683 | ubuntu-noble | ok 2025-05-13 12:02:41.315257 | 2025-05-13 12:02:41.315850 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-13 12:02:41.431229 | ubuntu-noble | ok 2025-05-13 12:02:41.446812 | 2025-05-13 12:02:41.446966 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-13 12:02:42.285110 | ubuntu-noble -> localhost | ok 2025-05-13 12:02:42.292489 | 2025-05-13 12:02:42.292644 | TASK [validate-host : Collect information about the host] 2025-05-13 12:02:44.149404 | ubuntu-noble | ok 2025-05-13 12:02:44.179774 | 2025-05-13 12:02:44.179901 | TASK [validate-host : Sanitize hostname] 2025-05-13 12:02:44.360674 | ubuntu-noble | ok 2025-05-13 12:02:44.365200 | 2025-05-13 12:02:44.365301 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-13 12:02:45.817513 | ubuntu-noble -> localhost | changed 2025-05-13 12:02:45.822410 | 2025-05-13 12:02:45.822497 | TASK [validate-host : Collect information about zuul worker] 2025-05-13 12:02:46.627455 | ubuntu-noble | ok 2025-05-13 12:02:46.633177 | 2025-05-13 12:02:46.633258 | TASK [validate-host : Write out all zuul information for each host] 2025-05-13 12:02:47.608630 | ubuntu-noble -> localhost | changed 2025-05-13 12:02:47.661969 | 2025-05-13 12:02:47.662071 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-13 12:02:47.961054 | ubuntu-noble | ok 2025-05-13 12:02:47.965373 | 2025-05-13 12:02:47.965454 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-13 12:02:49.919405 | ubuntu-noble | changed: 2025-05-13 12:02:49.919591 | ubuntu-noble | cd+++++++++ src/ 2025-05-13 12:02:49.919624 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-05-13 12:02:49.919649 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-05-13 12:02:49.919670 | ubuntu-noble | cd+++++++++ src/github.com/osism/node-image/ 2025-05-13 12:02:49.919691 | ubuntu-noble | Containerfile 2025-05-13 12:02:49.919843 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.018858 2025-05-13 12:03:21.767465 | 2025-05-13 12:03:21.767556 | TASK [upload-logs : Upload logs to log server] 2025-05-13 12:03:22.654664 | localhost | Output suppressed because no_log was given 2025-05-13 12:03:22.656207 | 2025-05-13 12:03:22.656289 | LOOP [upload-logs : Compress console log and json output] 2025-05-13 12:03:22.744448 | localhost | skipping: Conditional result was False 2025-05-13 12:03:22.757032 | localhost | skipping: Conditional result was False 2025-05-13 12:03:22.763570 | 2025-05-13 12:03:22.763682 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-13 12:03:22.856799 | localhost | skipping: Conditional result was False 2025-05-13 12:03:22.857032 | 2025-05-13 12:03:22.888086 | localhost | skipping: Conditional result was False 2025-05-13 12:03:22.891645 | 2025-05-13 12:03:22.891757 | LOOP [upload-logs : Upload console log and json output]