2026-03-20 00:12:26.152880 | Job console starting... 2026-03-20 00:12:26.166209 | Updating repositories 2026-03-20 00:12:26.244760 | Preparing job workspace 2026-03-20 00:12:31.740948 | Running Ansible setup... 2026-03-20 00:12:37.885919 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-03-20 00:12:38.604965 | 2026-03-20 00:12:38.605135 | PLAY [localhost] 2026-03-20 00:12:38.615134 | 2026-03-20 00:12:38.615216 | TASK [Gathering Facts] 2026-03-20 00:12:39.646613 | localhost | ok 2026-03-20 00:12:39.669631 | 2026-03-20 00:12:39.669973 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-20 00:12:40.182310 | localhost -> localhost | changed 2026-03-20 00:12:40.194137 | 2026-03-20 00:12:40.194362 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-20 00:12:41.100557 | localhost -> localhost | changed 2026-03-20 00:12:41.111470 | 2026-03-20 00:12:41.111567 | TASK [Setup log path fact] 2026-03-20 00:12:41.132094 | localhost | ok 2026-03-20 00:12:41.147623 | 2026-03-20 00:12:41.147801 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-20 00:12:41.179239 | localhost | ok 2026-03-20 00:12:41.191274 | 2026-03-20 00:12:41.191432 | TASK [emit-job-header : Print job information] 2026-03-20 00:12:41.235084 | # Job Information 2026-03-20 00:12:41.235306 | Ansible Version: 2.15.12 2026-03-20 00:12:41.235334 | Job: validate-buildsys-tags-dalmatian-testing-tcib-container-build-scenario000-centos9 2026-03-20 00:12:41.235653 | Pipeline: check 2026-03-20 00:12:41.235718 | Executor: ze04.softwarefactory-project.io 2026-03-20 00:12:41.235742 | Triggered by: https://review.rdoproject.org/r/c/rdoinfo/+/58620 2026-03-20 00:12:41.235762 | Log URL (when completed): https://logserver.rdoproject.org/63f/rdoproject.org/63f396f24e204d0aa44457cde5e5a6e7/ 2026-03-20 00:12:41.235780 | Event ID: 71a2c27a370e432dab519d5a4334ba2f 2026-03-20 00:12:41.240701 | 2026-03-20 00:12:41.240795 | LOOP [emit-job-header : Print node information] 2026-03-20 00:12:41.353778 | localhost | ok: 2026-03-20 00:12:41.354057 | localhost | # Node Information 2026-03-20 00:12:41.354086 | localhost | Inventory Hostname: primary 2026-03-20 00:12:41.354110 | localhost | Hostname: np0005652516 2026-03-20 00:12:41.354130 | localhost | Username: zuul 2026-03-20 00:12:41.354152 | localhost | Distro: CentOS 9 2026-03-20 00:12:41.354171 | localhost | Provider: vexxhost-nodepool-tripleo 2026-03-20 00:12:41.354188 | localhost | Region: RegionOne 2026-03-20 00:12:41.354205 | localhost | Label: cloud-centos-9-stream-tripleo-vexxhost 2026-03-20 00:12:41.354221 | localhost | Product Name: OpenStack Nova 2026-03-20 00:12:41.354239 | localhost | Interface IP: 38.102.83.192 2026-03-20 00:12:41.385557 | 2026-03-20 00:12:41.385723 | PLAY [all] 2026-03-20 00:12:41.393197 | 2026-03-20 00:12:41.393278 | TASK [Gather network facts] 2026-03-20 00:12:41.882105 | primary | ok 2026-03-20 00:12:41.912156 | 2026-03-20 00:12:41.912268 | TASK [include_role : start-zuul-console] 2026-03-20 00:12:41.932628 | primary | ok 2026-03-20 00:12:41.949412 | 2026-03-20 00:12:41.949545 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-20 00:12:42.384448 | primary | ok 2026-03-20 00:12:42.399153 | 2026-03-20 00:12:42.399270 | TASK [include_role : add-build-sshkey] 2026-03-20 00:12:42.427229 | primary | ok 2026-03-20 00:12:42.450230 | 2026-03-20 00:12:42.450365 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-20 00:12:42.761007 | primary -> localhost | ok 2026-03-20 00:12:42.768071 | 2026-03-20 00:12:42.768176 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-20 00:12:42.804091 | primary | ok 2026-03-20 00:12:42.819770 | primary | included: /var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-20 00:12:42.826240 | 2026-03-20 00:12:42.826327 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-20 00:12:43.481356 | primary -> localhost | Generating public/private rsa key pair. 2026-03-20 00:12:43.481606 | primary -> localhost | Your identification has been saved in /var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/work/63f396f24e204d0aa44457cde5e5a6e7_id_rsa. 2026-03-20 00:12:43.481638 | primary -> localhost | Your public key has been saved in /var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/work/63f396f24e204d0aa44457cde5e5a6e7_id_rsa.pub. 2026-03-20 00:12:43.481660 | primary -> localhost | The key fingerprint is: 2026-03-20 00:12:43.481702 | primary -> localhost | SHA256:tpjHoYLKQet0+pCyemevsavRt+tS0yfSBPHmA/l9mkM zuul-build-sshkey 2026-03-20 00:12:43.481730 | primary -> localhost | The key's randomart image is: 2026-03-20 00:12:43.481749 | primary -> localhost | +---[RSA 3072]----+ 2026-03-20 00:12:43.481766 | primary -> localhost | | .. | 2026-03-20 00:12:43.481784 | primary -> localhost | | .o | 2026-03-20 00:12:43.481801 | primary -> localhost | | o.o | 2026-03-20 00:12:43.481819 | primary -> localhost | | =.. | 2026-03-20 00:12:43.481836 | primary -> localhost | | . +S E . | 2026-03-20 00:12:43.481853 | primary -> localhost | |. oo +*+=.+ | 2026-03-20 00:12:43.481870 | primary -> localhost | |.*o.+.=o+o+ | 2026-03-20 00:12:43.481889 | primary -> localhost | |=o*.+= o . | 2026-03-20 00:12:43.481907 | primary -> localhost | |==o=+*=. | 2026-03-20 00:12:43.481924 | primary -> localhost | +----[SHA256]-----+ 2026-03-20 00:12:43.481975 | primary -> localhost | ok: Runtime: 0:00:00.112906 2026-03-20 00:12:43.489416 | 2026-03-20 00:12:43.489497 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-20 00:12:43.520774 | primary | ok 2026-03-20 00:12:43.534936 | primary | included: /var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-20 00:12:43.544165 | 2026-03-20 00:12:43.544244 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-20 00:12:43.568706 | primary | skipping: Conditional result was False 2026-03-20 00:12:43.575103 | 2026-03-20 00:12:43.575167 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-20 00:12:44.090789 | primary | changed 2026-03-20 00:12:44.103259 | 2026-03-20 00:12:44.104050 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-20 00:12:44.356065 | primary | ok 2026-03-20 00:12:44.365672 | 2026-03-20 00:12:44.365839 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-20 00:12:45.170705 | primary | changed 2026-03-20 00:12:45.178955 | 2026-03-20 00:12:45.179247 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-20 00:12:45.969174 | primary | changed 2026-03-20 00:12:45.980056 | 2026-03-20 00:12:45.980187 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-20 00:12:46.017159 | primary | skipping: Conditional result was False 2026-03-20 00:12:46.027238 | 2026-03-20 00:12:46.027404 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-20 00:12:46.461157 | primary -> localhost | changed 2026-03-20 00:12:46.473245 | 2026-03-20 00:12:46.473360 | TASK [add-build-sshkey : Add back temp key] 2026-03-20 00:12:46.801905 | primary -> localhost | Identity added: /var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/work/63f396f24e204d0aa44457cde5e5a6e7_id_rsa (zuul-build-sshkey) 2026-03-20 00:12:46.802191 | primary -> localhost | ok: Runtime: 0:00:00.011941 2026-03-20 00:12:46.810656 | 2026-03-20 00:12:46.810797 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-20 00:12:47.238911 | primary | ok 2026-03-20 00:12:47.245895 | 2026-03-20 00:12:47.245997 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-20 00:12:47.281957 | primary | skipping: Conditional result was False 2026-03-20 00:12:47.299114 | 2026-03-20 00:12:47.299269 | TASK [include_role : validate-host] 2026-03-20 00:12:47.331543 | primary | ok 2026-03-20 00:12:47.359665 | 2026-03-20 00:12:47.360125 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-20 00:12:47.393169 | primary | ok 2026-03-20 00:12:47.408091 | 2026-03-20 00:12:47.408292 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-20 00:12:47.722334 | primary -> localhost | ok 2026-03-20 00:12:47.775542 | 2026-03-20 00:12:47.775712 | TASK [validate-host : Collect information about the host] 2026-03-20 00:12:48.477970 | primary | ok 2026-03-20 00:12:48.488277 | 2026-03-20 00:12:48.488389 | TASK [validate-host : Sanitize hostname] 2026-03-20 00:12:48.541719 | primary | ok 2026-03-20 00:12:48.549941 | 2026-03-20 00:12:48.550064 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-20 00:12:49.085797 | primary -> localhost | changed 2026-03-20 00:12:49.093223 | 2026-03-20 00:12:49.093356 | TASK [validate-host : Collect information about zuul worker] 2026-03-20 00:12:49.506671 | primary | ok 2026-03-20 00:12:49.521187 | 2026-03-20 00:12:49.521420 | TASK [validate-host : Write out all zuul information for each host] 2026-03-20 00:12:50.151225 | primary -> localhost | changed 2026-03-20 00:12:50.166791 | 2026-03-20 00:12:50.166892 | TASK [include_role : prepare-workspace-openshift] 2026-03-20 00:12:50.181116 | primary | skipping: Conditional result was False 2026-03-20 00:12:50.187730 | 2026-03-20 00:12:50.187822 | TASK [include_role : remove-zuul-sshkey] 2026-03-20 00:12:50.207239 | primary | skipping: Conditional result was False 2026-03-20 00:12:50.216540 | 2026-03-20 00:12:50.216707 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-20 00:12:50.517161 | primary | ok: "logs" 2026-03-20 00:12:50.517523 | primary | ok: All items complete 2026-03-20 00:12:50.517563 | 2026-03-20 00:12:50.745755 | primary | ok: "artifacts" 2026-03-20 00:12:50.952113 | primary | ok: "docs" 2026-03-20 00:12:50.967870 | 2026-03-20 00:12:50.968021 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-20 00:12:51.233730 | primary | changed: "logs" 2026-03-20 00:12:51.475803 | primary | changed: "artifacts" 2026-03-20 00:12:51.715635 | primary | changed: "docs" 2026-03-20 00:12:51.764142 | 2026-03-20 00:12:51.764314 | PLAY RECAP 2026-03-20 00:12:51.764376 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-20 00:12:51.764410 | primary | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-03-20 00:12:51.764430 | 2026-03-20 00:12:51.969943 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-03-20 00:12:51.971576 | PRE-RUN START: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master] 2026-03-20 00:12:52.631723 | 2026-03-20 00:12:52.631873 | PLAY [localhost] 2026-03-20 00:12:52.649507 | 2026-03-20 00:12:52.649602 | TASK [configure-ssh-config-fips : Ensure ssh config directory] 2026-03-20 00:12:53.200099 | localhost | ok 2026-03-20 00:12:53.210327 | 2026-03-20 00:12:53.210545 | TASK [configure-ssh-config-fips : Setup ssh config] 2026-03-20 00:12:54.180567 | localhost | changed 2026-03-20 00:12:54.218549 | 2026-03-20 00:12:54.218734 | PLAY [all] 2026-03-20 00:12:54.242800 | 2026-03-20 00:12:54.242968 | TASK [include_role : prepare-workspace] 2026-03-20 00:12:54.275431 | primary | ok 2026-03-20 00:12:54.293806 | 2026-03-20 00:12:54.294001 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-20 00:12:54.820280 | primary | ok 2026-03-20 00:12:54.828780 | 2026-03-20 00:12:54.828946 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-20 00:12:57.640032 | primary | Output suppressed because no_log was given 2026-03-20 00:12:57.658563 | 2026-03-20 00:12:57.658762 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-20 00:12:57.945621 | primary | changed: "logs" 2026-03-20 00:12:58.181369 | primary | changed: "artifacts" 2026-03-20 00:12:58.404285 | primary | changed: "docs" 2026-03-20 00:12:58.423529 | 2026-03-20 00:12:58.423793 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-20 00:12:58.726043 | primary | changed: "logs" 2026-03-20 00:12:58.726351 | primary | changed: All items complete 2026-03-20 00:12:58.726382 | 2026-03-20 00:12:58.945169 | primary | changed: "artifacts" 2026-03-20 00:12:59.169665 | primary | changed: "docs" 2026-03-20 00:12:59.205396 | 2026-03-20 00:12:59.205550 | TASK [Check if worker can sudo] 2026-03-20 00:12:59.763537 | primary | ok: Runtime: 0:00:00.046466 2026-03-20 00:12:59.769998 | 2026-03-20 00:12:59.770069 | TASK [configure-mirrors : Gather needed facts] 2026-03-20 00:12:59.855973 | primary | skipping: Conditional result was False 2026-03-20 00:12:59.873771 | 2026-03-20 00:12:59.873936 | TASK [configure-mirrors : Set up infrastructure mirrors] 2026-03-20 00:12:59.933459 | primary | ok 2026-03-20 00:12:59.943290 | primary | included: /var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror.yaml 2026-03-20 00:12:59.950491 | 2026-03-20 00:12:59.950640 | TASK [configure-mirrors : Remove .pydistutils.cfg configuration in homedir] 2026-03-20 00:13:00.259613 | primary | ok 2026-03-20 00:13:00.270460 | 2026-03-20 00:13:00.270574 | LOOP [configure-mirrors : Include OS-specific variables] 2026-03-20 00:13:00.369623 | primary | ok: "/var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/vars/CentOS-9.yaml" 2026-03-20 00:13:00.390456 | 2026-03-20 00:13:00.390614 | TASK [configure-mirrors : Install /etc/pip.conf configuration] 2026-03-20 00:13:01.289868 | primary | changed 2026-03-20 00:13:01.306434 | 2026-03-20 00:13:01.306599 | LOOP [configure-mirrors : Setup distribution specific packaging mirrors] 2026-03-20 00:13:01.385386 | primary | ok: "/var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS-9.yaml" 2026-03-20 00:13:01.385821 | primary | ok: All items complete 2026-03-20 00:13:01.385910 | 2026-03-20 00:13:01.467234 | primary | included: /var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS-9.yaml 2026-03-20 00:13:01.475996 | 2026-03-20 00:13:01.476089 | LOOP [configure-mirrors : Install CentOS 9 repository files] 2026-03-20 00:13:02.481916 | primary | changed: "etc/yum.repos.d/centos.repo" 2026-03-20 00:13:03.305411 | primary | changed: "etc/yum.repos.d/centos-addons.repo" 2026-03-20 00:13:03.324365 | 2026-03-20 00:13:03.324561 | TASK [configure-mirrors : Disable deltrarpm] 2026-03-20 00:13:03.879843 | primary | changed: section and option added 2026-03-20 00:13:03.911440 | 2026-03-20 00:13:03.911601 | LOOP [configure-mirrors : Update yum/dnf cache] 2026-03-20 00:13:05.069457 | primary | 29 files removed 2026-03-20 00:13:05.075197 | primary | ok: Item: dnf clean all Runtime: 0:00:00.795606 2026-03-20 00:13:05.075286 | primary | changed: All items complete 2026-03-20 00:13:05.075310 | 2026-03-20 00:13:16.379933 | primary | Loaded plugins: builddep, changelog, config-manager, copr, debug, debuginfo-install, download, generate_completion_cache, groups-manager, needs-restarting, playground, repoclosure, repodiff, repograph, repomanage, reposync, system-upgrade 2026-03-20 00:13:16.380109 | primary | DNF version: 4.14.0 2026-03-20 00:13:16.380150 | primary | cachedir: /var/cache/dnf 2026-03-20 00:13:16.380178 | primary | Making cache files for all metadata files. 2026-03-20 00:13:16.380206 | primary | baseos: has expired and will be refreshed. 2026-03-20 00:13:16.380238 | primary | appstream: has expired and will be refreshed. 2026-03-20 00:13:16.380267 | primary | crb: has expired and will be refreshed. 2026-03-20 00:13:16.380297 | primary | extras-common: has expired and will be refreshed. 2026-03-20 00:13:16.380325 | primary | repo: downloading from remote: baseos 2026-03-20 00:13:16.380353 | primary | CentOS Stream 9 - BaseOS 28 MB/s | 8.9 MB 00:00 2026-03-20 00:13:16.388037 | primary | baseos: using metadata from Mon 16 Mar 2026 04:22:47 PM EDT. 2026-03-20 00:13:16.388167 | primary | repo: downloading from remote: appstream 2026-03-20 00:13:16.388199 | primary | CentOS Stream 9 - AppStream 120 MB/s | 27 MB 00:00 2026-03-20 00:13:16.388228 | primary | appstream: using metadata from Mon 16 Mar 2026 04:26:14 PM EDT. 2026-03-20 00:13:16.388255 | primary | repo: downloading from remote: crb 2026-03-20 00:13:16.388281 | primary | CentOS Stream 9 - CRB 71 MB/s | 8.0 MB 00:00 2026-03-20 00:13:16.388309 | primary | crb: using metadata from Mon 16 Mar 2026 04:30:37 PM EDT. 2026-03-20 00:13:16.388338 | primary | repo: downloading from remote: extras-common 2026-03-20 00:13:16.388366 | primary | CentOS Stream 9 - Extras packages 1.4 MB/s | 20 kB 00:00 2026-03-20 00:13:16.388394 | primary | extras-common: using metadata from Mon 09 Mar 2026 09:49:54 AM EDT. 2026-03-20 00:13:16.388421 | primary | User-Agent: constructed: 'libdnf (CentOS Stream 9; generic; Linux.x86_64)' 2026-03-20 00:13:16.388450 | primary | Completion plugin: Generating completion cache... 2026-03-20 00:13:16.388470 | primary | Metadata cache created. 2026-03-20 00:13:16.388515 | primary | ok: Item: dnf makecache -v Runtime: 0:00:11.064964 2026-03-20 00:13:16.407134 | 2026-03-20 00:13:16.407275 | PLAY RECAP 2026-03-20 00:13:16.407335 | localhost | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-20 00:13:16.407375 | primary | ok: 13 changed: 7 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-20 00:13:16.407399 | 2026-03-20 00:13:16.603732 | PRE-RUN END RESULT_NORMAL: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master] 2026-03-20 00:13:16.605021 | RUN START: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/rdoinfo/weirdo-buildsys-tags.yaml@master] 2026-03-20 00:13:17.286757 | 2026-03-20 00:13:17.286921 | PLAY [all] 2026-03-20 00:13:17.309305 | 2026-03-20 00:13:17.309501 | TASK [Create periodic_job fact] 2026-03-20 00:13:17.375529 | primary | ok 2026-03-20 00:13:17.385044 | 2026-03-20 00:13:17.385233 | TASK [Do not run weirdo if there are no new packages to test in parent job] 2026-03-20 00:13:17.433423 | primary | skipping: Conditional result was False 2026-03-20 00:13:17.449552 | 2026-03-20 00:13:17.449720 | TASK [meta] 2026-03-20 00:13:17.483955 | primary | skipping: end_play conditional evaluated to False, continuing play 2026-03-20 00:13:17.489970 | 2026-03-20 00:13:17.490054 | TASK [Run common weirdo tasks] 2026-03-20 00:13:17.522309 | primary | ok 2026-03-20 00:13:17.542983 | primary | included: /var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/untrusted/project_0/review.rdoproject.org/rdo-jobs/playbooks/weirdo/common.yaml 2026-03-20 00:13:17.552767 | 2026-03-20 00:13:17.553001 | TASK [Create workspace directory] 2026-03-20 00:13:17.981023 | primary | changed 2026-03-20 00:13:17.989416 | 2026-03-20 00:13:17.989578 | TASK [Create centos_releasever fact] 2026-03-20 00:13:18.014799 | primary | skipping: Conditional result was False 2026-03-20 00:13:18.022492 | 2026-03-20 00:13:18.022587 | TASK [set centos_release fact] 2026-03-20 00:13:18.053323 | primary | ok 2026-03-20 00:13:18.059012 | 2026-03-20 00:13:18.059116 | TASK [Install pip] 2026-03-20 00:13:18.082559 | primary | ok 2026-03-20 00:13:18.116951 | 2026-03-20 00:13:18.117166 | TASK [ensure-pip : Check if pip is installed] 2026-03-19 20:13:18.675155 | primary | /usr/bin/pip3 2026-03-19 20:13:18.715905 | primary | /usr/bin/python3: No module named wheel 2026-03-20 00:13:19.162436 | primary | ok: Runtime: 0:00:00.054650 2026-03-20 00:13:19.168737 | 2026-03-20 00:13:19.168839 | LOOP [ensure-pip : Install pip from packages] 2026-03-20 00:13:19.214656 | primary | ok: "/var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2026-03-20 00:13:19.226753 | primary | included: /var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2026-03-20 00:13:19.250976 | 2026-03-20 00:13:19.251321 | TASK [ensure-pip : Install Python 3 pip] 2026-03-20 00:13:20.831727 | primary | ok: Nothing to do 2026-03-20 00:13:20.841777 | 2026-03-20 00:13:20.841899 | TASK [ensure-pip : Install Python3-wheel on older CentOS] 2026-03-20 00:13:22.437182 | primary | changed 2026-03-20 00:13:22.445861 | 2026-03-20 00:13:22.446075 | TASK [ensure-pip : Check for EPEL repository] 2026-03-20 00:13:22.463298 | primary | skipping: Conditional result was False 2026-03-20 00:13:22.472182 | 2026-03-20 00:13:22.472335 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2026-03-20 00:13:22.497842 | primary | skipping: Conditional result was False 2026-03-20 00:13:22.505672 | 2026-03-20 00:13:22.505833 | TASK [ensure-pip : Install Python 2 pip] 2026-03-20 00:13:22.521951 | primary | skipping: Conditional result was False 2026-03-20 00:13:22.530469 | 2026-03-20 00:13:22.530825 | TASK [ensure-pip : Ensure setuptools] 2026-03-20 00:13:22.557602 | primary | skipping: Conditional result was False 2026-03-20 00:13:22.566003 | 2026-03-20 00:13:22.566141 | TASK [ensure-pip : Check for ensurepip module] 2026-03-20 00:13:23.152613 | primary | skipping: Conditional result was False 2026-03-20 00:13:23.163129 | 2026-03-20 00:13:23.163302 | TASK [ensure-pip : Ensure python3-venv] 2026-03-20 00:13:23.192712 | primary | skipping: Conditional result was False 2026-03-20 00:13:23.203124 | 2026-03-20 00:13:23.203273 | TASK [ensure-pip : Install pip from source] 2026-03-20 00:13:23.221445 | primary | skipping: Conditional result was False 2026-03-20 00:13:23.230265 | 2026-03-20 00:13:23.230413 | TASK [ensure-pip : Probe for venv python full path] 2026-03-19 20:13:23.453761 | primary | /usr/bin/python3 2026-03-20 00:13:23.769086 | primary | ok: Runtime: 0:00:00.004181 2026-03-20 00:13:23.781082 | 2026-03-20 00:13:23.781366 | TASK [ensure-pip : Set host default] 2026-03-20 00:13:23.832813 | primary | ok 2026-03-20 00:13:23.845258 | 2026-03-20 00:13:23.845422 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-03-20 00:13:23.896933 | primary | ok 2026-03-20 00:13:23.915789 | 2026-03-20 00:13:23.916033 | TASK [ensure-tox : Check if tox is installed] 2026-03-20 00:13:24.460855 | primary | ok: Runtime: 0:00:00.003061 2026-03-20 00:13:24.475631 | 2026-03-20 00:13:24.475911 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-03-20 00:13:24.493748 | primary | skipping: Conditional result was False 2026-03-20 00:13:24.509715 | 2026-03-20 00:13:24.509971 | TASK [ensure-tox : Create local venv] 2026-03-20 00:13:27.098829 | primary | ok: Runtime: 0:00:02.320727 2026-03-20 00:13:27.107164 | 2026-03-20 00:13:27.107252 | TASK [ensure-tox : Install tox to local venv] 2026-03-19 20:13:27.638816 | primary | Looking in indexes: http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/pypi/simple, http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/wheel/centos-9-x86_64 2026-03-19 20:13:27.913471 | primary | Collecting tox 2026-03-19 20:13:27.921035 | primary | Downloading http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/pypifiles/packages/e2/e4/8bb9ce952820df4165eb34610af347665d6cb436898a234db9d84d093ce6/tox-4.30.3-py3-none-any.whl (175 kB) 2026-03-19 20:13:28.034803 | primary | Collecting tomli>=2.2.1 2026-03-19 20:13:28.046459 | primary | Downloading http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/pypifiles/packages/23/d1/136eb2cb77520a31e1f64cbae9d33ec6df0d78bdf4160398e86eec8a8754/tomli-2.4.0-py3-none-any.whl (14 kB) 2026-03-19 20:13:28.127418 | primary | Collecting platformdirs>=4.3.8 2026-03-19 20:13:28.130812 | primary | Downloading http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/pypifiles/packages/40/4b/2028861e724d3bd36227adfa20d3fd24c3fc6d52032f4a93c133be5d17ce/platformdirs-4.4.0-py3-none-any.whl (18 kB) 2026-03-19 20:13:28.206364 | primary | Collecting packaging>=25 2026-03-19 20:13:28.212745 | primary | Downloading http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/pypifiles/packages/b7/b9/c538f279a4e237a006a2c98387d081e9eb060d203d8ed34467cc0f0b9b53/packaging-26.0-py3-none-any.whl (74 kB) 2026-03-19 20:13:28.274519 | primary | Collecting pyproject-api>=1.9.1 2026-03-19 20:13:28.281556 | primary | Downloading http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/pypifiles/packages/ef/e6/c293c06695d4a3ab0260ef124a74ebadba5f4c511ce3a4259e976902c00b/pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2026-03-19 20:13:28.389201 | primary | Collecting chardet>=5.2 2026-03-19 20:13:28.398260 | primary | Downloading http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/pypifiles/packages/38/6f/f5fbc992a329ee4e0f288c1fe0e2ad9485ed064cac731ed2fe47dcc38cbf/chardet-5.2.0-py3-none-any.whl (199 kB) 2026-03-19 20:13:28.475234 | primary | Collecting pluggy>=1.6 2026-03-19 20:13:28.482750 | primary | Downloading http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/pypifiles/packages/54/20/4d324d65cc6d9205fabedc306948156824eb9f0ee1633355a8f7ec5c66bf/pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-03-19 20:13:28.560001 | primary | Collecting typing-extensions>=4.14.1 2026-03-19 20:13:28.564322 | primary | Downloading http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/pypifiles/packages/18/67/36e9267722cc04a6b9f15c7f3441c2363321a3ea07da7ae0c0707beb2a9c/typing_extensions-4.15.0-py3-none-any.whl (44 kB) 2026-03-19 20:13:28.787310 | primary | Collecting virtualenv>=20.31.2 2026-03-19 20:13:28.798398 | primary | Downloading http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/pypifiles/packages/c6/59/7d02447a55b2e55755011a647479041bc92a82e143f96a8195cb33bd0a1c/virtualenv-21.2.0-py3-none-any.whl (5.8 MB) 2026-03-19 20:13:28.926339 | primary | Collecting cachetools>=6.1 2026-03-19 20:13:28.933492 | primary | Downloading http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/pypifiles/packages/90/45/f458fa2c388e79dd9d8b9b0c99f1d31b568f27388f2fdba7bb66bbc0c6ed/cachetools-6.2.6-py3-none-any.whl (11 kB) 2026-03-19 20:13:29.005575 | primary | Collecting colorama>=0.4.6 2026-03-19 20:13:29.009031 | primary | Downloading http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/wheel/centos-9-x86_64/colorama/colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-03-19 20:13:29.112275 | primary | Collecting filelock>=3.18 2026-03-19 20:13:29.118144 | primary | Downloading http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/pypifiles/packages/42/14/42b2651a2f46b022ccd948bca9f2d5af0fd8929c4eec235b8d6d844fbe67/filelock-3.19.1-py3-none-any.whl (15 kB) 2026-03-19 20:13:29.211796 | primary | Collecting python-discovery>=1 2026-03-19 20:13:29.221366 | primary | Downloading http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/pypifiles/packages/c2/3c/2005227cb951df502412de2fa781f800663cccbef8d90ec6f1b371ac2c0d/python_discovery-1.2.0-py3-none-any.whl (31 kB) 2026-03-19 20:13:29.280447 | primary | Collecting distlib<1,>=0.3.7 2026-03-19 20:13:29.285897 | primary | Downloading http://mirror.regionone.vexxhost-nodepool-tripleo.rdoproject.org/pypifiles/packages/33/6b/e0547afaf41bf2c42e52430072fa5658766e3d65bd4b03a563d1b6336f57/distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-03-19 20:13:29.438683 | primary | Installing collected packages: platformdirs, filelock, typing-extensions, tomli, python-discovery, packaging, distlib, virtualenv, pyproject-api, pluggy, colorama, chardet, cachetools, tox 2026-03-19 20:13:30.117072 | primary | Successfully installed cachetools-6.2.6 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.19.1 packaging-26.0 platformdirs-4.4.0 pluggy-1.6.0 pyproject-api-1.9.1 python-discovery-1.2.0 tomli-2.4.0 tox-4.30.3 typing-extensions-4.15.0 virtualenv-21.2.0 2026-03-19 20:13:30.268479 | primary | WARNING: You are using pip version 21.3.1; however, version 26.0.1 is available. 2026-03-19 20:13:30.367746 | primary | You should consider upgrading via the '/home/zuul/.local/tox/bin/python3 -m pip install --upgrade pip' command. 2026-03-20 00:13:30.652528 | primary | ok: Runtime: 0:00:03.044134 2026-03-20 00:13:30.660347 | 2026-03-20 00:13:30.660499 | TASK [ensure-tox : Export installed tox_executable path] 2026-03-20 00:13:30.696533 | primary | ok 2026-03-20 00:13:30.708827 | 2026-03-20 00:13:30.708985 | TASK [ensure-tox : Output tox version] 2026-03-19 20:13:31.146509 | primary | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-03-19 20:13:31.172737 | primary | 4.30.3 from /home/zuul/.local/tox/lib64/python3.9/site-packages/tox/__init__.py 2026-03-20 00:13:31.259020 | primary | ok: Runtime: 0:00:00.264184 2026-03-20 00:13:31.267532 | 2026-03-20 00:13:31.267622 | TASK [ensure-tox : Make global symlink] 2026-03-20 00:13:31.530867 | primary | changed 2026-03-20 00:13:31.547048 | 2026-03-20 00:13:31.547197 | TASK [Setup weirdo roles] 2026-03-20 00:13:32.095430 | primary | ok: Runtime: 0:00:00.015780 2026-03-20 00:13:32.108455 | 2026-03-20 00:13:32.108621 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2026-03-20 00:13:32.137071 | primary | skipping: Conditional result was False 2026-03-20 00:13:32.146063 | 2026-03-20 00:13:32.146215 | TASK [mirror-info-fork : Create /etc/ci] 2026-03-20 00:13:32.395345 | primary | changed 2026-03-20 00:13:32.408260 | 2026-03-20 00:13:32.408535 | TASK [mirror-info-fork : Install ci_mirror script] 2026-03-20 00:13:33.682744 | primary | changed 2026-03-20 00:13:33.774775 | 2026-03-20 00:13:33.774949 | TASK [install rdopkg dependencies] 2026-03-19 20:13:34.450208 | primary | Last metadata expiration check: 0:00:19 ago on Thu 19 Mar 2026 08:13:15 PM EDT. 2026-03-19 20:13:34.600620 | primary | Package python3-pip-21.3.1-1.el9.noarch is already installed. 2026-03-19 20:13:34.601178 | primary | Package rpmlint-1.11-19.el9.noarch is already installed. 2026-03-19 20:13:34.601791 | primary | Package python3-rpm-4.16.1.3-40.el9.x86_64 is already installed. 2026-03-19 20:13:34.634561 | primary | Dependencies resolved. 2026-03-19 20:13:34.635653 | primary | Nothing to do. 2026-03-19 20:13:34.635690 | primary | Complete! 2026-03-20 00:13:34.810514 | primary | ok: Runtime: 0:00:00.672396 2026-03-20 00:13:34.824602 | 2026-03-20 00:13:34.824848 | TASK [pip install rdopkg] 2026-03-20 00:13:41.707228 | primary | changed 2026-03-20 00:13:41.721876 | 2026-03-20 00:13:41.721960 | TASK [Set content registry ip and port] 2026-03-20 00:13:41.777367 | primary | ok 2026-03-20 00:13:41.787108 | 2026-03-20 00:13:41.787266 | TASK [Check if job needs to be run or not based on changes] 2026-03-19 20:13:42.060859 | primary | + CREPOS_FILE=changed_repos.txt 2026-03-19 20:13:42.060932 | primary | + PROJECT=rdoinfo 2026-03-19 20:13:42.060939 | primary | + RELEASE=dalmatian 2026-03-19 20:13:42.060944 | primary | + PHASE=testing 2026-03-19 20:13:42.060953 | primary | + DIST_VER=9s 2026-03-19 20:13:42.060997 | primary | + case $PROJECT in 2026-03-19 20:13:42.061003 | primary | + REPO=cloud9s-openstack-dalmatian-testing 2026-03-19 20:13:42.061008 | primary | + '[' -z testing -o -z dalmatian ']' 2026-03-19 20:13:42.061012 | primary | + logs=https://logserver.rdoproject.org/77a/rdoproject.org/77ae977e37c9487896352edd68fa91b6/buildset 2026-03-19 20:13:42.061020 | primary | + curl -o changed_repos.txt -sf https://logserver.rdoproject.org/77a/rdoproject.org/77ae977e37c9487896352edd68fa91b6/buildset/repos/changed_repos.txt 2026-03-19 20:13:42.101149 | primary | + grep -q -E cloud9s-openstack-dalmatian-testing changed_repos.txt 2026-03-19 20:13:42.103437 | primary | + echo 'INFO: this test is not required' 2026-03-19 20:13:42.103545 | primary | + tee not_required 2026-03-19 20:13:42.104590 | primary | INFO: this test is not required 2026-03-19 20:13:42.104753 | primary | + exit 0 2026-03-20 00:13:42.324596 | primary | ok: Runtime: 0:00:00.049041 2026-03-20 00:13:42.333917 | 2026-03-20 00:13:42.334201 | TASK [Detect if we created the file to stop quickstart run] 2026-03-20 00:13:42.591648 | primary | ok 2026-03-20 00:13:42.604763 | 2026-03-20 00:13:42.604962 | TASK [Run weirdo for the desired project and scenario] 2026-03-20 00:13:43.149857 | primary | skipping: Conditional result was False 2026-03-20 00:13:43.160764 | 2026-03-20 00:13:43.160895 | TASK [Set up content registry IP address and pause the job] 2026-03-20 00:13:43.230549 | primary | ok 2026-03-20 00:13:43.267421 | 2026-03-20 00:13:43.267569 | PLAY RECAP 2026-03-20 00:13:43.267661 | primary | ok: 26 changed: 15 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2026-03-20 00:13:43.267713 | 2026-03-20 00:13:43.490009 | RUN END RESULT_NORMAL: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/rdoinfo/weirdo-buildsys-tags.yaml@master] 2026-03-20 00:13:43.490252 | 2026-03-20 00:13:43.490252 | Job paused 2026-03-20 00:13:44.414669 | Job resumed 2026-03-20 00:13:44.414669 | 2026-03-20 00:13:44.420233 | POST-RUN START: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/podified-containers/collect-logs.yaml@master] 2026-03-20 00:13:45.123559 | 2026-03-20 00:13:45.123734 | PLAY [all] 2026-03-20 00:13:45.148906 | 2026-03-20 00:13:45.149098 | TASK [Create container log dir] 2026-03-20 00:13:45.616924 | primary | changed 2026-03-20 00:13:45.622844 | 2026-03-20 00:13:45.622955 | TASK [Check if the test is needed] 2026-03-20 00:13:46.070333 | primary | ok 2026-03-20 00:13:46.083265 | 2026-03-20 00:13:46.083442 | TASK [ansible.builtin.shell] 2026-03-20 00:13:46.629665 | primary | skipping: Conditional result was False 2026-03-20 00:13:46.647496 | 2026-03-20 00:13:46.647743 | TASK [Store built images to containers-built.log] 2026-03-20 00:13:46.722202 | primary | skipping: Conditional result was False 2026-03-20 00:13:46.731364 | 2026-03-20 00:13:46.731724 | TASK [Check if we get ci-framework-data basedir] 2026-03-20 00:13:46.997639 | primary | ok 2026-03-20 00:13:47.007737 | 2026-03-20 00:13:47.007828 | TASK [Create ci-framework-data log directory for zuul] 2026-03-20 00:13:47.056589 | primary | skipping: Conditional result was False 2026-03-20 00:13:47.064132 | 2026-03-20 00:13:47.064221 | TASK [Copy ci-framework interesting files] 2026-03-20 00:13:47.600200 | primary | skipping: Conditional result was False 2026-03-20 00:13:47.606771 | 2026-03-20 00:13:47.607098 | TASK [Collect logs] 2026-03-19 20:13:48.042131 | primary | + sudo dnf list installed 2026-03-19 20:13:48.478042 | primary | + df -h 2026-03-19 20:13:48.481365 | primary | + sudo rsync -var --no-links --include 'yum.repos.d/***' --include yum.conf --include 'dnf/***' '--exclude=*' /etc/ /home/zuul/zuul-output/logs 2026-03-19 20:13:48.499294 | primary | sending incremental file list 2026-03-19 20:13:48.506025 | primary | skipping non-regular file "yum.conf" 2026-03-19 20:13:48.506064 | primary | ./ 2026-03-19 20:13:48.507052 | primary | dnf/ 2026-03-19 20:13:48.507084 | primary | dnf/dnf.conf 2026-03-19 20:13:48.507188 | primary | dnf/aliases.d/ 2026-03-19 20:13:48.507207 | primary | dnf/modules.d/ 2026-03-19 20:13:48.507224 | primary | dnf/modules.defaults.d/ 2026-03-19 20:13:48.507237 | primary | dnf/plugins/ 2026-03-19 20:13:48.507255 | primary | dnf/plugins/copr.conf 2026-03-19 20:13:48.507275 | primary | dnf/plugins/debuginfo-install.conf 2026-03-19 20:13:48.507291 | primary | dnf/plugins/copr.d/ 2026-03-19 20:13:48.507305 | primary | dnf/protected.d/ 2026-03-19 20:13:48.507322 | primary | dnf/protected.d/dnf.conf 2026-03-19 20:13:48.507342 | primary | dnf/protected.d/grub2-pc.conf 2026-03-19 20:13:48.507367 | primary | dnf/protected.d/grub2-tools-minimal.conf 2026-03-19 20:13:48.507390 | primary | dnf/protected.d/setup.conf 2026-03-19 20:13:48.507410 | primary | dnf/protected.d/sudo.conf 2026-03-19 20:13:48.507429 | primary | dnf/protected.d/systemd.conf 2026-03-19 20:13:48.507447 | primary | dnf/protected.d/yum.conf 2026-03-19 20:13:48.507462 | primary | dnf/usr-drift-protected-paths.d/ 2026-03-19 20:13:48.507476 | primary | dnf/vars/ 2026-03-19 20:13:48.507492 | primary | dnf/vars/stream 2026-03-19 20:13:48.507507 | primary | yum.repos.d/ 2026-03-19 20:13:48.507523 | primary | yum.repos.d/centos-addons.repo 2026-03-19 20:13:48.507554 | primary | yum.repos.d/centos.repo 2026-03-19 20:13:48.550006 | primary | 2026-03-19 20:13:48.550087 | primary | sent 8,757 bytes received 351 bytes 18,216.00 bytes/sec 2026-03-19 20:13:48.550138 | primary | total size is 7,486 speedup is 0.82 2026-03-19 20:13:48.553860 | primary | + sudo rsync -var --no-links /etc/containers/ /home/zuul/zuul-output/logs 2026-03-19 20:13:48.578830 | primary | sending incremental file list 2026-03-19 20:13:48.578948 | primary | rsync: [sender] change_dir "/etc/containers" failed: No such file or directory (2) 2026-03-19 20:13:48.701454 | primary | 2026-03-19 20:13:48.701595 | primary | sent 19 bytes received 12 bytes 62.00 bytes/sec 2026-03-19 20:13:48.701642 | primary | total size is 0 speedup is 0.00 2026-03-19 20:13:48.701687 | primary | rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1327) [sender=3.2.5] 2026-03-19 20:13:48.705960 | primary | + true 2026-03-19 20:13:48.706002 | primary | + rsync -var --no-links /home/zuul/repos /home/zuul/zuul-output/logs 2026-03-19 20:13:48.709059 | primary | sending incremental file list 2026-03-19 20:13:48.709130 | primary | rsync: [sender] link_stat "/home/zuul/repos" failed: No such file or directory (2) 2026-03-19 20:13:48.750658 | primary | 2026-03-19 20:13:48.751763 | primary | sent 19 bytes received 12 bytes 62.00 bytes/sec 2026-03-19 20:13:48.751875 | primary | total size is 0 speedup is 0.00 2026-03-19 20:13:48.751897 | primary | rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1327) [sender=3.2.5] 2026-03-19 20:13:48.751925 | primary | + true 2026-03-20 00:13:49.147458 | primary | changed 2026-03-20 00:13:49.157270 | 2026-03-20 00:13:49.157414 | TASK [Copy files from /home/zuul/workspace on node] 2026-03-20 00:13:49.178907 | primary | ok 2026-03-20 00:13:49.200336 | 2026-03-20 00:13:49.200478 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-20 00:13:49.246716 | primary | skipping: Conditional result was False 2026-03-20 00:13:49.254067 | 2026-03-20 00:13:49.254159 | TASK [fetch-output : Set log path for single node] 2026-03-20 00:13:49.296787 | primary | ok 2026-03-20 00:13:49.303875 | 2026-03-20 00:13:49.304154 | LOOP [fetch-output : Ensure local output dirs] 2026-03-20 00:13:49.599117 | primary -> localhost | ok: "/var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/work/logs" 2026-03-20 00:13:49.842032 | primary -> localhost | changed: "/var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/work/artifacts" 2026-03-20 00:13:50.147287 | primary -> localhost | changed: "/var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/work/docs" 2026-03-20 00:13:50.168662 | 2026-03-20 00:13:50.168910 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-20 00:13:50.872629 | primary | changed: 2026-03-20 00:13:50.872875 | primary | .d..t...... ./ 2026-03-20 00:13:50.872913 | primary | >f+++++++++ disk_usage.txt 2026-03-20 00:13:50.872942 | primary | >f+++++++++ installed_pkgs.txt 2026-03-20 00:13:50.872962 | primary | cd+++++++++ dnf/ 2026-03-20 00:13:50.872982 | primary | >f+++++++++ dnf/dnf.conf 2026-03-20 00:13:50.873001 | primary | cd+++++++++ dnf/aliases.d/ 2026-03-20 00:13:50.873021 | primary | cd+++++++++ dnf/modules.d/ 2026-03-20 00:13:50.873039 | primary | cd+++++++++ dnf/modules.defaults.d/ 2026-03-20 00:13:50.873058 | primary | cd+++++++++ dnf/plugins/ 2026-03-20 00:13:50.873077 | primary | >f+++++++++ dnf/plugins/copr.conf 2026-03-20 00:13:50.873094 | primary | >f+++++++++ dnf/plugins/debuginfo-install.conf 2026-03-20 00:13:50.873111 | primary | cd+++++++++ dnf/plugins/copr.d/ 2026-03-20 00:13:50.873130 | primary | cd+++++++++ dnf/protected.d/ 2026-03-20 00:13:50.873147 | primary | >f+++++++++ dnf/protected.d/dnf.conf 2026-03-20 00:13:50.873165 | primary | >f+++++++++ dnf/protected.d/grub2-pc.conf 2026-03-20 00:13:50.873182 | primary | >f+++++++++ dnf/protected.d/grub2-tools-minimal.conf 2026-03-20 00:13:50.873199 | primary | >f+++++++++ dnf/protected.d/setup.conf 2026-03-20 00:13:50.873231 | primary | >f+++++++++ dnf/protected.d/sudo.conf 2026-03-20 00:13:50.873249 | primary | >f+++++++++ dnf/protected.d/systemd.conf 2026-03-20 00:13:50.873268 | primary | >f+++++++++ dnf/protected.d/yum.conf 2026-03-20 00:13:50.873285 | primary | cd+++++++++ dnf/usr-drift-protected-paths.d/ 2026-03-20 00:13:50.873302 | primary | cd+++++++++ dnf/vars/ 2026-03-20 00:13:50.873320 | primary | >f+++++++++ dnf/vars/stream 2026-03-20 00:13:50.873391 | primary | cd+++++++++ logs/ 2026-03-20 00:13:50.873414 | primary | cd+++++++++ yum.repos.d/ 2026-03-20 00:13:50.873432 | primary | >f+++++++++ yum.repos.d/centos-addons.repo 2026-03-20 00:13:50.873449 | primary | >f+++++++++ yum.repos.d/centos.repo 2026-03-20 00:13:50.873484 | primary | changed: All items complete 2026-03-20 00:13:50.873504 | 2026-03-20 00:13:51.328791 | primary | changed: .d..t...... ./ 2026-03-20 00:13:51.918148 | primary | changed: .d..t...... ./ 2026-03-20 00:13:51.935931 | 2026-03-20 00:13:51.936083 | TASK [Set zuul-log-path fact] 2026-03-20 00:13:51.956011 | primary | ok 2026-03-20 00:13:52.018950 | 2026-03-20 00:13:52.019108 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-20 00:13:52.049143 | primary | ok 2026-03-20 00:13:52.059761 | 2026-03-20 00:13:52.059899 | TASK [Return containers build job log path] 2026-03-20 00:13:52.110147 | primary | ok 2026-03-20 00:13:52.130897 | 2026-03-20 00:13:52.131011 | PLAY RECAP 2026-03-20 00:13:52.131056 | primary | ok: 9 changed: 4 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-03-20 00:13:52.131078 | 2026-03-20 00:13:52.283795 | POST-RUN END RESULT_NORMAL: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/podified-containers/collect-logs.yaml@master] 2026-03-20 00:13:52.285070 | POST-RUN START: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/weirdo/integration/post.yaml@master] 2026-03-20 00:13:59.266447 | 2026-03-20 00:13:59.266716 | PLAY [all] 2026-03-20 00:13:59.296820 | 2026-03-20 00:13:59.296995 | TASK [Prepare logs] 2026-03-19 20:13:59.828837 | primary | sudo: /home/zuul/src/review.rdoproject.org/rdo-infra/weirdo/.tox/ansible-playbook/bin/ara-manage: command not found 2026-03-19 20:13:59.858262 | primary | cp: cannot stat '/var/log/weirdo/*': No such file or directory 2026-03-19 20:13:59.912323 | primary | cp: cannot stat '/home/zuul/workspace/ara.sqlite': No such file or directory 2026-03-20 00:14:00.333661 | primary | ok: Runtime: 0:00:00.169110 2026-03-20 00:14:00.344342 | 2026-03-20 00:14:00.344507 | TASK [Copy Weirdo logs] 2026-03-20 00:14:01.166121 | primary | changed: 2026-03-20 00:14:01.166386 | primary | .d..t...... ./ 2026-03-20 00:14:01.166436 | primary | cd+++++++++ ara-database/ 2026-03-20 00:14:01.193411 | 2026-03-20 00:14:01.193524 | PLAY RECAP 2026-03-20 00:14:01.193568 | primary | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-20 00:14:01.193590 | 2026-03-20 00:14:01.338966 | POST-RUN END RESULT_NORMAL: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/weirdo/integration/post.yaml@master] 2026-03-20 00:14:01.340169 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-03-20 00:14:02.031386 | 2026-03-20 00:14:02.031580 | PLAY [all] 2026-03-20 00:14:02.069120 | 2026-03-20 00:14:02.069309 | TASK [include_role : fetch-output] 2026-03-20 00:14:02.113188 | primary | ok 2026-03-20 00:14:02.134664 | 2026-03-20 00:14:02.134882 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-20 00:14:02.201250 | primary | skipping: Conditional result was False 2026-03-20 00:14:02.207994 | 2026-03-20 00:14:02.208086 | TASK [fetch-output : Set log path for single node] 2026-03-20 00:14:02.249064 | primary | ok 2026-03-20 00:14:02.255181 | 2026-03-20 00:14:02.255307 | LOOP [fetch-output : Ensure local output dirs] 2026-03-20 00:14:02.735381 | primary -> localhost | ok: "/var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/work/logs" 2026-03-20 00:14:03.056935 | primary -> localhost | ok: "/var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/work/artifacts" 2026-03-20 00:14:03.338044 | primary -> localhost | ok: "/var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/work/docs" 2026-03-20 00:14:03.348727 | 2026-03-20 00:14:03.348932 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-20 00:14:04.158624 | primary | changed: .d..t...... logs/ 2026-03-20 00:14:04.159070 | primary | ok: All items complete 2026-03-20 00:14:04.159131 | 2026-03-20 00:14:04.705920 | primary | ok 2026-03-20 00:14:05.249340 | primary | ok 2026-03-20 00:14:05.283465 | 2026-03-20 00:14:05.283737 | TASK [include_role : fetch-output-openshift] 2026-03-20 00:14:05.311261 | primary | skipping: Conditional result was False 2026-03-20 00:14:05.321955 | 2026-03-20 00:14:05.322094 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-20 00:14:05.792321 | primary -> localhost | ok: Item: artifacts Runtime: 0:00:00.011439 2026-03-20 00:14:06.027520 | primary -> localhost | ok: Item: docs Runtime: 0:00:00.011154 2026-03-20 00:14:06.084874 | 2026-03-20 00:14:06.085031 | PLAY [all] 2026-03-20 00:14:06.113937 | 2026-03-20 00:14:06.114100 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-20 00:14:06.605401 | primary | changed 2026-03-20 00:14:06.646648 | 2026-03-20 00:14:06.646815 | PLAY RECAP 2026-03-20 00:14:06.646873 | primary | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-03-20 00:14:06.646903 | 2026-03-20 00:14:06.809751 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-03-20 00:14:06.810800 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2026-03-20 00:14:07.512918 | 2026-03-20 00:14:07.513072 | PLAY [localhost] 2026-03-20 00:14:07.532459 | 2026-03-20 00:14:07.532643 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-20 00:14:07.951833 | localhost | changed 2026-03-20 00:14:07.960733 | 2026-03-20 00:14:07.960906 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-20 00:14:07.989503 | localhost | ok 2026-03-20 00:14:07.998404 | 2026-03-20 00:14:07.998519 | TASK [add-fileserver : Create SSH private key tempfile] 2026-03-20 00:14:08.415624 | localhost | changed 2026-03-20 00:14:08.421843 | 2026-03-20 00:14:08.421964 | TASK [add-fileserver : Create SSH private key from secret] 2026-03-20 00:14:09.288808 | localhost | changed 2026-03-20 00:14:09.301060 | 2026-03-20 00:14:09.301242 | TASK [add-fileserver : Add fileserver ssh key] 2026-03-20 00:14:09.742090 | localhost | Identity added: /var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/work/tmp/ansible.kjt4201_ (/var/lib/zuul/builds/63f396f24e204d0aa44457cde5e5a6e7/work/tmp/ansible.kjt4201_) 2026-03-20 00:14:09.742298 | localhost | ok: Runtime: 0:00:00.010934 2026-03-20 00:14:09.746908 | 2026-03-20 00:14:09.746985 | TASK [add-fileserver : Remove SSH private key from disk] 2026-03-20 00:14:10.074785 | localhost | ok: Runtime: 0:00:00.010697 2026-03-20 00:14:10.080198 | 2026-03-20 00:14:10.080284 | TASK [add-fileserver : Add fileserver to inventory] 2026-03-20 00:14:10.151003 | localhost | changed 2026-03-20 00:14:10.156023 | 2026-03-20 00:14:10.156092 | TASK [add-fileserver : Add fileserver server to known hosts] 2026-03-20 00:14:10.623486 | localhost | changed 2026-03-20 00:14:10.657499 | 2026-03-20 00:14:10.657621 | PLAY [localhost] 2026-03-20 00:14:10.672008 | 2026-03-20 00:14:10.672124 | TASK [Generate bulk log download script] 2026-03-20 00:14:10.692500 | localhost | ok 2026-03-20 00:14:10.706803 | 2026-03-20 00:14:10.706939 | TASK [local-log-download : Check API endpoint is defined] 2026-03-20 00:14:10.738869 | localhost | ok: All assertions passed 2026-03-20 00:14:10.746768 | 2026-03-20 00:14:10.746905 | TASK [local-log-download : Create download script] 2026-03-20 00:14:11.261520 | localhost -> localhost | changed 2026-03-20 00:14:11.334913 | 2026-03-20 00:14:11.335069 | TASK [Register quick-download link] 2026-03-20 00:14:11.368246 | localhost | ok 2026-03-20 00:14:11.391111 | 2026-03-20 00:14:11.391240 | PLAY [logserver.rdoproject.org] 2026-03-20 00:14:11.405498 | 2026-03-20 00:14:11.405663 | TASK [Set zuul-log-path fact] 2026-03-20 00:14:11.423609 | logserver.rdoproject.org | ok 2026-03-20 00:14:11.434295 | 2026-03-20 00:14:11.434453 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-20 00:14:11.475019 | logserver.rdoproject.org | ok 2026-03-20 00:14:11.481295 | 2026-03-20 00:14:11.481368 | TASK [upload-logs : Create log directories] 2026-03-20 00:14:12.154622 | logserver.rdoproject.org | changed 2026-03-20 00:14:12.160879 | 2026-03-20 00:14:12.161025 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-20 00:14:12.508210 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.006788 2026-03-20 00:14:12.521763 | 2026-03-20 00:14:12.521974 | TASK [upload-logs : Upload logs to log server] 2026-03-20 00:14:13.301910 | logserver.rdoproject.org | Output suppressed because no_log was given 2026-03-20 00:14:13.305366 | 2026-03-20 00:14:13.305438 | LOOP [upload-logs : Compress console log and json output] 2026-03-20 00:14:13.380553 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-20 00:14:13.392532 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-20 00:14:13.411193 | 2026-03-20 00:14:13.411397 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-20 00:14:13.469247 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-20 00:14:13.469606 | 2026-03-20 00:14:13.474075 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-20 00:14:13.485234 | 2026-03-20 00:14:13.485360 | LOOP [upload-logs : Upload console log and json output]