2025-11-24 08:34:12.943139 | Job console starting...
2025-11-24 08:34:13.141488 | Updating repositories
2025-11-24 08:34:13.896521 | Preparing job workspace
2025-11-24 08:34:25.901971 | Running Ansible setup...
2025-11-24 08:34:31.090136 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-11-24 08:34:32.080725 | 
2025-11-24 08:34:32.080816 | PLAY [localhost]
2025-11-24 08:34:32.097618 | 
2025-11-24 08:34:32.097688 | TASK [Gathering Facts]
2025-11-24 08:34:33.741350 | localhost | ok
2025-11-24 08:34:33.754888 | 
2025-11-24 08:34:33.754972 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-11-24 08:34:34.421749 | localhost -> localhost | changed
2025-11-24 08:34:34.427255 | 
2025-11-24 08:34:34.427325 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-11-24 08:34:36.550263 | localhost -> localhost | changed
2025-11-24 08:34:36.559980 | 
2025-11-24 08:34:36.560042 | TASK [Setup log path fact]
2025-11-24 08:34:36.601580 | localhost | ok
2025-11-24 08:34:36.626615 | 
2025-11-24 08:34:36.626686 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-11-24 08:34:36.675811 | localhost | ok
2025-11-24 08:34:36.682676 | 
2025-11-24 08:34:36.682736 | TASK [emit-job-header : Print job information]
2025-11-24 08:34:36.739662 | # Job Information
2025-11-24 08:34:36.739784 | Ansible Version: 2.15.12
2025-11-24 08:34:36.739814 | Job: cifmw-molecule-compliance
2025-11-24 08:34:36.739838 | Pipeline: github-check
2025-11-24 08:34:36.739860 | Executor: ibm-bm3-ze.softwarefactory-project.io
2025-11-24 08:34:36.739880 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3451
2025-11-24 08:34:36.739899 | Log URL (when completed): https://logserver.rdoproject.org/ac1/rdoproject.org/ac15b306401046d9b4e704832eed6e9b/
2025-11-24 08:34:36.739919 | Event ID: 2dae9040-c910-11f0-818a-433f9d14d6bc
2025-11-24 08:34:36.743463 | 
2025-11-24 08:34:36.743527 | LOOP [emit-job-header : Print node information]
2025-11-24 08:34:36.880610 | localhost | ok:
2025-11-24 08:34:36.881072 | localhost | # Node Information
2025-11-24 08:34:36.881285 | localhost | Inventory Hostname: controller
2025-11-24 08:34:36.881495 | localhost | Hostname: np0005533194
2025-11-24 08:34:36.881696 | localhost | Username: zuul
2025-11-24 08:34:36.882051 | localhost | Distro: CentOS 9
2025-11-24 08:34:36.882556 | localhost | Provider: ibm-bm3-nodepool
2025-11-24 08:34:36.882892 | localhost | Region: regionOne
2025-11-24 08:34:36.884285 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2025-11-24 08:34:36.884326 | localhost | Product Name: OpenStack Compute
2025-11-24 08:34:36.884352 | localhost | Interface IP: 192.168.25.42
2025-11-24 08:34:36.942820 | 
2025-11-24 08:34:36.942879 | PLAY [all]
2025-11-24 08:34:36.962216 | 
2025-11-24 08:34:36.962279 | TASK [Gather network facts]
2025-11-24 08:34:37.360714 | controller | ok
2025-11-24 08:34:37.394458 | 
2025-11-24 08:34:37.394541 | TASK [include_role : start-zuul-console]
2025-11-24 08:34:37.445033 | controller | ok
2025-11-24 08:34:37.477740 | 
2025-11-24 08:34:37.477806 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-11-24 08:34:38.115181 | controller | ok
2025-11-24 08:34:38.123836 | 
2025-11-24 08:34:38.123896 | TASK [include_role : add-build-sshkey]
2025-11-24 08:34:38.182924 | controller | ok
2025-11-24 08:34:38.221161 | 
2025-11-24 08:34:38.221226 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-11-24 08:34:38.714800 | controller -> localhost | ok
2025-11-24 08:34:38.720518 | 
2025-11-24 08:34:38.720588 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-11-24 08:34:38.768706 | controller | ok
2025-11-24 08:34:38.799468 | controller | included: /var/lib/zuul/builds/ac15b306401046d9b4e704832eed6e9b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-11-24 08:34:38.818586 | 
2025-11-24 08:34:38.818650 | TASK [add-build-sshkey : Create Temp SSH key]
2025-11-24 08:34:39.880976 | controller -> localhost | Generating public/private rsa key pair.
2025-11-24 08:34:39.881150 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/ac15b306401046d9b4e704832eed6e9b/work/ac15b306401046d9b4e704832eed6e9b_id_rsa.
2025-11-24 08:34:39.881185 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/ac15b306401046d9b4e704832eed6e9b/work/ac15b306401046d9b4e704832eed6e9b_id_rsa.pub.
2025-11-24 08:34:39.881211 | controller -> localhost | The key fingerprint is:
2025-11-24 08:34:39.881234 | controller -> localhost | SHA256:NSA7ze+Exojh0rrIgjkPcpdzNAxZ3JU3PwL5ggqa42w zuul-build-sshkey
2025-11-24 08:34:39.881255 | controller -> localhost | The key's randomart image is:
2025-11-24 08:34:39.881275 | controller -> localhost | +---[RSA 3072]----+
2025-11-24 08:34:39.881295 | controller -> localhost | |     .o....o     |
2025-11-24 08:34:39.881314 | controller -> localhost | |     o.=..+ o    |
2025-11-24 08:34:39.881334 | controller -> localhost | |    + o o.o+ o   |
2025-11-24 08:34:39.881353 | controller -> localhost | |   o.= +.+..o o  |
2025-11-24 08:34:39.881372 | controller -> localhost | |  .o+.=.S o. . . |
2025-11-24 08:34:39.881413 | controller -> localhost | |  +o o.o o       |
2025-11-24 08:34:39.881436 | controller -> localhost | |++o.+ .   .      |
2025-11-24 08:34:39.881458 | controller -> localhost | |B+Eo o           |
2025-11-24 08:34:39.881478 | controller -> localhost | |o=o              |
2025-11-24 08:34:39.881499 | controller -> localhost | +----[SHA256]-----+
2025-11-24 08:34:39.881541 | controller -> localhost | ok: Runtime: 0:00:00.248133
2025-11-24 08:34:39.887096 | 
2025-11-24 08:34:39.887157 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-11-24 08:34:39.959756 | controller | ok
2025-11-24 08:34:39.970066 | controller | included: /var/lib/zuul/builds/ac15b306401046d9b4e704832eed6e9b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-11-24 08:34:39.984207 | 
2025-11-24 08:34:39.984277 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-11-24 08:34:40.057706 | controller | skipping: Conditional result was False
2025-11-24 08:34:40.063370 | 
2025-11-24 08:34:40.063462 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-11-24 08:34:40.601937 | controller | changed
2025-11-24 08:34:40.606917 | 
2025-11-24 08:34:40.607007 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-11-24 08:34:40.849186 | controller | ok
2025-11-24 08:34:40.854053 | 
2025-11-24 08:34:40.854115 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-11-24 08:34:41.629729 | controller | changed
2025-11-24 08:34:41.635670 | 
2025-11-24 08:34:41.635734 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-11-24 08:34:42.450178 | controller | changed
2025-11-24 08:34:42.460996 | 
2025-11-24 08:34:42.461061 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-11-24 08:34:42.520019 | controller | skipping: Conditional result was False
2025-11-24 08:34:42.527527 | 
2025-11-24 08:34:42.527604 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-11-24 08:34:43.406630 | controller -> localhost | changed
2025-11-24 08:34:43.417902 | 
2025-11-24 08:34:43.417994 | TASK [add-build-sshkey : Add back temp key]
2025-11-24 08:34:44.000544 | controller -> localhost | Identity added: /var/lib/zuul/builds/ac15b306401046d9b4e704832eed6e9b/work/ac15b306401046d9b4e704832eed6e9b_id_rsa (zuul-build-sshkey)
2025-11-24 08:34:44.000727 | controller -> localhost | ok: Runtime: 0:00:00.014573
2025-11-24 08:34:44.006314 | 
2025-11-24 08:34:44.006374 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-11-24 08:34:44.439778 | controller | ok
2025-11-24 08:34:44.506696 | 
2025-11-24 08:34:44.506787 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-11-24 08:34:44.580938 | controller | skipping: Conditional result was False
2025-11-24 08:34:44.613729 | 
2025-11-24 08:34:44.613809 | TASK [include_role : validate-host]
2025-11-24 08:34:44.720670 | controller | ok
2025-11-24 08:34:44.793240 | 
2025-11-24 08:34:44.793337 | TASK [validate-host : Define zuul_info_dir fact]
2025-11-24 08:34:44.842185 | controller | ok
2025-11-24 08:34:44.852957 | 
2025-11-24 08:34:44.853047 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-11-24 08:34:45.389068 | controller -> localhost | ok
2025-11-24 08:34:45.396034 | 
2025-11-24 08:34:45.396094 | TASK [validate-host : Collect information about the host]
2025-11-24 08:34:46.080591 | controller | ok
2025-11-24 08:34:46.096213 | 
2025-11-24 08:34:46.096284 | TASK [validate-host : Sanitize hostname]
2025-11-24 08:34:46.270009 | controller | ok
2025-11-24 08:34:46.280548 | 
2025-11-24 08:34:46.280638 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-11-24 08:34:47.592988 | controller -> localhost | changed
2025-11-24 08:34:47.598280 | 
2025-11-24 08:34:47.598403 | TASK [validate-host : Collect information about zuul worker]
2025-11-24 08:34:48.118655 | controller | ok
2025-11-24 08:34:48.124607 | 
2025-11-24 08:34:48.124686 | TASK [validate-host : Write out all zuul information for each host]
2025-11-24 08:34:49.421269 | controller -> localhost | changed
2025-11-24 08:34:49.445468 | 
2025-11-24 08:34:49.445558 | TASK [include_role : prepare-workspace-openshift]
2025-11-24 08:34:49.501799 | controller | skipping: Conditional result was False
2025-11-24 08:34:49.510154 | 
2025-11-24 08:34:49.510224 | TASK [include_role : remove-zuul-sshkey]
2025-11-24 08:34:49.555119 | controller | skipping: Conditional result was False
2025-11-24 08:34:49.562443 | 
2025-11-24 08:34:49.562510 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-11-24 08:34:49.789758 | controller | ok: "logs"
2025-11-24 08:34:49.790018 | controller | ok: All items complete
2025-11-24 08:34:49.790048 | 
2025-11-24 08:34:49.977662 | controller | ok: "artifacts"
2025-11-24 08:34:50.156543 | controller | ok: "docs"
2025-11-24 08:34:50.163494 | 
2025-11-24 08:34:50.163589 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-11-24 08:34:50.451811 | controller | changed: "logs"
2025-11-24 08:34:50.639516 | controller | changed: "artifacts"
2025-11-24 08:34:50.834933 | controller | changed: "docs"
2025-11-24 08:34:50.872819 | 
2025-11-24 08:34:50.872900 | PLAY RECAP
2025-11-24 08:34:50.872945 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-11-24 08:34:50.872993 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-11-24 08:34:50.873016 | 
2025-11-24 08:34:51.248784 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-11-24 08:34:51.250027 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-11-24 08:34:53.073356 | 
2025-11-24 08:34:53.073486 | PLAY [all]
2025-11-24 08:34:53.165407 | 
2025-11-24 08:34:53.166501 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-11-24 08:34:53.378778 | controller | ok
2025-11-24 08:34:53.389294 | 
2025-11-24 08:34:53.389378 | TASK [mirror-info-fork : Create /etc/ci]
2025-11-24 08:34:54.007198 | controller | changed
2025-11-24 08:34:54.013886 | 
2025-11-24 08:34:54.013977 | TASK [mirror-info-fork : Install ci_mirror script]
2025-11-24 08:34:55.651012 | controller | changed
2025-11-24 08:34:55.702579 | 
2025-11-24 08:34:55.702698 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-11-24 08:34:56.726573 | controller | changed:
2025-11-24 08:34:56.726819 | controller | {
2025-11-24 08:34:56.726858 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-11-24 08:34:56.726899 | controller | }
2025-11-24 08:34:56.941622 | controller | changed:
2025-11-24 08:34:56.941709 | controller | {
2025-11-24 08:34:56.941738 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-11-24 08:34:56.941761 | controller | }
2025-11-24 08:34:57.171901 | controller | changed:
2025-11-24 08:34:57.172033 | controller | {
2025-11-24 08:34:57.172065 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2025-11-24 08:34:57.172087 | controller | }
2025-11-24 08:34:57.376150 | controller | changed:
2025-11-24 08:34:57.376230 | controller | {
2025-11-24 08:34:57.376258 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-11-24 08:34:57.376279 | controller | }
2025-11-24 08:34:57.603612 | controller | changed:
2025-11-24 08:34:57.603694 | controller | {
2025-11-24 08:34:57.603721 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-11-24 08:34:57.603742 | controller | }
2025-11-24 08:34:57.831627 | controller | changed:
2025-11-24 08:34:57.831712 | controller | {
2025-11-24 08:34:57.831740 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-11-24 08:34:57.831761 | controller | }
2025-11-24 08:34:58.057677 | controller | changed:
2025-11-24 08:34:58.057812 | controller | {
2025-11-24 08:34:58.057846 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen"
2025-11-24 08:34:58.057871 | controller | }
2025-11-24 08:34:58.276763 | controller | changed:
2025-11-24 08:34:58.276840 | controller | {
2025-11-24 08:34:58.276870 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora"
2025-11-24 08:34:58.276894 | controller | }
2025-11-24 08:34:58.571830 | controller | changed:
2025-11-24 08:34:58.571927 | controller | {
2025-11-24 08:34:58.571957 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-11-24 08:34:58.571992 | controller | }
2025-11-24 08:34:58.735931 | controller | changed:
2025-11-24 08:34:58.736068 | controller | {
2025-11-24 08:34:58.736096 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-11-24 08:34:58.736117 | controller | }
2025-11-24 08:34:58.959196 | controller | changed:
2025-11-24 08:34:58.959289 | controller | {
2025-11-24 08:34:58.959318 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-11-24 08:34:58.959339 | controller | }
2025-11-24 08:34:59.183216 | controller | changed:
2025-11-24 08:34:59.183301 | controller | {
2025-11-24 08:34:59.183330 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-11-24 08:34:59.183357 | controller | }
2025-11-24 08:34:59.420169 | controller | changed:
2025-11-24 08:34:59.420258 | controller | {
2025-11-24 08:34:59.420285 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-11-24 08:34:59.420306 | controller | }
2025-11-24 08:34:59.656503 | controller | changed:
2025-11-24 08:34:59.656587 | controller | {
2025-11-24 08:34:59.656618 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-11-24 08:34:59.656641 | controller | }
2025-11-24 08:34:59.888499 | controller | changed:
2025-11-24 08:34:59.888586 | controller | {
2025-11-24 08:34:59.888614 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-11-24 08:34:59.888637 | controller | }
2025-11-24 08:35:00.102303 | controller | changed:
2025-11-24 08:35:00.102420 | controller | {
2025-11-24 08:35:00.102455 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-11-24 08:35:00.102477 | controller | }
2025-11-24 08:35:00.329486 | controller | changed:
2025-11-24 08:35:00.329657 | controller | {
2025-11-24 08:35:00.329695 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com"
2025-11-24 08:35:00.329721 | controller | }
2025-11-24 08:35:00.558332 | controller | changed:
2025-11-24 08:35:00.558434 | controller | {
2025-11-24 08:35:00.558463 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb"
2025-11-24 08:35:00.558491 | controller | }
2025-11-24 08:35:00.807206 | controller | changed:
2025-11-24 08:35:00.807293 | controller | {
2025-11-24 08:35:00.807321 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-11-24 08:35:00.807342 | controller | }
2025-11-24 08:35:01.012445 | controller | changed:
2025-11-24 08:35:01.012528 | controller | {
2025-11-24 08:35:01.012556 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-11-24 08:35:01.012577 | controller | }
2025-11-24 08:35:01.213049 | controller | changed:
2025-11-24 08:35:01.213132 | controller | {
2025-11-24 08:35:01.213171 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-11-24 08:35:01.213193 | controller | }
2025-11-24 08:35:01.426922 | controller | changed:
2025-11-24 08:35:01.427109 | controller | {
2025-11-24 08:35:01.427149 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-11-24 08:35:01.427173 | controller | }
2025-11-24 08:35:01.633166 | controller | changed:
2025-11-24 08:35:01.633253 | controller | {
2025-11-24 08:35:01.633279 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com"
2025-11-24 08:35:01.633300 | controller | }
2025-11-24 08:35:01.839266 | controller | changed:
2025-11-24 08:35:01.839350 | controller | {
2025-11-24 08:35:01.839376 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-11-24 08:35:01.839452 | controller | }
2025-11-24 08:35:02.060824 | controller | changed:
2025-11-24 08:35:02.060919 | controller | {
2025-11-24 08:35:02.060952 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-11-24 08:35:02.060992 | controller | }
2025-11-24 08:35:02.268077 | controller | changed:
2025-11-24 08:35:02.268156 | controller | {
2025-11-24 08:35:02.268183 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-11-24 08:35:02.268204 | controller | }
2025-11-24 08:35:02.294880 | 
2025-11-24 08:35:02.301499 | TASK [Set timezone to UTC]
2025-11-24 08:35:03.182452 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-11-24 08:35:03.196070 | 
2025-11-24 08:35:03.196146 | TASK [Create nodepool directory]
2025-11-24 08:35:03.466112 | controller | changed
2025-11-24 08:35:03.479182 | 
2025-11-24 08:35:03.479251 | TASK [Create nodepool sub_nodes file]
2025-11-24 08:35:04.236043 | controller | changed
2025-11-24 08:35:04.243274 | 
2025-11-24 08:35:04.243342 | TASK [Create nodepool sub_nodes_private file]
2025-11-24 08:35:04.981500 | controller | changed
2025-11-24 08:35:04.988627 | 
2025-11-24 08:35:04.988692 | LOOP [Populate nodepool sub_nodes file]
2025-11-24 08:35:05.088828 | 
2025-11-24 08:35:05.089068 | LOOP [Populate nodepool sub_nodes_private file]
2025-11-24 08:35:05.220377 | 
2025-11-24 08:35:05.220558 | TASK [Create nodepool primary file]
2025-11-24 08:35:05.321519 | controller | skipping: Conditional result was False
2025-11-24 08:35:05.335190 | 
2025-11-24 08:35:05.335272 | TASK [Create nodepool node_private for this node]
2025-11-24 08:35:06.095784 | controller | changed
2025-11-24 08:35:06.103334 | 
2025-11-24 08:35:06.103421 | LOOP [Copy ssh keys to nodepool directory]
2025-11-24 08:35:06.690676 | controller | ok: Item: id_rsa Runtime: 0:00:00.004823
2025-11-24 08:35:06.690847 | 
2025-11-24 08:35:06.854130 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004956
2025-11-24 08:35:06.866764 | 
2025-11-24 08:35:06.866860 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-11-24 08:35:07.568180 | controller | changed
2025-11-24 08:35:07.577476 | 
2025-11-24 08:35:07.577552 | TASK [Validate sudoers config after edits]
2025-11-24 08:35:07.928729 | controller | /etc/sudoers: parsed OK
2025-11-24 08:35:07.928801 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-11-24 08:35:07.928812 | controller | /etc/sudoers.d/zuul: parsed OK
2025-11-24 08:35:07.928818 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-11-24 08:35:08.167891 | controller | ok: Runtime: 0:00:00.005410
2025-11-24 08:35:08.175022 | 
2025-11-24 08:35:08.175087 | TASK [Show the environment passed in to job shell scripts]
2025-11-24 08:35:08.537666 | controller | SHELL=/bin/bash
2025-11-24 08:35:08.537714 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2025-11-24 08:35:08.537724 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2025-11-24 08:35:08.537730 | controller | ZUUL_CHANGES=rdo-jobs:master:refs/changes/88/58488/1^openstack-k8s-operators/ci-framework:main:refs/changes/51/3451/9e962b797235f287fc3e87d5e76ab3a88eb03cd8
2025-11-24 08:35:08.537737 | controller | PWD=/home/zuul
2025-11-24 08:35:08.537743 | controller | ZUUL_PIPELINE=github-check
2025-11-24 08:35:08.537748 | controller | LOGNAME=zuul
2025-11-24 08:35:08.537754 | controller | XDG_SESSION_TYPE=tty
2025-11-24 08:35:08.537759 | controller | _=/usr/bin/env
2025-11-24 08:35:08.537801 | controller | MOTD_SHOWN=pam
2025-11-24 08:35:08.537809 | controller | HOME=/home/zuul
2025-11-24 08:35:08.537815 | controller | LANG=en_US.UTF-8
2025-11-24 08:35:08.537820 | controller | SSH_CONNECTION=192.168.25.12 41468 192.168.25.42 22
2025-11-24 08:35:08.537826 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET
2025-11-24 08:35:08.537833 | controller | ZUUL_CHANGE_IDS=58488,1 3451,9e962b797235f287fc3e87d5e76ab3a88eb03cd8
2025-11-24 08:35:08.537839 | controller | WORKSPACE=/home/zuul/workspace
2025-11-24 08:35:08.537844 | controller | XDG_SESSION_CLASS=user
2025-11-24 08:35:08.537850 | controller | SELINUX_ROLE_REQUESTED=
2025-11-24 08:35:08.537855 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-11-24 08:35:08.537860 | controller | USER=zuul
2025-11-24 08:35:08.537890 | controller | ZUUL_VOTING=True
2025-11-24 08:35:08.537896 | controller | BUILD_TIMEOUT=1800000
2025-11-24 08:35:08.537901 | controller | SELINUX_USE_CURRENT_RANGE=
2025-11-24 08:35:08.537906 | controller | SHLVL=1
2025-11-24 08:35:08.537912 | controller | ZUUL_PATCHSET=9e962b797235f287fc3e87d5e76ab3a88eb03cd8
2025-11-24 08:35:08.537917 | controller | XDG_SESSION_ID=1
2025-11-24 08:35:08.537923 | controller | ZUUL_BRANCH=main
2025-11-24 08:35:08.537929 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-11-24 08:35:08.537934 | controller | SSH_CLIENT=192.168.25.12 41468 22
2025-11-24 08:35:08.537939 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-11-24 08:35:08.537945 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-11-24 08:35:08.537952 | controller | which_declare=declare -f
2025-11-24 08:35:08.537958 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-11-24 08:35:08.537964 | controller | SELINUX_LEVEL_REQUESTED=
2025-11-24 08:35:08.537969 | controller | ZUUL_CHANGE=3451
2025-11-24 08:35:08.537975 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-11-24 08:35:08.537980 | controller | ZUUL_UUID=ac15b306401046d9b4e704832eed6e9b
2025-11-24 08:35:08.537986 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-11-24 08:35:08.537991 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-11-24 08:35:08.537997 | controller | }
2025-11-24 08:35:08.804102 | controller | ok: Runtime: 0:00:00.005921
2025-11-24 08:35:08.810124 | 
2025-11-24 08:35:08.810188 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-11-24 08:35:08.882330 | controller | skipping: Conditional result was False
2025-11-24 08:35:08.888916 | 
2025-11-24 08:35:08.889011 | TASK [Symlink /home/zuul-worker/workspace]
2025-11-24 08:35:09.458791 | controller | skipping: Conditional result was False
2025-11-24 08:35:09.465690 | 
2025-11-24 08:35:09.465776 | TASK [Ensure legacy workspace directory]
2025-11-24 08:35:09.814138 | controller | changed
2025-11-24 08:35:09.856588 | 
2025-11-24 08:35:09.856665 | PLAY RECAP
2025-11-24 08:35:09.856709 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-11-24 08:35:09.856734 | 
2025-11-24 08:35:10.029785 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-11-24 08:35:10.030521 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-11-24 08:35:11.249922 | 
2025-11-24 08:35:11.250026 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2025-11-24 08:35:11.280751 | 
2025-11-24 08:35:11.280824 | TASK [Create zuul-output directory]
2025-11-24 08:35:11.657740 | controller | changed
2025-11-24 08:35:11.667706 | 
2025-11-24 08:35:11.667791 | TASK [Slurp Zuul inventory test]
2025-11-24 08:35:12.181289 | controller -> localhost | ok
2025-11-24 08:35:12.187603 | 
2025-11-24 08:35:12.187679 | TASK [Save zuul inventory]
2025-11-24 08:35:13.085464 | controller | changed
2025-11-24 08:35:13.091271 | 
2025-11-24 08:35:13.091343 | TASK [Save zuul vars without the change_message]
2025-11-24 08:35:13.682068 | controller | changed
2025-11-24 08:35:13.701897 | 
2025-11-24 08:35:13.702023 | PLAY RECAP
2025-11-24 08:35:13.702072 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-11-24 08:35:13.702098 | 
2025-11-24 08:35:13.806755 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-11-24 08:35:13.807749 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-11-24 08:35:14.480263 | 
2025-11-24 08:35:14.480362 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2025-11-24 08:35:14.511540 | 
2025-11-24 08:35:14.511614 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2025-11-24 08:35:14.545303 | controller | ok
2025-11-24 08:35:14.566222 | 
2025-11-24 08:35:14.566307 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-11-24 08:35:14.589499 | controller | skipping: Conditional result was False
2025-11-24 08:35:14.595275 | 
2025-11-24 08:35:14.595344 | TASK [mirror-info-fork : Create /etc/ci]
2025-11-24 08:35:14.972730 | controller | ok
2025-11-24 08:35:14.978999 | 
2025-11-24 08:35:14.979069 | TASK [mirror-info-fork : Install ci_mirror script]
2025-11-24 08:35:15.905149 | controller | ok
2025-11-24 08:35:15.921378 | 
2025-11-24 08:35:15.921492 | TASK [Prepare workspace]
2025-11-24 08:35:15.965030 | controller | ok
2025-11-24 08:35:16.000914 | 
2025-11-24 08:35:16.000999 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-11-24 08:35:16.393151 | controller | ok
2025-11-24 08:35:16.402946 | 
2025-11-24 08:35:16.403028 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-11-24 08:35:19.469324 | controller | Output suppressed because no_log was given
2025-11-24 08:35:19.478500 | 
2025-11-24 08:35:19.478638 | LOOP [Create zuul-output directory]
2025-11-24 08:35:19.679457 | controller | changed: "/home/zuul/ci-framework-data/logs"
2025-11-24 08:35:19.847127 | controller | ok: "/home/zuul/zuul-output/logs"
2025-11-24 08:35:19.861081 | 
2025-11-24 08:35:19.861152 | TASK [Install required packages]
2025-11-24 08:36:13.085892 | controller | changed
2025-11-24 08:36:13.091086 | 
2025-11-24 08:36:13.091166 | TASK [Install venv]
2025-11-24 08:37:16.441508 | controller | changed
2025-11-24 08:37:16.492455 | 
2025-11-24 08:37:16.492548 | PLAY RECAP
2025-11-24 08:37:16.492589 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-11-24 08:37:16.492612 | 
2025-11-24 08:37:16.572064 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-11-24 08:37:16.572934 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-11-24 08:37:17.109255 | 
2025-11-24 08:37:17.109352 | PLAY [Run ci/playbooks/molecule-test.yml]
2025-11-24 08:37:17.130064 | 
2025-11-24 08:37:17.130143 | TASK [Gather required facts]
2025-11-24 08:37:17.626779 | controller | ok
2025-11-24 08:37:17.632283 | 
2025-11-24 08:37:17.632361 | TASK [Load environment var if instructed to]
2025-11-24 08:37:17.656874 | controller | skipping: Conditional result was False
2025-11-24 08:37:17.662221 | 
2025-11-24 08:37:17.662286 | TASK [Ensure group_vars dir exists]
2025-11-24 08:37:17.984653 | controller | ok
2025-11-24 08:37:17.990761 | 
2025-11-24 08:37:17.990827 | TASK [Print related variables]
2025-11-24 08:37:18.019797 | controller | ok:
2025-11-24 08:37:18.019918 | controller | mol_config_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config_local.yml
2025-11-24 08:37:18.019948 | controller | roles_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance
2025-11-24 08:37:18.024806 | 
2025-11-24 08:37:18.024867 | TASK [Run molecule]
2025-11-24 08:37:18.957280 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2025-11-24 08:37:19.025354 | controller | INFO     Performing prerun with role_name_check=0...
2025-11-24 08:37:37.629095 | controller | WARNING  Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections).
2025-11-24 08:37:37.629546 | controller | WARNING  Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-11-24 08:37:37.630029 | controller | WARNING  Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-11-24 08:37:37.630475 | controller | WARNING  Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-11-24 08:37:37.630975 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+9e962b79 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 1.0.0+9e962b79 (/home/zuul/.ansible/collections/ansible_collections).
2025-11-24 08:37:37.631418 | controller | WARNING  Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-11-24 08:37:37.631845 | controller | WARNING  Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-11-24 08:37:37.632317 | controller | WARNING  Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-11-24 08:37:37.632757 | controller | WARNING  Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-11-24 08:37:37.633211 | controller | WARNING  Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-11-24 08:37:37.633634 | controller | WARNING  Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-11-24 08:37:37.634085 | controller | WARNING  Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-11-24 08:37:37.634512 | controller | WARNING  Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-11-24 08:37:37.634977 | controller | WARNING  Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-11-24 08:37:37.635428 | controller | WARNING  Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-11-24 08:37:37.644752 | controller | INFO     Running default > prepare
2025-11-24 08:37:37.645208 | controller | WARNING  Skipping, prepare playbook not configured.
2025-11-24 08:37:37.652576 | controller | INFO     Running default > converge
2025-11-24 08:37:38.297808 | controller |
2025-11-24 08:37:38.297933 | controller | PLAY [Converge test of controller tasks] ***************************************
2025-11-24 08:37:38.298032 | controller |
2025-11-24 08:37:38.298140 | controller | TASK [Gathering Facts] *********************************************************
2025-11-24 08:37:38.298243 | controller | Monday 24 November 2025  08:37:38 +0000 (0:00:00.010)       0:00:00.010 *******
2025-11-24 08:37:39.155749 | controller | ok: [instance]
2025-11-24 08:37:39.155823 | controller |
2025-11-24 08:37:39.155972 | controller | TASK [compliance : Ensure compliance folder exists] ****************************
2025-11-24 08:37:39.156080 | controller | Monday 24 November 2025  08:37:39 +0000 (0:00:00.858)       0:00:00.869 *******
2025-11-24 08:37:39.460092 | controller | changed: [instance]
2025-11-24 08:37:39.460181 | controller |
2025-11-24 08:37:39.460296 | controller | TASK [compliance : Install the compliance operator and plugin] *****************
2025-11-24 08:37:39.460404 | controller | Monday 24 November 2025  08:37:39 +0000 (0:00:00.304)       0:00:01.173 *******
2025-11-24 08:37:39.494313 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/install.yml for instance
2025-11-24 08:37:39.494432 | controller |
2025-11-24 08:37:39.494579 | controller | TASK [compliance : Create the compliance namespace] ****************************
2025-11-24 08:37:39.494683 | controller | Monday 24 November 2025  08:37:39 +0000 (0:00:00.034)       0:00:01.207 *******
2025-11-24 08:37:39.521764 | controller | skipping: [instance]
2025-11-24 08:37:39.521859 | controller |
2025-11-24 08:37:39.522007 | controller | TASK [compliance : Ensure OperatorGroup for the compliance-operator is present] ***
2025-11-24 08:37:39.522109 | controller | Monday 24 November 2025  08:37:39 +0000 (0:00:00.027)       0:00:01.235 *******
2025-11-24 08:37:39.548295 | controller | skipping: [instance]
2025-11-24 08:37:39.548411 | controller |
2025-11-24 08:37:39.548542 | controller | TASK [compliance : Ensure Subscription for the compliance-operator is present] ***
2025-11-24 08:37:39.548670 | controller | Monday 24 November 2025  08:37:39 +0000 (0:00:00.026)       0:00:01.262 *******
2025-11-24 08:37:39.577492 | controller | skipping: [instance]
2025-11-24 08:37:39.577598 | controller |
2025-11-24 08:37:39.577716 | controller | TASK [compliance : Wait until the compliance-operator csv is present] **********
2025-11-24 08:37:39.577826 | controller | Monday 24 November 2025  08:37:39 +0000 (0:00:00.029)       0:00:01.291 *******
2025-11-24 08:37:39.604148 | controller | skipping: [instance]
2025-11-24 08:37:39.604254 | controller |
2025-11-24 08:37:39.604381 | controller | TASK [compliance : Get full name of the compliance-operator csv] ***************
2025-11-24 08:37:39.604513 | controller | Monday 24 November 2025  08:37:39 +0000 (0:00:00.026)       0:00:01.317 *******
2025-11-24 08:37:39.630563 | controller | skipping: [instance]
2025-11-24 08:37:39.630674 | controller |
2025-11-24 08:37:39.630800 | controller | TASK [compliance : Wait for the compliance-operator csv to Succeed] ************
2025-11-24 08:37:39.630958 | controller | Monday 24 November 2025  08:37:39 +0000 (0:00:00.026)       0:00:01.344 *******
2025-11-24 08:37:39.656656 | controller | skipping: [instance]
2025-11-24 08:37:39.656758 | controller |
2025-11-24 08:37:39.656906 | controller | TASK [podman : Ensure podman is installed] *************************************
2025-11-24 08:37:39.657039 | controller | Monday 24 November 2025  08:37:39 +0000 (0:00:00.026)       0:00:01.370 *******
2025-11-24 08:37:40.413592 | controller | ok: [instance]
2025-11-24 08:37:40.414192 | controller |
2025-11-24 08:37:40.414374 | controller | TASK [podman : Enable loginctl linger for ansible_user_id] *********************
2025-11-24 08:37:40.414523 | controller | Monday 24 November 2025  08:37:40 +0000 (0:00:00.756)       0:00:02.127 *******
2025-11-24 08:37:40.827781 | controller | changed: [instance]
2025-11-24 08:37:40.827829 | controller |
2025-11-24 08:37:40.827951 | controller | TASK [podman : Ensure subordinate UID entry exists for zuul] *******************
2025-11-24 08:37:40.828064 | controller | Monday 24 November 2025  08:37:40 +0000 (0:00:00.414)       0:00:02.541 *******
2025-11-24 08:37:40.850389 | controller | skipping: [instance]
2025-11-24 08:37:40.850476 | controller |
2025-11-24 08:37:40.850586 | controller | TASK [podman : Ensure subordinate GID entry exists for zuul] *******************
2025-11-24 08:37:40.850692 | controller | Monday 24 November 2025  08:37:40 +0000 (0:00:00.022)       0:00:02.564 *******
2025-11-24 08:37:40.870252 | controller | skipping: [instance]
2025-11-24 08:37:40.870345 | controller |
2025-11-24 08:37:40.870461 | controller | TASK [podman : Run podman system migrate if subuid/subgid files were changed] ***
2025-11-24 08:37:40.870570 | controller | Monday 24 November 2025  08:37:40 +0000 (0:00:00.019)       0:00:02.583 *******
2025-11-24 08:37:40.893632 | controller | skipping: [instance]
2025-11-24 08:37:40.893726 | controller |
2025-11-24 08:37:40.893838 | controller | TASK [compliance : Log into registry] ******************************************
2025-11-24 08:37:40.894000 | controller | Monday 24 November 2025  08:37:40 +0000 (0:00:00.023)       0:00:02.607 *******
2025-11-24 08:37:40.910475 | controller | skipping: [instance]
2025-11-24 08:37:40.910591 | controller |
2025-11-24 08:37:40.910727 | controller | TASK [compliance : Copy out the compliance plugin from the oc-compliance image] ***
2025-11-24 08:37:40.910892 | controller | Monday 24 November 2025  08:37:40 +0000 (0:00:00.016)       0:00:02.624 *******
2025-11-24 08:37:40.926480 | controller | skipping: [instance]
2025-11-24 08:37:40.926594 | controller |
2025-11-24 08:37:40.926726 | controller | TASK [compliance : Install packages to process results] ************************
2025-11-24 08:37:40.926852 | controller | Monday 24 November 2025  08:37:40 +0000 (0:00:00.015)       0:00:02.640 *******
2025-11-24 08:37:45.872075 | controller | changed: [instance]
2025-11-24 08:37:45.872405 | controller |
2025-11-24 08:37:45.918019 | controller | TASK [compliance : Run compliance scans and extract results] *******************
2025-11-24 08:37:45.918064 | controller | Monday 24 November 2025  08:37:45 +0000 (0:00:04.945)       0:00:07.585 *******
2025-11-24 08:37:45.918079 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=cis)
2025-11-24 08:37:45.918101 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=e8)
2025-11-24 08:37:45.918111 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=high)
2025-11-24 08:37:45.918788 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=moderate)
2025-11-24 08:37:45.937808 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=nerc-cip)
2025-11-24 08:37:45.937845 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=pci-dss)
2025-11-24 08:37:45.937854 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=stig)
2025-11-24 08:37:45.937860 | controller |
2025-11-24 08:37:45.937889 | controller | TASK [compliance : Log start of scans] *****************************************
2025-11-24 08:37:45.937896 | controller | Monday 24 November 2025  08:37:45 +0000 (0:00:00.045)       0:00:07.631 *******
2025-11-24 08:37:45.937906 | controller | ok: [instance] =>
2025-11-24 08:37:45.964981 | controller |   msg: Starting scans for cis
2025-11-24 08:37:45.965018 | controller |
2025-11-24 08:37:45.965028 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-11-24 08:37:45.965035 | controller | Monday 24 November 2025  08:37:45 +0000 (0:00:00.019)       0:00:07.651 *******
2025-11-24 08:37:45.965049 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-cis)
2025-11-24 08:37:45.984949 | controller |
2025-11-24 08:37:45.984980 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:45.984988 | controller | Monday 24 November 2025  08:37:45 +0000 (0:00:00.027)       0:00:07.678 *******
2025-11-24 08:37:45.985007 | controller | ok: [instance]
2025-11-24 08:37:45.985033 | controller |
2025-11-24 08:37:45.985313 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:46.001012 | controller | Monday 24 November 2025  08:37:45 +0000 (0:00:00.020)       0:00:07.698 *******
2025-11-24 08:37:46.001042 | controller | skipping: [instance]
2025-11-24 08:37:46.001214 | controller |
2025-11-24 08:37:46.001391 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:46.001563 | controller | Monday 24 November 2025  08:37:45 +0000 (0:00:00.016)       0:00:07.714 *******
2025-11-24 08:37:46.017333 | controller | skipping: [instance]
2025-11-24 08:37:46.017508 | controller |
2025-11-24 08:37:46.017679 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:46.017903 | controller | Monday 24 November 2025  08:37:46 +0000 (0:00:00.016)       0:00:07.731 *******
2025-11-24 08:37:46.196539 | controller | ok: [instance]
2025-11-24 08:37:46.381552 | controller |
2025-11-24 08:37:46.381582 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:46.381589 | controller | Monday 24 November 2025  08:37:46 +0000 (0:00:00.178)       0:00:07.909 *******
2025-11-24 08:37:46.381600 | controller | changed: [instance]
2025-11-24 08:37:46.397769 | controller |
2025-11-24 08:37:46.397788 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:46.397795 | controller | Monday 24 November 2025  08:37:46 +0000 (0:00:00.185)       0:00:08.094 *******
2025-11-24 08:37:46.397804 | controller | skipping: [instance]
2025-11-24 08:37:46.674385 | controller |
2025-11-24 08:37:46.674416 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:46.674424 | controller | Monday 24 November 2025  08:37:46 +0000 (0:00:00.016)       0:00:08.111 *******
2025-11-24 08:37:46.674434 | controller | ok: [instance]
2025-11-24 08:37:46.688623 | controller |
2025-11-24 08:37:46.688649 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:46.688657 | controller | Monday 24 November 2025  08:37:46 +0000 (0:00:00.276)       0:00:08.387 *******
2025-11-24 08:37:46.688667 | controller | skipping: [instance]
2025-11-24 08:37:46.706950 | controller |
2025-11-24 08:37:46.706983 | controller | TASK [compliance : Log start of scans] *****************************************
2025-11-24 08:37:46.706991 | controller | Monday 24 November 2025  08:37:46 +0000 (0:00:00.014)       0:00:08.402 *******
2025-11-24 08:37:46.707002 | controller | ok: [instance] =>
2025-11-24 08:37:46.707025 | controller |   msg: Starting scans for e8
2025-11-24 08:37:46.707034 | controller |
2025-11-24 08:37:46.707259 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-11-24 08:37:46.739366 | controller | Monday 24 November 2025  08:37:46 +0000 (0:00:00.018)       0:00:08.420 *******
2025-11-24 08:37:46.739396 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-e8)
2025-11-24 08:37:46.760928 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-e8)
2025-11-24 08:37:46.760952 | controller |
2025-11-24 08:37:46.760962 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:46.760969 | controller | Monday 24 November 2025  08:37:46 +0000 (0:00:00.032)       0:00:08.452 *******
2025-11-24 08:37:46.760981 | controller | ok: [instance]
2025-11-24 08:37:46.761121 | controller |
2025-11-24 08:37:46.761136 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:46.761308 | controller | Monday 24 November 2025  08:37:46 +0000 (0:00:00.021)       0:00:08.474 *******
2025-11-24 08:37:46.777794 | controller | skipping: [instance]
2025-11-24 08:37:46.777982 | controller |
2025-11-24 08:37:46.778133 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:46.778274 | controller | Monday 24 November 2025  08:37:46 +0000 (0:00:00.017)       0:00:08.491 *******
2025-11-24 08:37:46.794559 | controller | skipping: [instance]
2025-11-24 08:37:46.794710 | controller |
2025-11-24 08:37:46.794895 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:46.795056 | controller | Monday 24 November 2025  08:37:46 +0000 (0:00:00.016)       0:00:08.508 *******
2025-11-24 08:37:46.973413 | controller | ok: [instance]
2025-11-24 08:37:47.161733 | controller |
2025-11-24 08:37:47.161764 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:47.161772 | controller | Monday 24 November 2025  08:37:46 +0000 (0:00:00.178)       0:00:08.686 *******
2025-11-24 08:37:47.161781 | controller | changed: [instance]
2025-11-24 08:37:47.178849 | controller |
2025-11-24 08:37:47.178905 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:47.178916 | controller | Monday 24 November 2025  08:37:47 +0000 (0:00:00.188)       0:00:08.875 *******
2025-11-24 08:37:47.178932 | controller | skipping: [instance]
2025-11-24 08:37:47.355667 | controller |
2025-11-24 08:37:47.355698 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:47.355706 | controller | Monday 24 November 2025  08:37:47 +0000 (0:00:00.017)       0:00:08.892 *******
2025-11-24 08:37:47.355716 | controller | ok: [instance]
2025-11-24 08:37:47.369952 | controller |
2025-11-24 08:37:47.369986 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:47.369993 | controller | Monday 24 November 2025  08:37:47 +0000 (0:00:00.176)       0:00:09.068 *******
2025-11-24 08:37:47.370004 | controller | skipping: [instance]
2025-11-24 08:37:47.370027 | controller |
2025-11-24 08:37:47.370035 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:47.370115 | controller | Monday 24 November 2025  08:37:47 +0000 (0:00:00.014)       0:00:09.083 *******
2025-11-24 08:37:47.390948 | controller | ok: [instance]
2025-11-24 08:37:47.390998 | controller |
2025-11-24 08:37:47.391248 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:47.407902 | controller | Monday 24 November 2025  08:37:47 +0000 (0:00:00.020)       0:00:09.104 *******
2025-11-24 08:37:47.407931 | controller | skipping: [instance]
2025-11-24 08:37:47.423932 | controller |
2025-11-24 08:37:47.423959 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:47.423967 | controller | Monday 24 November 2025  08:37:47 +0000 (0:00:00.016)       0:00:09.121 *******
2025-11-24 08:37:47.423977 | controller | skipping: [instance]
2025-11-24 08:37:47.424016 | controller |
2025-11-24 08:37:47.424025 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:47.424034 | controller | Monday 24 November 2025  08:37:47 +0000 (0:00:00.016)       0:00:09.137 *******
2025-11-24 08:37:47.607947 | controller | ok: [instance]
2025-11-24 08:37:47.608163 | controller |
2025-11-24 08:37:47.608183 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:47.795349 | controller | Monday 24 November 2025  08:37:47 +0000 (0:00:00.183)       0:00:09.321 *******
2025-11-24 08:37:47.795382 | controller | changed: [instance]
2025-11-24 08:37:47.832676 | controller |
2025-11-24 08:37:47.832704 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:47.832711 | controller | Monday 24 November 2025  08:37:47 +0000 (0:00:00.187)       0:00:09.508 *******
2025-11-24 08:37:47.832721 | controller | skipping: [instance]
2025-11-24 08:37:48.005628 | controller |
2025-11-24 08:37:48.005658 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:48.005666 | controller | Monday 24 November 2025  08:37:47 +0000 (0:00:00.037)       0:00:09.546 *******
2025-11-24 08:37:48.005676 | controller | ok: [instance]
2025-11-24 08:37:48.019885 | controller |
2025-11-24 08:37:48.019912 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:48.019920 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.172)       0:00:09.718 *******
2025-11-24 08:37:48.019930 | controller | skipping: [instance]
2025-11-24 08:37:48.039445 | controller |
2025-11-24 08:37:48.039472 | controller | TASK [compliance : Log start of scans] *****************************************
2025-11-24 08:37:48.039480 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.014)       0:00:09.733 *******
2025-11-24 08:37:48.039490 | controller | ok: [instance] =>
2025-11-24 08:37:48.078790 | controller |   msg: Starting scans for high
2025-11-24 08:37:48.078834 | controller |
2025-11-24 08:37:48.078842 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-11-24 08:37:48.078848 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.019)       0:00:09.752 *******
2025-11-24 08:37:48.078857 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-high)
2025-11-24 08:37:48.099229 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-high-node)
2025-11-24 08:37:48.099256 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-high)
2025-11-24 08:37:48.099265 | controller |
2025-11-24 08:37:48.099272 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:48.099280 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.039)       0:00:09.791 *******
2025-11-24 08:37:48.099290 | controller | ok: [instance]
2025-11-24 08:37:48.115915 | controller |
2025-11-24 08:37:48.115935 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:48.115943 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.020)       0:00:09.812 *******
2025-11-24 08:37:48.115952 | controller | skipping: [instance]
2025-11-24 08:37:48.116008 | controller |
2025-11-24 08:37:48.116022 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:48.116031 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.016)       0:00:09.829 *******
2025-11-24 08:37:48.132959 | controller | skipping: [instance]
2025-11-24 08:37:48.133144 | controller |
2025-11-24 08:37:48.133316 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:48.133498 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.017)       0:00:09.846 *******
2025-11-24 08:37:48.310963 | controller | ok: [instance]
2025-11-24 08:37:48.311292 | controller |
2025-11-24 08:37:48.491971 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:48.492000 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.177)       0:00:10.024 *******
2025-11-24 08:37:48.492012 | controller | changed: [instance]
2025-11-24 08:37:48.508737 | controller |
2025-11-24 08:37:48.508761 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:48.508768 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.180)       0:00:10.205 *******
2025-11-24 08:37:48.508778 | controller | skipping: [instance]
2025-11-24 08:37:48.679720 | controller |
2025-11-24 08:37:48.679750 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:48.679758 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.016)       0:00:10.222 *******
2025-11-24 08:37:48.679768 | controller | ok: [instance]
2025-11-24 08:37:48.695015 | controller |
2025-11-24 08:37:48.695038 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:48.695045 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.170)       0:00:10.392 *******
2025-11-24 08:37:48.695055 | controller | skipping: [instance]
2025-11-24 08:37:48.715458 | controller |
2025-11-24 08:37:48.715480 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:48.715487 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.015)       0:00:10.408 *******
2025-11-24 08:37:48.715496 | controller | ok: [instance]
2025-11-24 08:37:48.732202 | controller |
2025-11-24 08:37:48.732224 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:48.732231 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.020)       0:00:10.429 *******
2025-11-24 08:37:48.732240 | controller | skipping: [instance]
2025-11-24 08:37:48.749260 | controller |
2025-11-24 08:37:48.749280 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:48.749287 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.016)       0:00:10.445 *******
2025-11-24 08:37:48.749296 | controller | skipping: [instance]
2025-11-24 08:37:48.922513 | controller |
2025-11-24 08:37:48.922543 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:48.922550 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.017)       0:00:10.462 *******
2025-11-24 08:37:48.922560 | controller | ok: [instance]
2025-11-24 08:37:49.109358 | controller |
2025-11-24 08:37:49.109388 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:49.109397 | controller | Monday 24 November 2025  08:37:48 +0000 (0:00:00.173)       0:00:10.635 *******
2025-11-24 08:37:49.109407 | controller | changed: [instance]
2025-11-24 08:37:49.126559 | controller |
2025-11-24 08:37:49.126585 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:49.126592 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.186)       0:00:10.822 *******
2025-11-24 08:37:49.126602 | controller | skipping: [instance]
2025-11-24 08:37:49.299181 | controller |
2025-11-24 08:37:49.299210 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:49.299217 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.017)       0:00:10.840 *******
2025-11-24 08:37:49.299228 | controller | ok: [instance]
2025-11-24 08:37:49.313250 | controller |
2025-11-24 08:37:49.313275 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:49.313283 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.172)       0:00:11.012 *******
2025-11-24 08:37:49.313292 | controller | skipping: [instance]
2025-11-24 08:37:49.332961 | controller |
2025-11-24 08:37:49.332987 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:49.332995 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.014)       0:00:11.026 *******
2025-11-24 08:37:49.333005 | controller | ok: [instance]
2025-11-24 08:37:49.348241 | controller |
2025-11-24 08:37:49.348263 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:49.348270 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.019)       0:00:11.046 *******
2025-11-24 08:37:49.348279 | controller | skipping: [instance]
2025-11-24 08:37:49.362884 | controller |
2025-11-24 08:37:49.362908 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:49.362916 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.015)       0:00:11.061 *******
2025-11-24 08:37:49.362934 | controller | skipping: [instance]
2025-11-24 08:37:49.531947 | controller |
2025-11-24 08:37:49.531976 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:49.531984 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.014)       0:00:11.076 *******
2025-11-24 08:37:49.531994 | controller | ok: [instance]
2025-11-24 08:37:49.532017 | controller |
2025-11-24 08:37:49.532025 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:49.532136 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.169)       0:00:11.245 *******
2025-11-24 08:37:49.710783 | controller | changed: [instance]
2025-11-24 08:37:49.726065 | controller |
2025-11-24 08:37:49.726094 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:49.726102 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.178)       0:00:11.424 *******
2025-11-24 08:37:49.726112 | controller | skipping: [instance]
2025-11-24 08:37:49.896306 | controller |
2025-11-24 08:37:49.896334 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:49.896342 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.015)       0:00:11.439 *******
2025-11-24 08:37:49.896353 | controller | ok: [instance]
2025-11-24 08:37:49.908638 | controller |
2025-11-24 08:37:49.908663 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:49.908671 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.170)       0:00:11.609 *******
2025-11-24 08:37:49.908680 | controller | skipping: [instance]
2025-11-24 08:37:49.924940 | controller |
2025-11-24 08:37:49.924966 | controller | TASK [compliance : Log start of scans] *****************************************
2025-11-24 08:37:49.924973 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.012)       0:00:11.622 *******
2025-11-24 08:37:49.924990 | controller | ok: [instance] =>
2025-11-24 08:37:49.925014 | controller |   msg: Starting scans for moderate
2025-11-24 08:37:49.925286 | controller |
2025-11-24 08:37:49.959939 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-11-24 08:37:49.959964 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.016)       0:00:11.638 *******
2025-11-24 08:37:49.959977 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-moderate)
2025-11-24 08:37:49.960200 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-moderate-node)
2025-11-24 08:37:49.960219 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-moderate)
2025-11-24 08:37:49.960228 | controller |
2025-11-24 08:37:49.960239 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:49.977927 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.034)       0:00:11.673 *******
2025-11-24 08:37:49.977949 | controller | ok: [instance]
2025-11-24 08:37:49.977971 | controller |
2025-11-24 08:37:49.977979 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:49.978117 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.018)       0:00:11.691 *******
2025-11-24 08:37:49.992312 | controller | skipping: [instance]
2025-11-24 08:37:50.006749 | controller |
2025-11-24 08:37:50.006771 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:50.006780 | controller | Monday 24 November 2025  08:37:49 +0000 (0:00:00.014)       0:00:11.705 *******
2025-11-24 08:37:50.006791 | controller | skipping: [instance]
2025-11-24 08:37:50.175357 | controller |
2025-11-24 08:37:50.175386 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:50.175394 | controller | Monday 24 November 2025  08:37:50 +0000 (0:00:00.014)       0:00:11.720 *******
2025-11-24 08:37:50.175404 | controller | ok: [instance]
2025-11-24 08:37:50.351634 | controller |
2025-11-24 08:37:50.351663 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:50.351671 | controller | Monday 24 November 2025  08:37:50 +0000 (0:00:00.168)       0:00:11.888 *******
2025-11-24 08:37:50.351681 | controller | changed: [instance]
2025-11-24 08:37:50.366073 | controller |
2025-11-24 08:37:50.366096 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:50.366104 | controller | Monday 24 November 2025  08:37:50 +0000 (0:00:00.176)       0:00:12.065 *******
2025-11-24 08:37:50.366113 | controller | skipping: [instance]
2025-11-24 08:37:50.531289 | controller |
2025-11-24 08:37:50.531318 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:50.531326 | controller | Monday 24 November 2025  08:37:50 +0000 (0:00:00.014)       0:00:12.079 *******
2025-11-24 08:37:50.531336 | controller | ok: [instance]
2025-11-24 08:37:50.544226 | controller |
2025-11-24 08:37:50.544252 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:50.544261 | controller | Monday 24 November 2025  08:37:50 +0000 (0:00:00.164)       0:00:12.244 *******
2025-11-24 08:37:50.544272 | controller | skipping: [instance]
2025-11-24 08:37:50.564002 | controller |
2025-11-24 08:37:50.564028 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:50.564044 | controller | Monday 24 November 2025  08:37:50 +0000 (0:00:00.013)       0:00:12.257 *******
2025-11-24 08:37:50.564056 | controller | ok: [instance]
2025-11-24 08:37:50.564104 | controller |
2025-11-24 08:37:50.564119 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:50.564128 | controller | Monday 24 November 2025  08:37:50 +0000 (0:00:00.019)       0:00:12.277 *******
2025-11-24 08:37:50.580594 | controller | skipping: [instance]
2025-11-24 08:37:50.596914 | controller |
2025-11-24 08:37:50.596933 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:50.596941 | controller | Monday 24 November 2025  08:37:50 +0000 (0:00:00.016)       0:00:12.294 *******
2025-11-24 08:37:50.596956 | controller | skipping: [instance]
2025-11-24 08:37:50.773927 | controller |
2025-11-24 08:37:50.773960 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:50.773968 | controller | Monday 24 November 2025  08:37:50 +0000 (0:00:00.016)       0:00:12.310 *******
2025-11-24 08:37:50.773978 | controller | ok: [instance]
2025-11-24 08:37:50.957655 | controller |
2025-11-24 08:37:50.957684 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:50.957692 | controller | Monday 24 November 2025  08:37:50 +0000 (0:00:00.176)       0:00:12.487 *******
2025-11-24 08:37:50.957702 | controller | changed: [instance]
2025-11-24 08:37:50.974318 | controller |
2025-11-24 08:37:50.974343 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:50.974350 | controller | Monday 24 November 2025  08:37:50 +0000 (0:00:00.183)       0:00:12.670 *******
2025-11-24 08:37:50.974359 | controller | skipping: [instance]
2025-11-24 08:37:51.145892 | controller |
2025-11-24 08:37:51.145925 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:51.145934 | controller | Monday 24 November 2025  08:37:50 +0000 (0:00:00.016)       0:00:12.687 *******
2025-11-24 08:37:51.145944 | controller | ok: [instance]
2025-11-24 08:37:51.160530 | controller |
2025-11-24 08:37:51.160556 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:51.160565 | controller | Monday 24 November 2025  08:37:51 +0000 (0:00:00.171)       0:00:12.859 *******
2025-11-24 08:37:51.160577 | controller | skipping: [instance]
2025-11-24 08:37:51.180851 | controller |
2025-11-24 08:37:51.180887 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:51.180895 | controller | Monday 24 November 2025  08:37:51 +0000 (0:00:00.014)       0:00:12.873 *******
2025-11-24 08:37:51.180904 | controller | ok: [instance]
2025-11-24 08:37:51.197923 | controller |
2025-11-24 08:37:51.197946 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:51.197954 | controller | Monday 24 November 2025  08:37:51 +0000 (0:00:00.020)       0:00:12.894 *******
2025-11-24 08:37:51.197963 | controller | skipping: [instance]
2025-11-24 08:37:51.198150 | controller |
2025-11-24 08:37:51.198171 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:51.214347 | controller | Monday 24 November 2025  08:37:51 +0000 (0:00:00.017)       0:00:12.911 *******
2025-11-24 08:37:51.214371 | controller | skipping: [instance]
2025-11-24 08:37:51.394834 | controller |
2025-11-24 08:37:51.394899 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:51.394912 | controller | Monday 24 November 2025  08:37:51 +0000 (0:00:00.016)       0:00:12.927 *******
2025-11-24 08:37:51.394923 | controller | ok: [instance]
2025-11-24 08:37:51.586322 | controller |
2025-11-24 08:37:51.586352 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:51.586361 | controller | Monday 24 November 2025  08:37:51 +0000 (0:00:00.180)       0:00:13.108 *******
2025-11-24 08:37:51.586371 | controller | changed: [instance]
2025-11-24 08:37:51.603386 | controller |
2025-11-24 08:37:51.603414 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:51.603422 | controller | Monday 24 November 2025  08:37:51 +0000 (0:00:00.191)       0:00:13.299 *******
2025-11-24 08:37:51.603432 | controller | skipping: [instance]
2025-11-24 08:37:51.775797 | controller |
2025-11-24 08:37:51.775828 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:51.775837 | controller | Monday 24 November 2025  08:37:51 +0000 (0:00:00.017)       0:00:13.316 *******
2025-11-24 08:37:51.775846 | controller | ok: [instance]
2025-11-24 08:37:51.790943 | controller |
2025-11-24 08:37:51.790967 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:51.790975 | controller | Monday 24 November 2025  08:37:51 +0000 (0:00:00.172)       0:00:13.489 *******
2025-11-24 08:37:51.790990 | controller | skipping: [instance]
2025-11-24 08:37:51.809931 | controller |
2025-11-24 08:37:51.809957 | controller | TASK [compliance : Log start of scans] *****************************************
2025-11-24 08:37:51.809972 | controller | Monday 24 November 2025  08:37:51 +0000 (0:00:00.015)       0:00:13.504 *******
2025-11-24 08:37:51.809982 | controller | ok: [instance] =>
2025-11-24 08:37:51.841986 | controller |   msg: Starting scans for nerc-cip
2025-11-24 08:37:51.842023 | controller |
2025-11-24 08:37:51.842033 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-11-24 08:37:51.842041 | controller | Monday 24 November 2025  08:37:51 +0000 (0:00:00.018)       0:00:13.523 *******
2025-11-24 08:37:51.842053 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-nerc-cip)
2025-11-24 08:37:51.861904 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-nerc-cip-node)
2025-11-24 08:37:51.861942 | controller |
2025-11-24 08:37:51.861950 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:51.861956 | controller | Monday 24 November 2025  08:37:51 +0000 (0:00:00.031)       0:00:13.555 *******
2025-11-24 08:37:51.861968 | controller | ok: [instance]
2025-11-24 08:37:51.862066 | controller |
2025-11-24 08:37:51.862212 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:51.862356 | controller | Monday 24 November 2025  08:37:51 +0000 (0:00:00.020)       0:00:13.575 *******
2025-11-24 08:37:51.878599 | controller | skipping: [instance]
2025-11-24 08:37:51.878751 | controller |
2025-11-24 08:37:51.878932 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:51.879081 | controller | Monday 24 November 2025  08:37:51 +0000 (0:00:00.016)       0:00:13.592 *******
2025-11-24 08:37:51.895229 | controller | skipping: [instance]
2025-11-24 08:37:51.895366 | controller |
2025-11-24 08:37:51.895511 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:51.895652 | controller | Monday 24 November 2025  08:37:51 +0000 (0:00:00.016)       0:00:13.609 *******
2025-11-24 08:37:52.073974 | controller | ok: [instance]
2025-11-24 08:37:52.074329 | controller |
2025-11-24 08:37:52.267378 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:52.267408 | controller | Monday 24 November 2025  08:37:52 +0000 (0:00:00.178)       0:00:13.787 *******
2025-11-24 08:37:52.267420 | controller | changed: [instance]
2025-11-24 08:37:52.284424 | controller |
2025-11-24 08:37:52.284452 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:52.284460 | controller | Monday 24 November 2025  08:37:52 +0000 (0:00:00.193)       0:00:13.980 *******
2025-11-24 08:37:52.284470 | controller | skipping: [instance]
2025-11-24 08:37:52.462334 | controller |
2025-11-24 08:37:52.462362 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:52.462370 | controller | Monday 24 November 2025  08:37:52 +0000 (0:00:00.017)       0:00:13.997 *******
2025-11-24 08:37:52.462380 | controller | ok: [instance]
2025-11-24 08:37:52.477404 | controller |
2025-11-24 08:37:52.477437 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:52.477445 | controller | Monday 24 November 2025  08:37:52 +0000 (0:00:00.177)       0:00:14.175 *******
2025-11-24 08:37:52.477456 | controller | skipping: [instance]
2025-11-24 08:37:52.498436 | controller |
2025-11-24 08:37:52.498460 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:52.498468 | controller | Monday 24 November 2025  08:37:52 +0000 (0:00:00.015)       0:00:14.190 *******
2025-11-24 08:37:52.498478 | controller | ok: [instance]
2025-11-24 08:37:52.514945 | controller |
2025-11-24 08:37:52.514978 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:52.514986 | controller | Monday 24 November 2025  08:37:52 +0000 (0:00:00.021)       0:00:14.211 *******
2025-11-24 08:37:52.514996 | controller | skipping: [instance]
2025-11-24 08:37:52.515020 | controller |
2025-11-24 08:37:52.515028 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:52.515127 | controller | Monday 24 November 2025  08:37:52 +0000 (0:00:00.016)       0:00:14.228 *******
2025-11-24 08:37:52.531550 | controller | skipping: [instance]
2025-11-24 08:37:52.710943 | controller |
2025-11-24 08:37:52.710976 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:52.710983 | controller | Monday 24 November 2025  08:37:52 +0000 (0:00:00.016)       0:00:14.244 *******
2025-11-24 08:37:52.710994 | controller | ok: [instance]
2025-11-24 08:37:52.711396 | controller |
2025-11-24 08:37:52.900417 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:52.900448 | controller | Monday 24 November 2025  08:37:52 +0000 (0:00:00.179)       0:00:14.424 *******
2025-11-24 08:37:52.900459 | controller | changed: [instance]
2025-11-24 08:37:52.917715 | controller |
2025-11-24 08:37:52.917748 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:52.917763 | controller | Monday 24 November 2025  08:37:52 +0000 (0:00:00.189)       0:00:14.613 *******
2025-11-24 08:37:52.917789 | controller | skipping: [instance]
2025-11-24 08:37:53.094314 | controller |
2025-11-24 08:37:53.094344 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:53.094352 | controller | Monday 24 November 2025  08:37:52 +0000 (0:00:00.017)       0:00:14.630 *******
2025-11-24 08:37:53.094362 | controller | ok: [instance]
2025-11-24 08:37:53.108815 | controller |
2025-11-24 08:37:53.108842 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:53.108852 | controller | Monday 24 November 2025  08:37:53 +0000 (0:00:00.176)       0:00:14.807 *******
2025-11-24 08:37:53.108890 | controller | skipping: [instance]
2025-11-24 08:37:53.126928 | controller |
2025-11-24 08:37:53.126951 | controller | TASK [compliance : Log start of scans] *****************************************
2025-11-24 08:37:53.126960 | controller | Monday 24 November 2025  08:37:53 +0000 (0:00:00.014)       0:00:14.822 *******
2025-11-24 08:37:53.126971 | controller | ok: [instance] =>
2025-11-24 08:37:53.127470 | controller |   msg: Starting scans for pci-dss
2025-11-24 08:37:53.159006 | controller |
2025-11-24 08:37:53.159043 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-11-24 08:37:53.159052 | controller | Monday 24 November 2025  08:37:53 +0000 (0:00:00.018)       0:00:14.840 *******
2025-11-24 08:37:53.159066 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-pci-dss)
2025-11-24 08:37:53.180115 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-pci-dss-node)
2025-11-24 08:37:53.180136 | controller |
2025-11-24 08:37:53.180143 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:53.180149 | controller | Monday 24 November 2025  08:37:53 +0000 (0:00:00.031)       0:00:14.872 *******
2025-11-24 08:37:53.180158 | controller | ok: [instance]
2025-11-24 08:37:53.180280 | controller |
2025-11-24 08:37:53.180429 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:53.180553 | controller | Monday 24 November 2025  08:37:53 +0000 (0:00:00.021)       0:00:14.893 *******
2025-11-24 08:37:53.197086 | controller | skipping: [instance]
2025-11-24 08:37:53.197226 | controller |
2025-11-24 08:37:53.197355 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:53.197480 | controller | Monday 24 November 2025  08:37:53 +0000 (0:00:00.016)       0:00:14.910 *******
2025-11-24 08:37:53.216248 | controller | skipping: [instance]
2025-11-24 08:37:53.216402 | controller |
2025-11-24 08:37:53.216545 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:53.216666 | controller | Monday 24 November 2025  08:37:53 +0000 (0:00:00.019)       0:00:14.930 *******
2025-11-24 08:37:53.400000 | controller | ok: [instance]
2025-11-24 08:37:53.590586 | controller |
2025-11-24 08:37:53.590614 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:53.590622 | controller | Monday 24 November 2025  08:37:53 +0000 (0:00:00.183)       0:00:15.113 *******
2025-11-24 08:37:53.590632 | controller | changed: [instance]
2025-11-24 08:37:53.590655 | controller |
2025-11-24 08:37:53.590662 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:53.590676 | controller | Monday 24 November 2025  08:37:53 +0000 (0:00:00.190)       0:00:15.304 *******
2025-11-24 08:37:53.607711 | controller | skipping: [instance]
2025-11-24 08:37:53.783922 | controller |
2025-11-24 08:37:53.783953 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:53.783961 | controller | Monday 24 November 2025  08:37:53 +0000 (0:00:00.016)       0:00:15.320 *******
2025-11-24 08:37:53.783971 | controller | ok: [instance]
2025-11-24 08:37:53.799170 | controller |
2025-11-24 08:37:53.799198 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:53.799207 | controller | Monday 24 November 2025  08:37:53 +0000 (0:00:00.176)       0:00:15.497 *******
2025-11-24 08:37:53.799218 | controller | skipping: [instance]
2025-11-24 08:37:53.822671 | controller |
2025-11-24 08:37:53.822695 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:53.822703 | controller | Monday 24 November 2025  08:37:53 +0000 (0:00:00.015)       0:00:15.512 *******
2025-11-24 08:37:53.822712 | controller | ok: [instance]
2025-11-24 08:37:53.840590 | controller |
2025-11-24 08:37:53.840613 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:53.840621 | controller | Monday 24 November 2025  08:37:53 +0000 (0:00:00.023)       0:00:15.536 *******
2025-11-24 08:37:53.840631 | controller | skipping: [instance]
2025-11-24 08:37:53.873969 | controller |
2025-11-24 08:37:53.874002 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:53.874012 | controller | Monday 24 November 2025  08:37:53 +0000 (0:00:00.017)       0:00:15.554 *******
2025-11-24 08:37:53.874031 | controller | skipping: [instance]
2025-11-24 08:37:54.049927 | controller |
2025-11-24 08:37:54.049951 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:54.049959 | controller | Monday 24 November 2025  08:37:53 +0000 (0:00:00.033)       0:00:15.587 *******
2025-11-24 08:37:54.049969 | controller | ok: [instance]
2025-11-24 08:37:54.049992 | controller |
2025-11-24 08:37:54.050001 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:54.050118 | controller | Monday 24 November 2025  08:37:54 +0000 (0:00:00.176)       0:00:15.763 *******
2025-11-24 08:37:54.234962 | controller | changed: [instance]
2025-11-24 08:37:54.252249 | controller |
2025-11-24 08:37:54.252280 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:54.252288 | controller | Monday 24 November 2025  08:37:54 +0000 (0:00:00.184)       0:00:15.948 *******
2025-11-24 08:37:54.252298 | controller | skipping: [instance]
2025-11-24 08:37:54.451461 | controller |
2025-11-24 08:37:54.451490 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:54.451498 | controller | Monday 24 November 2025  08:37:54 +0000 (0:00:00.017)       0:00:15.965 *******
2025-11-24 08:37:54.451508 | controller | ok: [instance]
2025-11-24 08:37:54.465737 | controller |
2025-11-24 08:37:54.465773 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:54.465781 | controller | Monday 24 November 2025  08:37:54 +0000 (0:00:00.199)       0:00:16.164 *******
2025-11-24 08:37:54.465791 | controller | skipping: [instance]
2025-11-24 08:37:54.483958 | controller |
2025-11-24 08:37:54.483994 | controller | TASK [compliance : Log start of scans] *****************************************
2025-11-24 08:37:54.484002 | controller | Monday 24 November 2025  08:37:54 +0000 (0:00:00.014)       0:00:16.179 *******
2025-11-24 08:37:54.484012 | controller | ok: [instance] =>
2025-11-24 08:37:54.484037 | controller |   msg: Starting scans for stig
2025-11-24 08:37:54.484387 | controller |
2025-11-24 08:37:54.522000 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-11-24 08:37:54.522040 | controller | Monday 24 November 2025  08:37:54 +0000 (0:00:00.018)       0:00:16.197 *******
2025-11-24 08:37:54.522055 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-stig)
2025-11-24 08:37:54.522085 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-stig-node)
2025-11-24 08:37:54.522102 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-stig)
2025-11-24 08:37:54.522109 | controller |
2025-11-24 08:37:54.522119 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:54.522198 | controller | Monday 24 November 2025  08:37:54 +0000 (0:00:00.037)       0:00:16.235 *******
2025-11-24 08:37:54.542941 | controller | ok: [instance]
2025-11-24 08:37:54.542973 | controller |
2025-11-24 08:37:54.543087 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:54.543207 | controller | Monday 24 November 2025  08:37:54 +0000 (0:00:00.021)       0:00:16.256 *******
2025-11-24 08:37:54.559546 | controller | skipping: [instance]
2025-11-24 08:37:54.559703 | controller |
2025-11-24 08:37:54.559881 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:54.560034 | controller | Monday 24 November 2025  08:37:54 +0000 (0:00:00.016)       0:00:16.273 *******
2025-11-24 08:37:54.576042 | controller | skipping: [instance]
2025-11-24 08:37:54.576190 | controller |
2025-11-24 08:37:54.576338 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:54.576481 | controller | Monday 24 November 2025  08:37:54 +0000 (0:00:00.016)       0:00:16.289 *******
2025-11-24 08:37:54.754372 | controller | ok: [instance]
2025-11-24 08:37:54.940053 | controller |
2025-11-24 08:37:54.940086 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:54.940095 | controller | Monday 24 November 2025  08:37:54 +0000 (0:00:00.177)       0:00:16.467 *******
2025-11-24 08:37:54.940109 | controller | changed: [instance]
2025-11-24 08:37:54.955983 | controller |
2025-11-24 08:37:54.956026 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:54.956036 | controller | Monday 24 November 2025  08:37:54 +0000 (0:00:00.185)       0:00:16.652 *******
2025-11-24 08:37:54.956050 | controller | skipping: [instance]
2025-11-24 08:37:54.956078 | controller |
2025-11-24 08:37:54.956088 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:54.956141 | controller | Monday 24 November 2025  08:37:54 +0000 (0:00:00.016)       0:00:16.669 *******
2025-11-24 08:37:55.124568 | controller | ok: [instance]
2025-11-24 08:37:55.138262 | controller |
2025-11-24 08:37:55.138280 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:55.138288 | controller | Monday 24 November 2025  08:37:55 +0000 (0:00:00.168)       0:00:16.837 *******
2025-11-24 08:37:55.138297 | controller | skipping: [instance]
2025-11-24 08:37:55.157280 | controller |
2025-11-24 08:37:55.157298 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:55.157310 | controller | Monday 24 November 2025  08:37:55 +0000 (0:00:00.013)       0:00:16.851 *******
2025-11-24 08:37:55.157319 | controller | ok: [instance]
2025-11-24 08:37:55.171970 | controller |
2025-11-24 08:37:55.171992 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:55.172000 | controller | Monday 24 November 2025  08:37:55 +0000 (0:00:00.018)       0:00:16.870 *******
2025-11-24 08:37:55.172011 | controller | skipping: [instance]
2025-11-24 08:37:55.186455 | controller |
2025-11-24 08:37:55.186476 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:55.186484 | controller | Monday 24 November 2025  08:37:55 +0000 (0:00:00.014)       0:00:16.885 *******
2025-11-24 08:37:55.186494 | controller | skipping: [instance]
2025-11-24 08:37:55.371243 | controller |
2025-11-24 08:37:55.371273 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:55.371281 | controller | Monday 24 November 2025  08:37:55 +0000 (0:00:00.014)       0:00:16.899 *******
2025-11-24 08:37:55.371291 | controller | ok: [instance]
2025-11-24 08:37:55.567911 | controller |
2025-11-24 08:37:55.567941 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:55.567949 | controller | Monday 24 November 2025  08:37:55 +0000 (0:00:00.184)       0:00:17.084 *******
2025-11-24 08:37:55.567959 | controller | changed: [instance]
2025-11-24 08:37:55.584640 | controller |
2025-11-24 08:37:55.584667 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:55.584684 | controller | Monday 24 November 2025  08:37:55 +0000 (0:00:00.196)       0:00:17.281 *******
2025-11-24 08:37:55.584696 | controller | skipping: [instance]
2025-11-24 08:37:55.758887 | controller |
2025-11-24 08:37:55.758918 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:55.758927 | controller | Monday 24 November 2025  08:37:55 +0000 (0:00:00.016)       0:00:17.298 *******
2025-11-24 08:37:55.758937 | controller | ok: [instance]
2025-11-24 08:37:55.773515 | controller |
2025-11-24 08:37:55.773540 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:55.773547 | controller | Monday 24 November 2025  08:37:55 +0000 (0:00:00.174)       0:00:17.472 *******
2025-11-24 08:37:55.773557 | controller | skipping: [instance]
2025-11-24 08:37:55.794368 | controller |
2025-11-24 08:37:55.794393 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:55.794400 | controller | Monday 24 November 2025  08:37:55 +0000 (0:00:00.014)       0:00:17.486 *******
2025-11-24 08:37:55.794410 | controller | ok: [instance]
2025-11-24 08:37:55.810842 | controller |
2025-11-24 08:37:55.810885 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:55.810897 | controller | Monday 24 November 2025  08:37:55 +0000 (0:00:00.020)       0:00:17.507 *******
2025-11-24 08:37:55.810909 | controller | skipping: [instance]
2025-11-24 08:37:55.827251 | controller |
2025-11-24 08:37:55.827275 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:55.827283 | controller | Monday 24 November 2025  08:37:55 +0000 (0:00:00.016)       0:00:17.524 *******
2025-11-24 08:37:55.827294 | controller | skipping: [instance]
2025-11-24 08:37:56.005509 | controller |
2025-11-24 08:37:56.005543 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:56.005552 | controller | Monday 24 November 2025  08:37:55 +0000 (0:00:00.016)       0:00:17.540 *******
2025-11-24 08:37:56.005562 | controller | ok: [instance]
2025-11-24 08:37:56.192989 | controller |
2025-11-24 08:37:56.193019 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:56.193027 | controller | Monday 24 November 2025  08:37:56 +0000 (0:00:00.177)       0:00:17.718 *******
2025-11-24 08:37:56.193037 | controller | changed: [instance]
2025-11-24 08:37:56.209431 | controller |
2025-11-24 08:37:56.209453 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:56.209461 | controller | Monday 24 November 2025  08:37:56 +0000 (0:00:00.187)       0:00:17.906 *******
2025-11-24 08:37:56.209470 | controller | skipping: [instance]
2025-11-24 08:37:56.381323 | controller |
2025-11-24 08:37:56.381354 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:56.381362 | controller | Monday 24 November 2025  08:37:56 +0000 (0:00:00.016)       0:00:17.922 *******
2025-11-24 08:37:56.381372 | controller | ok: [instance]
2025-11-24 08:37:56.395376 | controller |
2025-11-24 08:37:56.395404 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:56.395411 | controller | Monday 24 November 2025  08:37:56 +0000 (0:00:00.171)       0:00:18.094 *******
2025-11-24 08:37:56.395426 | controller | skipping: [instance]
2025-11-24 08:37:56.433686 | controller |
2025-11-24 08:37:56.433716 | controller | TASK [compliance : Delete all resources created by the role] *******************
2025-11-24 08:37:56.433723 | controller | Monday 24 November 2025  08:37:56 +0000 (0:00:00.014)       0:00:18.108 *******
2025-11-24 08:37:56.433733 | controller | skipping: [instance]
2025-11-24 08:37:57.047848 | controller |
2025-11-24 08:37:57.047896 | controller | PLAY [Converge test of compute tasks] ******************************************
2025-11-24 08:37:57.047905 | controller |
2025-11-24 08:37:57.047911 | controller | TASK [Gathering Facts] *********************************************************
2025-11-24 08:37:57.047916 | controller | Monday 24 November 2025  08:37:56 +0000 (0:00:00.038)       0:00:18.147 *******
2025-11-24 08:37:57.047926 | controller | ok: [instance]
2025-11-24 08:37:57.249492 | controller |
2025-11-24 08:37:57.249521 | controller | TASK [compliance : Ensure compliance folder exists] ****************************
2025-11-24 08:37:57.249529 | controller | Monday 24 November 2025  08:37:57 +0000 (0:00:00.614)       0:00:18.761 *******
2025-11-24 08:37:57.249546 | controller | ok: [instance]
2025-11-24 08:37:57.276981 | controller |
2025-11-24 08:37:57.277016 | controller | TASK [compliance : Install the compliance operator and plugin] *****************
2025-11-24 08:37:57.277026 | controller | Monday 24 November 2025  08:37:57 +0000 (0:00:00.201)       0:00:18.962 *******
2025-11-24 08:37:57.277038 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/install.yml for instance
2025-11-24 08:37:57.277067 | controller |
2025-11-24 08:37:57.277077 | controller | TASK [compliance : Create the compliance namespace] ****************************
2025-11-24 08:37:57.277202 | controller | Monday 24 November 2025  08:37:57 +0000 (0:00:00.027)       0:00:18.990 *******
2025-11-24 08:37:57.292624 | controller | skipping: [instance]
2025-11-24 08:37:57.309449 | controller |
2025-11-24 08:37:57.309467 | controller | TASK [compliance : Ensure OperatorGroup for the compliance-operator is present] ***
2025-11-24 08:37:57.309475 | controller | Monday 24 November 2025  08:37:57 +0000 (0:00:00.015)       0:00:19.006 *******
2025-11-24 08:37:57.309484 | controller | skipping: [instance]
2025-11-24 08:37:57.325553 | controller |
2025-11-24 08:37:57.325570 | controller | TASK [compliance : Ensure Subscription for the compliance-operator is present] ***
2025-11-24 08:37:57.325577 | controller | Monday 24 November 2025  08:37:57 +0000 (0:00:00.016)       0:00:19.022 *******
2025-11-24 08:37:57.325585 | controller | skipping: [instance]
2025-11-24 08:37:57.341594 | controller |
2025-11-24 08:37:57.341611 | controller | TASK [compliance : Wait until the compliance-operator csv is present] **********
2025-11-24 08:37:57.341618 | controller | Monday 24 November 2025  08:37:57 +0000 (0:00:00.016)       0:00:19.039 *******
2025-11-24 08:37:57.341626 | controller | skipping: [instance]
2025-11-24 08:37:57.357389 | controller |
2025-11-24 08:37:57.357405 | controller | TASK [compliance : Get full name of the compliance-operator csv] ***************
2025-11-24 08:37:57.357415 | controller | Monday 24 November 2025  08:37:57 +0000 (0:00:00.016)       0:00:19.055 *******
2025-11-24 08:37:57.357423 | controller | skipping: [instance]
2025-11-24 08:37:57.373684 | controller |
2025-11-24 08:37:57.373700 | controller | TASK [compliance : Wait for the compliance-operator csv to Succeed] ************
2025-11-24 08:37:57.373707 | controller | Monday 24 November 2025  08:37:57 +0000 (0:00:00.015)       0:00:19.071 *******
2025-11-24 08:37:57.373715 | controller | skipping: [instance]
2025-11-24 08:37:58.028786 | controller |
2025-11-24 08:37:58.028815 | controller | TASK [podman : Ensure podman is installed] *************************************
2025-11-24 08:37:58.028823 | controller | Monday 24 November 2025  08:37:57 +0000 (0:00:00.016)       0:00:19.087 *******
2025-11-24 08:37:58.028833 | controller | ok: [instance]
2025-11-24 08:37:58.228419 | controller |
2025-11-24 08:37:58.228449 | controller | TASK [podman : Enable loginctl linger for ansible_user_id] *********************
2025-11-24 08:37:58.228457 | controller | Monday 24 November 2025  08:37:58 +0000 (0:00:00.654)       0:00:19.742 *******
2025-11-24 08:37:58.228467 | controller | changed: [instance]
2025-11-24 08:37:58.250879 | controller |
2025-11-24 08:37:58.250898 | controller | TASK [podman : Ensure subordinate UID entry exists for zuul] *******************
2025-11-24 08:37:58.250905 | controller | Monday 24 November 2025  08:37:58 +0000 (0:00:00.199)       0:00:19.941 *******
2025-11-24 08:37:58.250913 | controller | skipping: [instance]
2025-11-24 08:37:58.269917 | controller |
2025-11-24 08:37:58.269934 | controller | TASK [podman : Ensure subordinate GID entry exists for zuul] *******************
2025-11-24 08:37:58.269942 | controller | Monday 24 November 2025  08:37:58 +0000 (0:00:00.022)       0:00:19.964 *******
2025-11-24 08:37:58.269950 | controller | skipping: [instance]
2025-11-24 08:37:58.269971 | controller |
2025-11-24 08:37:58.269979 | controller | TASK [podman : Run podman system migrate if subuid/subgid files were changed] ***
2025-11-24 08:37:58.270076 | controller | Monday 24 November 2025  08:37:58 +0000 (0:00:00.019)       0:00:19.983 *******
2025-11-24 08:37:58.293879 | controller | skipping: [instance]
2025-11-24 08:37:58.310767 | controller |
2025-11-24 08:37:58.310787 | controller | TASK [compliance : Log into registry] ******************************************
2025-11-24 08:37:58.310796 | controller | Monday 24 November 2025  08:37:58 +0000 (0:00:00.023)       0:00:20.007 *******
2025-11-24 08:37:58.310806 | controller | skipping: [instance]
2025-11-24 08:37:58.327041 | controller |
2025-11-24 08:37:58.327063 | controller | TASK [compliance : Copy out the compliance plugin from the oc-compliance image] ***
2025-11-24 08:37:58.327073 | controller | Monday 24 November 2025  08:37:58 +0000 (0:00:00.016)       0:00:20.024 *******
2025-11-24 08:37:58.327081 | controller | skipping: [instance]
2025-11-24 08:37:58.944902 | controller |
2025-11-24 08:37:58.944931 | controller | TASK [compliance : Install packages to process results] ************************
2025-11-24 08:37:58.944939 | controller | Monday 24 November 2025  08:37:58 +0000 (0:00:00.016)       0:00:20.040 *******
2025-11-24 08:37:58.944949 | controller | ok: [instance]
2025-11-24 08:37:58.987977 | controller |
2025-11-24 08:37:58.988009 | controller | TASK [compliance : Run compliance scans and extract results] *******************
2025-11-24 08:37:58.988020 | controller | Monday 24 November 2025  08:37:58 +0000 (0:00:00.617)       0:00:20.658 *******
2025-11-24 08:37:58.988032 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=cis)
2025-11-24 08:37:58.988943 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=e8)
2025-11-24 08:37:58.988964 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=high)
2025-11-24 08:37:59.005907 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=moderate)
2025-11-24 08:37:59.005925 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=nerc-cip)
2025-11-24 08:37:59.005932 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=pci-dss)
2025-11-24 08:37:59.005938 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=stig)
2025-11-24 08:37:59.005943 | controller |
2025-11-24 08:37:59.005949 | controller | TASK [compliance : Log start of scans] *****************************************
2025-11-24 08:37:59.005954 | controller | Monday 24 November 2025  08:37:58 +0000 (0:00:00.043)       0:00:20.701 *******
2025-11-24 08:37:59.005963 | controller | ok: [instance] =>
2025-11-24 08:37:59.005984 | controller |   msg: Starting scans for cis
2025-11-24 08:37:59.005990 | controller |
2025-11-24 08:37:59.005997 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-11-24 08:37:59.006094 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.018)       0:00:20.719 *******
2025-11-24 08:37:59.031713 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-cis)
2025-11-24 08:37:59.051544 | controller |
2025-11-24 08:37:59.051567 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:59.051575 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.025)       0:00:20.744 *******
2025-11-24 08:37:59.051584 | controller | ok: [instance]
2025-11-24 08:37:59.068006 | controller |
2025-11-24 08:37:59.068027 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:59.068035 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.020)       0:00:20.764 *******
2025-11-24 08:37:59.068043 | controller | skipping: [instance]
2025-11-24 08:37:59.084232 | controller |
2025-11-24 08:37:59.084250 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:59.084257 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.016)       0:00:20.781 *******
2025-11-24 08:37:59.084265 | controller | skipping: [instance]
2025-11-24 08:37:59.262776 | controller |
2025-11-24 08:37:59.262808 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:59.262816 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.016)       0:00:20.797 *******
2025-11-24 08:37:59.262827 | controller | changed: [instance]
2025-11-24 08:37:59.449268 | controller |
2025-11-24 08:37:59.449297 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:37:59.449313 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.178)       0:00:20.976 *******
2025-11-24 08:37:59.449323 | controller | changed: [instance]
2025-11-24 08:37:59.466591 | controller |
2025-11-24 08:37:59.466617 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:37:59.466625 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.186)       0:00:21.162 *******
2025-11-24 08:37:59.466635 | controller | skipping: [instance]
2025-11-24 08:37:59.636425 | controller |
2025-11-24 08:37:59.636454 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:37:59.636462 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.017)       0:00:21.180 *******
2025-11-24 08:37:59.636471 | controller | ok: [instance]
2025-11-24 08:37:59.650956 | controller |
2025-11-24 08:37:59.650986 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:37:59.650994 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.169)       0:00:21.349 *******
2025-11-24 08:37:59.651005 | controller | skipping: [instance]
2025-11-24 08:37:59.669955 | controller |
2025-11-24 08:37:59.669989 | controller | TASK [compliance : Log start of scans] *****************************************
2025-11-24 08:37:59.669999 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.014)       0:00:21.364 *******
2025-11-24 08:37:59.670012 | controller | ok: [instance] =>
2025-11-24 08:37:59.670040 | controller |   msg: Starting scans for e8
2025-11-24 08:37:59.670048 | controller |
2025-11-24 08:37:59.670057 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-11-24 08:37:59.670145 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.019)       0:00:21.383 *******
2025-11-24 08:37:59.700985 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-e8)
2025-11-24 08:37:59.701015 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-e8)
2025-11-24 08:37:59.701032 | controller |
2025-11-24 08:37:59.701039 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:37:59.701049 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.030)       0:00:21.414 *******
2025-11-24 08:37:59.720938 | controller | ok: [instance]
2025-11-24 08:37:59.721074 | controller |
2025-11-24 08:37:59.721093 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:37:59.737430 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.020)       0:00:21.434 *******
2025-11-24 08:37:59.737450 | controller | skipping: [instance]
2025-11-24 08:37:59.753913 | controller |
2025-11-24 08:37:59.753931 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:37:59.753939 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.016)       0:00:21.451 *******
2025-11-24 08:37:59.753947 | controller | skipping: [instance]
2025-11-24 08:37:59.754114 | controller |
2025-11-24 08:37:59.754131 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:37:59.929486 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.016)       0:00:21.467 *******
2025-11-24 08:37:59.929520 | controller | changed: [instance]
2025-11-24 08:38:00.113054 | controller |
2025-11-24 08:38:00.113084 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:38:00.113092 | controller | Monday 24 November 2025  08:37:59 +0000 (0:00:00.175)       0:00:21.642 *******
2025-11-24 08:38:00.113101 | controller | changed: [instance]
2025-11-24 08:38:00.130487 | controller |
2025-11-24 08:38:00.130507 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:38:00.130514 | controller | Monday 24 November 2025  08:38:00 +0000 (0:00:00.183)       0:00:21.826 *******
2025-11-24 08:38:00.130523 | controller | skipping: [instance]
2025-11-24 08:38:00.302355 | controller |
2025-11-24 08:38:00.302379 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:38:00.302387 | controller | Monday 24 November 2025  08:38:00 +0000 (0:00:00.017)       0:00:21.844 *******
2025-11-24 08:38:00.302400 | controller | ok: [instance]
2025-11-24 08:38:00.317982 | controller |
2025-11-24 08:38:00.318014 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:38:00.318022 | controller | Monday 24 November 2025  08:38:00 +0000 (0:00:00.171)       0:00:22.015 *******
2025-11-24 08:38:00.318033 | controller | skipping: [instance]
2025-11-24 08:38:00.318050 | controller |
2025-11-24 08:38:00.318056 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:38:00.318063 | controller | Monday 24 November 2025  08:38:00 +0000 (0:00:00.015)       0:00:22.031 *******
2025-11-24 08:38:00.338808 | controller | ok: [instance]
2025-11-24 08:38:00.338920 | controller |
2025-11-24 08:38:00.339035 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:38:00.339162 | controller | Monday 24 November 2025  08:38:00 +0000 (0:00:00.021)       0:00:22.052 *******
2025-11-24 08:38:00.356411 | controller | skipping: [instance]
2025-11-24 08:38:00.372489 | controller |
2025-11-24 08:38:00.372507 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:38:00.372514 | controller | Monday 24 November 2025  08:38:00 +0000 (0:00:00.017)       0:00:22.069 *******
2025-11-24 08:38:00.372523 | controller | skipping: [instance]
2025-11-24 08:38:00.548928 | controller |
2025-11-24 08:38:00.548958 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:38:00.548966 | controller | Monday 24 November 2025  08:38:00 +0000 (0:00:00.016)       0:00:22.086 *******
2025-11-24 08:38:00.548976 | controller | changed: [instance]
2025-11-24 08:38:00.737315 | controller |
2025-11-24 08:38:00.737345 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:38:00.737353 | controller | Monday 24 November 2025  08:38:00 +0000 (0:00:00.176)       0:00:22.262 *******
2025-11-24 08:38:00.737363 | controller | changed: [instance]
2025-11-24 08:38:00.737390 | controller |
2025-11-24 08:38:00.737499 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:38:00.737650 | controller | Monday 24 November 2025  08:38:00 +0000 (0:00:00.188)       0:00:22.450 *******
2025-11-24 08:38:00.753930 | controller | skipping: [instance]
2025-11-24 08:38:00.753972 | controller |
2025-11-24 08:38:00.754186 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:38:00.930409 | controller | Monday 24 November 2025  08:38:00 +0000 (0:00:00.016)       0:00:22.467 *******
2025-11-24 08:38:00.930448 | controller | ok: [instance]
2025-11-24 08:38:00.944966 | controller |
2025-11-24 08:38:00.945001 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:38:00.945009 | controller | Monday 24 November 2025  08:38:00 +0000 (0:00:00.175)       0:00:22.643 *******
2025-11-24 08:38:00.945019 | controller | skipping: [instance]
2025-11-24 08:38:00.945057 | controller |
2025-11-24 08:38:00.945078 | controller | TASK [compliance : Log start of scans] *****************************************
2025-11-24 08:38:00.945090 | controller | Monday 24 November 2025  08:38:00 +0000 (0:00:00.014)       0:00:22.658 *******
2025-11-24 08:38:00.963785 | controller | ok: [instance] =>
2025-11-24 08:38:01.000498 | controller |   msg: Starting scans for high
2025-11-24 08:38:01.000517 | controller |
2025-11-24 08:38:01.000525 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-11-24 08:38:01.000531 | controller | Monday 24 November 2025  08:38:00 +0000 (0:00:00.018)       0:00:22.677 *******
2025-11-24 08:38:01.000539 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-high)
2025-11-24 08:38:01.020482 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-high-node)
2025-11-24 08:38:01.020500 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-high)
2025-11-24 08:38:01.020506 | controller |
2025-11-24 08:38:01.020512 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:38:01.020518 | controller | Monday 24 November 2025  08:38:00 +0000 (0:00:00.036)       0:00:22.713 *******
2025-11-24 08:38:01.020531 | controller | ok: [instance]
2025-11-24 08:38:01.037249 | controller |
2025-11-24 08:38:01.037266 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:38:01.037273 | controller | Monday 24 November 2025  08:38:01 +0000 (0:00:00.020)       0:00:22.734 *******
2025-11-24 08:38:01.037281 | controller | skipping: [instance]
2025-11-24 08:38:01.053632 | controller |
2025-11-24 08:38:01.053648 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:38:01.053655 | controller | Monday 24 November 2025  08:38:01 +0000 (0:00:00.016)       0:00:22.750 *******
2025-11-24 08:38:01.053663 | controller | skipping: [instance]
2025-11-24 08:38:01.238313 | controller |
2025-11-24 08:38:01.238332 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:38:01.238339 | controller | Monday 24 November 2025  08:38:01 +0000 (0:00:00.016)       0:00:22.767 *******
2025-11-24 08:38:01.238348 | controller | changed: [instance]
2025-11-24 08:38:01.422533 | controller |
2025-11-24 08:38:01.422564 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:38:01.422572 | controller | Monday 24 November 2025  08:38:01 +0000 (0:00:00.184)       0:00:22.951 *******
2025-11-24 08:38:01.422581 | controller | changed: [instance]
2025-11-24 08:38:01.439488 | controller |
2025-11-24 08:38:01.439509 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:38:01.439518 | controller | Monday 24 November 2025  08:38:01 +0000 (0:00:00.184)       0:00:23.135 *******
2025-11-24 08:38:01.439528 | controller | skipping: [instance]
2025-11-24 08:38:01.609952 | controller |
2025-11-24 08:38:01.609982 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:38:01.609989 | controller | Monday 24 November 2025  08:38:01 +0000 (0:00:00.017)       0:00:23.152 *******
2025-11-24 08:38:01.609999 | controller | ok: [instance]
2025-11-24 08:38:01.623910 | controller |
2025-11-24 08:38:01.623934 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:38:01.623943 | controller | Monday 24 November 2025  08:38:01 +0000 (0:00:00.170)       0:00:23.323 *******
2025-11-24 08:38:01.623955 | controller | skipping: [instance]
2025-11-24 08:38:01.623987 | controller |
2025-11-24 08:38:01.624207 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:38:01.644339 | controller | Monday 24 November 2025  08:38:01 +0000 (0:00:00.014)       0:00:23.337 *******
2025-11-24 08:38:01.644371 | controller | ok: [instance]
2025-11-24 08:38:01.661777 | controller |
2025-11-24 08:38:01.661807 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:38:01.661815 | controller | Monday 24 November 2025  08:38:01 +0000 (0:00:00.020)       0:00:23.357 *******
2025-11-24 08:38:01.661825 | controller | skipping: [instance]
2025-11-24 08:38:01.690968 | controller |
2025-11-24 08:38:01.690998 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:38:01.691007 | controller | Monday 24 November 2025  08:38:01 +0000 (0:00:00.017)       0:00:23.375 *******
2025-11-24 08:38:01.691019 | controller | skipping: [instance]
2025-11-24 08:38:01.691049 | controller |
2025-11-24 08:38:01.691297 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:38:01.878458 | controller | Monday 24 November 2025  08:38:01 +0000 (0:00:00.027)       0:00:23.402 *******
2025-11-24 08:38:01.878494 | controller | changed: [instance]
2025-11-24 08:38:02.062391 | controller |
2025-11-24 08:38:02.062419 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:38:02.062432 | controller | Monday 24 November 2025  08:38:01 +0000 (0:00:00.188)       0:00:23.591 *******
2025-11-24 08:38:02.062442 | controller | changed: [instance]
2025-11-24 08:38:02.079373 | controller |
2025-11-24 08:38:02.079396 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:38:02.079403 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.183)       0:00:23.775 *******
2025-11-24 08:38:02.079412 | controller | skipping: [instance]
2025-11-24 08:38:02.254321 | controller |
2025-11-24 08:38:02.254352 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:38:02.254365 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.017)       0:00:23.792 *******
2025-11-24 08:38:02.254375 | controller | ok: [instance]
2025-11-24 08:38:02.268936 | controller |
2025-11-24 08:38:02.268960 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:38:02.268969 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.174)       0:00:23.967 *******
2025-11-24 08:38:02.268981 | controller | skipping: [instance]
2025-11-24 08:38:02.288925 | controller |
2025-11-24 08:38:02.288957 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:38:02.288966 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.014)       0:00:23.982 *******
2025-11-24 08:38:02.288977 | controller | ok: [instance]
2025-11-24 08:38:02.289117 | controller |
2025-11-24 08:38:02.289135 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:38:02.305570 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.020)       0:00:24.002 *******
2025-11-24 08:38:02.305590 | controller | skipping: [instance]
2025-11-24 08:38:02.322363 | controller |
2025-11-24 08:38:02.322385 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:38:02.322393 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.016)       0:00:24.019 *******
2025-11-24 08:38:02.322404 | controller | skipping: [instance]
2025-11-24 08:38:02.499404 | controller |
2025-11-24 08:38:02.499433 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:38:02.499446 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.016)       0:00:24.035 *******
2025-11-24 08:38:02.499456 | controller | changed: [instance]
2025-11-24 08:38:02.685062 | controller |
2025-11-24 08:38:02.685090 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:38:02.685098 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.176)       0:00:24.212 *******
2025-11-24 08:38:02.685108 | controller | changed: [instance]
2025-11-24 08:38:02.701915 | controller |
2025-11-24 08:38:02.701937 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:38:02.701945 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.185)       0:00:24.398 *******
2025-11-24 08:38:02.701956 | controller | skipping: [instance]
2025-11-24 08:38:02.702141 | controller |
2025-11-24 08:38:02.702155 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:38:02.702165 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.017)       0:00:24.415 *******
2025-11-24 08:38:02.884218 | controller | ok: [instance]
2025-11-24 08:38:02.897791 | controller |
2025-11-24 08:38:02.897814 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:38:02.897822 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.182)       0:00:24.597 *******
2025-11-24 08:38:02.897832 | controller | skipping: [instance]
2025-11-24 08:38:02.914944 | controller |
2025-11-24 08:38:02.914983 | controller | TASK [compliance : Log start of scans] *****************************************
2025-11-24 08:38:02.914991 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.013)       0:00:24.611 *******
2025-11-24 08:38:02.915003 | controller | ok: [instance] =>
2025-11-24 08:38:02.951876 | controller |   msg: Starting scans for moderate
2025-11-24 08:38:02.951908 | controller |
2025-11-24 08:38:02.951916 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-11-24 08:38:02.951922 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.017)       0:00:24.628 *******
2025-11-24 08:38:02.951932 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-moderate)
2025-11-24 08:38:02.970737 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-moderate-node)
2025-11-24 08:38:02.970771 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-moderate)
2025-11-24 08:38:02.970781 | controller |
2025-11-24 08:38:02.970788 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:38:02.970797 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.036)       0:00:24.664 *******
2025-11-24 08:38:02.970806 | controller | ok: [instance]
2025-11-24 08:38:02.985824 | controller |
2025-11-24 08:38:02.985847 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:38:02.985854 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.019)       0:00:24.684 *******
2025-11-24 08:38:02.985884 | controller | skipping: [instance]
2025-11-24 08:38:03.000644 | controller |
2025-11-24 08:38:03.000663 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:38:03.000670 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.014)       0:00:24.699 *******
2025-11-24 08:38:03.000679 | controller | skipping: [instance]
2025-11-24 08:38:03.171833 | controller |
2025-11-24 08:38:03.171880 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:38:03.171891 | controller | Monday 24 November 2025  08:38:02 +0000 (0:00:00.014)       0:00:24.714 *******
2025-11-24 08:38:03.171901 | controller | changed: [instance]
2025-11-24 08:38:03.352558 | controller |
2025-11-24 08:38:03.352587 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:38:03.352595 | controller | Monday 24 November 2025  08:38:03 +0000 (0:00:00.170)       0:00:24.885 *******
2025-11-24 08:38:03.352605 | controller | changed: [instance]
2025-11-24 08:38:03.367790 | controller |
2025-11-24 08:38:03.367813 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:38:03.367820 | controller | Monday 24 November 2025  08:38:03 +0000 (0:00:00.180)       0:00:25.065 *******
2025-11-24 08:38:03.367830 | controller | skipping: [instance]
2025-11-24 08:38:03.534221 | controller |
2025-11-24 08:38:03.534249 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:38:03.534256 | controller | Monday 24 November 2025  08:38:03 +0000 (0:00:00.015)       0:00:25.081 *******
2025-11-24 08:38:03.534266 | controller | ok: [instance]
2025-11-24 08:38:03.547423 | controller |
2025-11-24 08:38:03.547447 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:38:03.547454 | controller | Monday 24 November 2025  08:38:03 +0000 (0:00:00.166)       0:00:25.247 *******
2025-11-24 08:38:03.547464 | controller | skipping: [instance]
2025-11-24 08:38:03.566945 | controller |
2025-11-24 08:38:03.566980 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:38:03.566990 | controller | Monday 24 November 2025  08:38:03 +0000 (0:00:00.013)       0:00:25.260 *******
2025-11-24 08:38:03.567005 | controller | ok: [instance]
2025-11-24 08:38:03.567036 | controller |
2025-11-24 08:38:03.567204 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:38:03.582337 | controller | Monday 24 November 2025  08:38:03 +0000 (0:00:00.019)       0:00:25.280 *******
2025-11-24 08:38:03.582363 | controller | skipping: [instance]
2025-11-24 08:38:03.597377 | controller |
2025-11-24 08:38:03.597401 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:38:03.597409 | controller | Monday 24 November 2025  08:38:03 +0000 (0:00:00.015)       0:00:25.295 *******
2025-11-24 08:38:03.597421 | controller | skipping: [instance]
2025-11-24 08:38:03.770622 | controller |
2025-11-24 08:38:03.770650 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:38:03.770658 | controller | Monday 24 November 2025  08:38:03 +0000 (0:00:00.014)       0:00:25.310 *******
2025-11-24 08:38:03.770668 | controller | changed: [instance]
2025-11-24 08:38:03.954595 | controller |
2025-11-24 08:38:03.954624 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:38:03.954632 | controller | Monday 24 November 2025  08:38:03 +0000 (0:00:00.173)       0:00:25.483 *******
2025-11-24 08:38:03.954641 | controller | changed: [instance]
2025-11-24 08:38:03.971028 | controller |
2025-11-24 08:38:03.971052 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:38:03.971059 | controller | Monday 24 November 2025  08:38:03 +0000 (0:00:00.184)       0:00:25.667 *******
2025-11-24 08:38:03.971068 | controller | skipping: [instance]
2025-11-24 08:38:04.140841 | controller |
2025-11-24 08:38:04.140899 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:38:04.140910 | controller | Monday 24 November 2025  08:38:03 +0000 (0:00:00.016)       0:00:25.684 *******
2025-11-24 08:38:04.140919 | controller | ok: [instance]
2025-11-24 08:38:04.155549 | controller |
2025-11-24 08:38:04.155571 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:38:04.155579 | controller | Monday 24 November 2025  08:38:04 +0000 (0:00:00.169)       0:00:25.854 *******
2025-11-24 08:38:04.155591 | controller | skipping: [instance]
2025-11-24 08:38:04.176295 | controller |
2025-11-24 08:38:04.176314 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:38:04.176321 | controller | Monday 24 November 2025  08:38:04 +0000 (0:00:00.014)       0:00:25.869 *******
2025-11-24 08:38:04.176331 | controller | ok: [instance]
2025-11-24 08:38:04.192917 | controller |
2025-11-24 08:38:04.192939 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:38:04.192953 | controller | Monday 24 November 2025  08:38:04 +0000 (0:00:00.020)       0:00:25.889 *******
2025-11-24 08:38:04.192965 | controller | skipping: [instance]
2025-11-24 08:38:04.193209 | controller |
2025-11-24 08:38:04.193223 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:38:04.209743 | controller | Monday 24 November 2025  08:38:04 +0000 (0:00:00.016)       0:00:25.906 *******
2025-11-24 08:38:04.209767 | controller | skipping: [instance]
2025-11-24 08:38:04.382644 | controller |
2025-11-24 08:38:04.382672 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:38:04.382680 | controller | Monday 24 November 2025  08:38:04 +0000 (0:00:00.016)       0:00:25.923 *******
2025-11-24 08:38:04.382704 | controller | changed: [instance]
2025-11-24 08:38:04.565732 | controller |
2025-11-24 08:38:04.565761 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:38:04.565769 | controller | Monday 24 November 2025  08:38:04 +0000 (0:00:00.172)       0:00:26.095 *******
2025-11-24 08:38:04.565779 | controller | changed: [instance]
2025-11-24 08:38:04.581906 | controller |
2025-11-24 08:38:04.581935 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:38:04.581943 | controller | Monday 24 November 2025  08:38:04 +0000 (0:00:00.183)       0:00:26.279 *******
2025-11-24 08:38:04.581954 | controller | skipping: [instance]
2025-11-24 08:38:04.749072 | controller |
2025-11-24 08:38:04.749100 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:38:04.749108 | controller | Monday 24 November 2025  08:38:04 +0000 (0:00:00.016)       0:00:26.295 *******
2025-11-24 08:38:04.749118 | controller | ok: [instance]
2025-11-24 08:38:04.763270 | controller |
2025-11-24 08:38:04.763290 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:38:04.763297 | controller | Monday 24 November 2025  08:38:04 +0000 (0:00:00.166)       0:00:26.462 *******
2025-11-24 08:38:04.763306 | controller | skipping: [instance]
2025-11-24 08:38:04.781761 | controller |
2025-11-24 08:38:04.781784 | controller | TASK [compliance : Log start of scans] *****************************************
2025-11-24 08:38:04.781792 | controller | Monday 24 November 2025  08:38:04 +0000 (0:00:00.014)       0:00:26.476 *******
2025-11-24 08:38:04.781803 | controller | ok: [instance] =>
2025-11-24 08:38:04.813643 | controller |   msg: Starting scans for nerc-cip
2025-11-24 08:38:04.813665 | controller |
2025-11-24 08:38:04.813672 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-11-24 08:38:04.813692 | controller | Monday 24 November 2025  08:38:04 +0000 (0:00:00.018)       0:00:26.495 *******
2025-11-24 08:38:04.813701 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-nerc-cip)
2025-11-24 08:38:04.833942 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-nerc-cip-node)
2025-11-24 08:38:04.833963 | controller |
2025-11-24 08:38:04.833971 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:38:04.833982 | controller | Monday 24 November 2025  08:38:04 +0000 (0:00:00.031)       0:00:26.527 *******
2025-11-24 08:38:04.833991 | controller | ok: [instance]
2025-11-24 08:38:04.849922 | controller |
2025-11-24 08:38:04.849941 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:38:04.849948 | controller | Monday 24 November 2025  08:38:04 +0000 (0:00:00.020)       0:00:26.547 *******
2025-11-24 08:38:04.849957 | controller | skipping: [instance]
2025-11-24 08:38:04.849978 | controller |
2025-11-24 08:38:04.849984 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:38:04.849991 | controller | Monday 24 November 2025  08:38:04 +0000 (0:00:00.016)       0:00:26.563 *******
2025-11-24 08:38:04.865948 | controller | skipping: [instance]
2025-11-24 08:38:04.865996 | controller |
2025-11-24 08:38:04.866012 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:38:04.866022 | controller | Monday 24 November 2025  08:38:04 +0000 (0:00:00.015)       0:00:26.579 *******
2025-11-24 08:38:05.043571 | controller | changed: [instance]
2025-11-24 08:38:05.231895 | controller |
2025-11-24 08:38:05.231924 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:38:05.231932 | controller | Monday 24 November 2025  08:38:05 +0000 (0:00:00.177)       0:00:26.756 *******
2025-11-24 08:38:05.231942 | controller | changed: [instance]
2025-11-24 08:38:05.248478 | controller |
2025-11-24 08:38:05.248496 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:38:05.248503 | controller | Monday 24 November 2025  08:38:05 +0000 (0:00:00.188)       0:00:26.945 *******
2025-11-24 08:38:05.248512 | controller | skipping: [instance]
2025-11-24 08:38:05.423698 | controller |
2025-11-24 08:38:05.423728 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:38:05.423736 | controller | Monday 24 November 2025  08:38:05 +0000 (0:00:00.016)       0:00:26.962 *******
2025-11-24 08:38:05.423751 | controller | ok: [instance]
2025-11-24 08:38:05.438388 | controller |
2025-11-24 08:38:05.438415 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:38:05.438423 | controller | Monday 24 November 2025  08:38:05 +0000 (0:00:00.174)       0:00:27.137 *******
2025-11-24 08:38:05.438436 | controller | skipping: [instance]
2025-11-24 08:38:05.459702 | controller |
2025-11-24 08:38:05.459727 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:38:05.459735 | controller | Monday 24 November 2025  08:38:05 +0000 (0:00:00.014)       0:00:27.151 *******
2025-11-24 08:38:05.459745 | controller | ok: [instance]
2025-11-24 08:38:05.476954 | controller |
2025-11-24 08:38:05.476978 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:38:05.476986 | controller | Monday 24 November 2025  08:38:05 +0000 (0:00:00.021)       0:00:27.173 *******
2025-11-24 08:38:05.476995 | controller | skipping: [instance]
2025-11-24 08:38:05.493992 | controller |
2025-11-24 08:38:05.494027 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:38:05.494035 | controller | Monday 24 November 2025  08:38:05 +0000 (0:00:00.017)       0:00:27.190 *******
2025-11-24 08:38:05.494046 | controller | skipping: [instance]
2025-11-24 08:38:05.494088 | controller |
2025-11-24 08:38:05.494110 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:38:05.494120 | controller | Monday 24 November 2025  08:38:05 +0000 (0:00:00.016)       0:00:27.207 *******
2025-11-24 08:38:05.669998 | controller | changed: [instance]
2025-11-24 08:38:05.859881 | controller |
2025-11-24 08:38:05.859910 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:38:05.859918 | controller | Monday 24 November 2025  08:38:05 +0000 (0:00:00.175)       0:00:27.383 *******
2025-11-24 08:38:05.859928 | controller | changed: [instance]
2025-11-24 08:38:05.875970 | controller |
2025-11-24 08:38:05.876006 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:38:05.876016 | controller | Monday 24 November 2025  08:38:05 +0000 (0:00:00.189)       0:00:27.573 *******
2025-11-24 08:38:05.876028 | controller | skipping: [instance]
2025-11-24 08:38:05.876048 | controller |
2025-11-24 08:38:05.876057 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:38:05.876138 | controller | Monday 24 November 2025  08:38:05 +0000 (0:00:00.016)       0:00:27.589 *******
2025-11-24 08:38:06.046492 | controller | ok: [instance]
2025-11-24 08:38:06.060951 | controller |
2025-11-24 08:38:06.060978 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:38:06.060988 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.170)       0:00:27.759 *******
2025-11-24 08:38:06.060999 | controller | skipping: [instance]
2025-11-24 08:38:06.061028 | controller |
2025-11-24 08:38:06.061218 | controller | TASK [compliance : Log start of scans] *****************************************
2025-11-24 08:38:06.079637 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.014)       0:00:27.774 *******
2025-11-24 08:38:06.079663 | controller | ok: [instance] =>
2025-11-24 08:38:06.110925 | controller |   msg: Starting scans for pci-dss
2025-11-24 08:38:06.110946 | controller |
2025-11-24 08:38:06.110955 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-11-24 08:38:06.110962 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.018)       0:00:27.792 *******
2025-11-24 08:38:06.110972 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-pci-dss)
2025-11-24 08:38:06.111442 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-pci-dss-node)
2025-11-24 08:38:06.131401 | controller |
2025-11-24 08:38:06.131419 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:38:06.131426 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.031)       0:00:27.824 *******
2025-11-24 08:38:06.131435 | controller | ok: [instance]
2025-11-24 08:38:06.147556 | controller |
2025-11-24 08:38:06.147574 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:38:06.147582 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.020)       0:00:27.844 *******
2025-11-24 08:38:06.147591 | controller | skipping: [instance]
2025-11-24 08:38:06.163772 | controller |
2025-11-24 08:38:06.163790 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:38:06.163797 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.016)       0:00:27.861 *******
2025-11-24 08:38:06.163805 | controller | skipping: [instance]
2025-11-24 08:38:06.343379 | controller |
2025-11-24 08:38:06.343409 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:38:06.343417 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.016)       0:00:27.877 *******
2025-11-24 08:38:06.343426 | controller | changed: [instance]
2025-11-24 08:38:06.538458 | controller |
2025-11-24 08:38:06.538487 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:38:06.538500 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.179)       0:00:28.056 *******
2025-11-24 08:38:06.538510 | controller | changed: [instance]
2025-11-24 08:38:06.554930 | controller |
2025-11-24 08:38:06.554959 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:38:06.554967 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.195)       0:00:28.251 *******
2025-11-24 08:38:06.554978 | controller | skipping: [instance]
2025-11-24 08:38:06.555391 | controller |
2025-11-24 08:38:06.731127 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:38:06.731156 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.016)       0:00:28.268 *******
2025-11-24 08:38:06.731168 | controller | ok: [instance]
2025-11-24 08:38:06.745484 | controller |
2025-11-24 08:38:06.745500 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:38:06.745507 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.175)       0:00:28.444 *******
2025-11-24 08:38:06.745515 | controller | skipping: [instance]
2025-11-24 08:38:06.766962 | controller |
2025-11-24 08:38:06.766996 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:38:06.767006 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.014)       0:00:28.459 *******
2025-11-24 08:38:06.767025 | controller | ok: [instance]
2025-11-24 08:38:06.767059 | controller |
2025-11-24 08:38:06.767183 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:38:06.767203 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.021)       0:00:28.480 *******
2025-11-24 08:38:06.783797 | controller | skipping: [instance]
2025-11-24 08:38:06.801950 | controller |
2025-11-24 08:38:06.801983 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:38:06.801991 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.016)       0:00:28.497 *******
2025-11-24 08:38:06.802001 | controller | skipping: [instance]
2025-11-24 08:38:06.802054 | controller |
2025-11-24 08:38:06.802063 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:38:06.802070 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.017)       0:00:28.515 *******
2025-11-24 08:38:06.983252 | controller | changed: [instance]
2025-11-24 08:38:07.169090 | controller |
2025-11-24 08:38:07.169118 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:38:07.169126 | controller | Monday 24 November 2025  08:38:06 +0000 (0:00:00.181)       0:00:28.696 *******
2025-11-24 08:38:07.169136 | controller | changed: [instance]
2025-11-24 08:38:07.185320 | controller |
2025-11-24 08:38:07.185345 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:38:07.185353 | controller | Monday 24 November 2025  08:38:07 +0000 (0:00:00.185)       0:00:28.882 *******
2025-11-24 08:38:07.185362 | controller | skipping: [instance]
2025-11-24 08:38:07.360590 | controller |
2025-11-24 08:38:07.360617 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:38:07.360625 | controller | Monday 24 November 2025  08:38:07 +0000 (0:00:00.016)       0:00:28.898 *******
2025-11-24 08:38:07.360635 | controller | ok: [instance]
2025-11-24 08:38:07.375169 | controller |
2025-11-24 08:38:07.375192 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:38:07.375200 | controller | Monday 24 November 2025  08:38:07 +0000 (0:00:00.175)       0:00:29.073 *******
2025-11-24 08:38:07.375209 | controller | skipping: [instance]
2025-11-24 08:38:07.393404 | controller |
2025-11-24 08:38:07.393425 | controller | TASK [compliance : Log start of scans] *****************************************
2025-11-24 08:38:07.393432 | controller | Monday 24 November 2025  08:38:07 +0000 (0:00:00.014)       0:00:29.088 *******
2025-11-24 08:38:07.393441 | controller | ok: [instance] =>
2025-11-24 08:38:07.432828 | controller |   msg: Starting scans for stig
2025-11-24 08:38:07.432850 | controller |
2025-11-24 08:38:07.432877 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-11-24 08:38:07.432887 | controller | Monday 24 November 2025  08:38:07 +0000 (0:00:00.018)       0:00:29.106 *******
2025-11-24 08:38:07.432897 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-stig)
2025-11-24 08:38:07.453419 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-stig-node)
2025-11-24 08:38:07.453441 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-stig)
2025-11-24 08:38:07.453448 | controller |
2025-11-24 08:38:07.453454 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:38:07.453460 | controller | Monday 24 November 2025  08:38:07 +0000 (0:00:00.039)       0:00:29.146 *******
2025-11-24 08:38:07.453469 | controller | ok: [instance]
2025-11-24 08:38:07.469431 | controller |
2025-11-24 08:38:07.469454 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:38:07.469463 | controller | Monday 24 November 2025  08:38:07 +0000 (0:00:00.020)       0:00:29.166 *******
2025-11-24 08:38:07.469473 | controller | skipping: [instance]
2025-11-24 08:38:07.469640 | controller |
2025-11-24 08:38:07.469828 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:38:07.470030 | controller | Monday 24 November 2025  08:38:07 +0000 (0:00:00.016)       0:00:29.183 *******
2025-11-24 08:38:07.485651 | controller | skipping: [instance]
2025-11-24 08:38:07.485813 | controller |
2025-11-24 08:38:07.485980 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:38:07.486120 | controller | Monday 24 November 2025  08:38:07 +0000 (0:00:00.016)       0:00:29.199 *******
2025-11-24 08:38:07.663563 | controller | changed: [instance]
2025-11-24 08:38:07.853454 | controller |
2025-11-24 08:38:07.853482 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:38:07.853490 | controller | Monday 24 November 2025  08:38:07 +0000 (0:00:00.177)       0:00:29.376 *******
2025-11-24 08:38:07.853499 | controller | changed: [instance]
2025-11-24 08:38:07.871646 | controller |
2025-11-24 08:38:07.871682 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:38:07.871690 | controller | Monday 24 November 2025  08:38:07 +0000 (0:00:00.189)       0:00:29.566 *******
2025-11-24 08:38:07.871699 | controller | skipping: [instance]
2025-11-24 08:38:08.047430 | controller |
2025-11-24 08:38:08.047460 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:38:08.047468 | controller | Monday 24 November 2025  08:38:07 +0000 (0:00:00.018)       0:00:29.585 *******
2025-11-24 08:38:08.047482 | controller | ok: [instance]
2025-11-24 08:38:08.063325 | controller |
2025-11-24 08:38:08.063344 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:38:08.063352 | controller | Monday 24 November 2025  08:38:08 +0000 (0:00:00.175)       0:00:29.760 *******
2025-11-24 08:38:08.063361 | controller | skipping: [instance]
2025-11-24 08:38:08.084848 | controller |
2025-11-24 08:38:08.084886 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:38:08.084896 | controller | Monday 24 November 2025  08:38:08 +0000 (0:00:00.016)       0:00:29.776 *******
2025-11-24 08:38:08.084905 | controller | ok: [instance]
2025-11-24 08:38:08.101967 | controller |
2025-11-24 08:38:08.102006 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:38:08.102014 | controller | Monday 24 November 2025  08:38:08 +0000 (0:00:00.021)       0:00:29.798 *******
2025-11-24 08:38:08.102024 | controller | skipping: [instance]
2025-11-24 08:38:08.102042 | controller |
2025-11-24 08:38:08.102049 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:38:08.102119 | controller | Monday 24 November 2025  08:38:08 +0000 (0:00:00.017)       0:00:29.815 *******
2025-11-24 08:38:08.120048 | controller | skipping: [instance]
2025-11-24 08:38:08.301942 | controller |
2025-11-24 08:38:08.301971 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:38:08.301979 | controller | Monday 24 November 2025  08:38:08 +0000 (0:00:00.017)       0:00:29.833 *******
2025-11-24 08:38:08.301989 | controller | changed: [instance]
2025-11-24 08:38:08.302167 | controller |
2025-11-24 08:38:08.302196 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:38:08.492753 | controller | Monday 24 November 2025  08:38:08 +0000 (0:00:00.181)       0:00:30.015 *******
2025-11-24 08:38:08.492788 | controller | changed: [instance]
2025-11-24 08:38:08.509967 | controller |
2025-11-24 08:38:08.509999 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:38:08.510007 | controller | Monday 24 November 2025  08:38:08 +0000 (0:00:00.190)       0:00:30.206 *******
2025-11-24 08:38:08.510017 | controller | skipping: [instance]
2025-11-24 08:38:08.510040 | controller |
2025-11-24 08:38:08.510048 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:38:08.510161 | controller | Monday 24 November 2025  08:38:08 +0000 (0:00:00.017)       0:00:30.223 *******
2025-11-24 08:38:08.685965 | controller | ok: [instance]
2025-11-24 08:38:08.686017 | controller |
2025-11-24 08:38:08.686281 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:38:08.700832 | controller | Monday 24 November 2025  08:38:08 +0000 (0:00:00.175)       0:00:30.399 *******
2025-11-24 08:38:08.700855 | controller | skipping: [instance]
2025-11-24 08:38:08.721855 | controller |
2025-11-24 08:38:08.721888 | controller | TASK [compliance : Set output directory] ***************************************
2025-11-24 08:38:08.721902 | controller | Monday 24 November 2025  08:38:08 +0000 (0:00:00.014)       0:00:30.414 *******
2025-11-24 08:38:08.721911 | controller | ok: [instance]
2025-11-24 08:38:08.739356 | controller |
2025-11-24 08:38:08.739377 | controller | TASK [compliance : Create scan binding] ****************************************
2025-11-24 08:38:08.739390 | controller | Monday 24 November 2025  08:38:08 +0000 (0:00:00.020)       0:00:30.435 *******
2025-11-24 08:38:08.739401 | controller | skipping: [instance]
2025-11-24 08:38:08.756218 | controller |
2025-11-24 08:38:08.756234 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-11-24 08:38:08.756241 | controller | Monday 24 November 2025  08:38:08 +0000 (0:00:00.017)       0:00:30.452 *******
2025-11-24 08:38:08.756249 | controller | skipping: [instance]
2025-11-24 08:38:08.944951 | controller |
2025-11-24 08:38:08.944984 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-11-24 08:38:08.944992 | controller | Monday 24 November 2025  08:38:08 +0000 (0:00:00.017)       0:00:30.469 *******
2025-11-24 08:38:08.945003 | controller | changed: [instance]
2025-11-24 08:38:09.136797 | controller |
2025-11-24 08:38:09.136827 | controller | TASK [compliance : Create directory for scan results] **************************
2025-11-24 08:38:09.136835 | controller | Monday 24 November 2025  08:38:08 +0000 (0:00:00.187)       0:00:30.657 *******
2025-11-24 08:38:09.136845 | controller | changed: [instance]
2025-11-24 08:38:09.136886 | controller |
2025-11-24 08:38:09.137151 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-11-24 08:38:09.154833 | controller | Monday 24 November 2025  08:38:09 +0000 (0:00:00.192)       0:00:30.850 *******
2025-11-24 08:38:09.154878 | controller | skipping: [instance]
2025-11-24 08:38:09.334594 | controller |
2025-11-24 08:38:09.334624 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-11-24 08:38:09.334632 | controller | Monday 24 November 2025  08:38:09 +0000 (0:00:00.017)       0:00:30.868 *******
2025-11-24 08:38:09.334642 | controller | ok: [instance]
2025-11-24 08:38:09.349816 | controller |
2025-11-24 08:38:09.349834 | controller | TASK [compliance : Process scan result files] **********************************
2025-11-24 08:38:09.349841 | controller | Monday 24 November 2025  08:38:09 +0000 (0:00:00.179)       0:00:31.047 *******
2025-11-24 08:38:09.349850 | controller | skipping: [instance]
2025-11-24 08:38:09.382851 | controller |
2025-11-24 08:38:09.382899 | controller | TASK [compliance : Delete all resources created by the role] *******************
2025-11-24 08:38:09.382907 | controller | Monday 24 November 2025  08:38:09 +0000 (0:00:00.015)       0:00:31.063 *******
2025-11-24 08:38:09.382918 | controller | skipping: [instance]
2025-11-24 08:38:09.382950 | controller |
2025-11-24 08:38:09.383088 | controller | PLAY RECAP *********************************************************************
2025-11-24 08:38:09.383168 | controller | instance                   : ok=200  changed=52   unreachable=0    failed=0    skipped=152  rescued=0    ignored=0
2025-11-24 08:38:09.383907 | controller |
2025-11-24 08:38:09.385210 | controller | Monday 24 November 2025  08:38:09 +0000 (0:00:00.032)       0:00:31.096 *******
2025-11-24 08:38:09.385229 | controller | ===============================================================================
2025-11-24 08:38:09.385236 | controller | compliance : Install packages to process results ------------------------ 4.95s
2025-11-24 08:38:09.385242 | controller | Gathering Facts --------------------------------------------------------- 0.86s
2025-11-24 08:38:09.385247 | controller | podman : Ensure podman is installed ------------------------------------- 0.76s
2025-11-24 08:38:09.385253 | controller | podman : Ensure podman is installed ------------------------------------- 0.65s
2025-11-24 08:38:09.385258 | controller | compliance : Install packages to process results ------------------------ 0.62s
2025-11-24 08:38:09.385267 | controller | Gathering Facts --------------------------------------------------------- 0.61s
2025-11-24 08:38:09.441884 | controller | podman : Enable loginctl linger for ansible_user_id --------------------- 0.41s
2025-11-24 08:38:09.441907 | controller | compliance : Ensure compliance folder exists ---------------------------- 0.30s
2025-11-24 08:38:09.441915 | controller | compliance : Find all the compressed scan results ----------------------- 0.28s
2025-11-24 08:38:09.441920 | controller | compliance : Ensure compliance folder exists ---------------------------- 0.20s
2025-11-24 08:38:09.441930 | controller | podman : Enable loginctl linger for ansible_user_id --------------------- 0.20s
2025-11-24 08:38:09.441935 | controller | compliance : Find all the compressed scan results ----------------------- 0.20s
2025-11-24 08:38:09.441941 | controller | compliance : Create directory for scan results -------------------------- 0.20s
2025-11-24 08:38:09.441949 | controller | compliance : Create directory for scan results -------------------------- 0.20s
2025-11-24 08:38:09.441954 | controller | compliance : Create directory for scan results -------------------------- 0.19s
2025-11-24 08:38:09.441960 | controller | compliance : Create directory for scan results -------------------------- 0.19s
2025-11-24 08:38:09.441965 | controller | compliance : Create directory for scan results -------------------------- 0.19s
2025-11-24 08:38:09.441970 | controller | compliance : Create directory for scan results -------------------------- 0.19s
2025-11-24 08:38:09.441975 | controller | compliance : Create directory for scan results -------------------------- 0.19s
2025-11-24 08:38:09.441980 | controller | compliance : Create directory for scan results -------------------------- 0.19s
2025-11-24 08:38:09.441989 | controller | INFO     Running default > cleanup
2025-11-24 08:38:09.442419 | controller | WARNING  Skipping, cleanup playbook not configured.
2025-11-24 08:38:09.443023 | controller | INFO     Writing /tmp/report.html report.
2025-11-24 08:38:09.609989 | controller | changed
2025-11-24 08:38:09.672540 | 
2025-11-24 08:38:09.672606 | PLAY RECAP
2025-11-24 08:38:09.672651 | controller | ok: 4 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-11-24 08:38:09.672675 | 
2025-11-24 08:38:09.868619 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-11-24 08:38:09.870034 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-11-24 08:38:10.920046 | 
2025-11-24 08:38:10.920194 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-11-24 08:38:10.968832 | 
2025-11-24 08:38:10.968998 | TASK [Filter out host if needed]
2025-11-24 08:38:11.002842 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-11-24 08:38:11.021287 | 
2025-11-24 08:38:11.021355 | TASK [Ensure file is present]
2025-11-24 08:38:11.386403 | controller | ok
2025-11-24 08:38:11.394496 | 
2025-11-24 08:38:11.394563 | TASK [Manage molecule report file]
2025-11-24 08:38:11.967360 | controller | changed
2025-11-24 08:38:11.973798 | 
2025-11-24 08:38:11.973874 | TASK [Check if we get ci-framework-data basedir]
2025-11-24 08:38:12.191270 | controller | ok
2025-11-24 08:38:12.200761 | 
2025-11-24 08:38:12.200863 | TASK [Create ci-framework-data log directory for zuul]
2025-11-24 08:38:12.693907 | controller | changed
2025-11-24 08:38:12.699333 | 
2025-11-24 08:38:12.699430 | TASK [Copy ci-framework interesting files]
2025-11-24 08:38:13.246318 | controller | changed
2025-11-24 08:38:13.252773 | 
2025-11-24 08:38:13.252842 | TASK [Get SELinux listing]
2025-11-24 08:38:13.813204 | controller | changed
2025-11-24 08:38:13.819799 | 
2025-11-24 08:38:13.819877 | TASK [Generate log index]
2025-11-24 08:38:14.656789 | controller | changed
2025-11-24 08:38:14.666763 | 
2025-11-24 08:38:14.666837 | TASK [Get some env related data]
2025-11-24 08:38:15.258968 | controller | /home/zuul/.local/bin/ansible
2025-11-24 08:38:16.226657 | controller | changed
2025-11-24 08:38:16.232636 | 
2025-11-24 08:38:16.232819 | TASK [Generate list of logs to collect in home directory]
2025-11-24 08:38:16.679208 | controller | ok: All paths examined
2025-11-24 08:38:16.772924 | 
2025-11-24 08:38:16.773061 | LOOP [Copy logs from home directory]
2025-11-24 08:38:17.126508 | controller | changed:
2025-11-24 08:38:17.126663 | controller | {
2025-11-24 08:38:17.126763 | controller |   "atime": 1763973418.3385131,
2025-11-24 08:38:17.126789 | controller |   "ctime": 1763973436.0124466,
2025-11-24 08:38:17.126808 | controller |   "dev": 64513,
2025-11-24 08:38:17.126825 | controller |   "gid": 1000,
2025-11-24 08:38:17.126842 | controller |   "gr_name": "zuul",
2025-11-24 08:38:17.126858 | controller |   "inode": 5167421,
2025-11-24 08:38:17.126874 | controller |   "isblk": false,
2025-11-24 08:38:17.126890 | controller |   "ischr": false,
2025-11-24 08:38:17.126906 | controller |   "isdir": false,
2025-11-24 08:38:17.126922 | controller |   "isfifo": false,
2025-11-24 08:38:17.126939 | controller |   "isgid": false,
2025-11-24 08:38:17.126954 | controller |   "islnk": false,
2025-11-24 08:38:17.126969 | controller |   "isreg": true,
2025-11-24 08:38:17.126998 | controller |   "issock": false,
2025-11-24 08:38:17.127016 | controller |   "isuid": false,
2025-11-24 08:38:17.127032 | controller |   "mode": "0644",
2025-11-24 08:38:17.127048 | controller |   "mtime": 1763973436.0124466,
2025-11-24 08:38:17.127063 | controller |   "nlink": 1,
2025-11-24 08:38:17.127086 | controller |   "path": "/home/zuul/ansible.log",
2025-11-24 08:38:17.127103 | controller |   "pw_name": "zuul",
2025-11-24 08:38:17.127122 | controller |   "rgrp": true,
2025-11-24 08:38:17.127138 | controller |   "roth": true,
2025-11-24 08:38:17.127153 | controller |   "rusr": true,
2025-11-24 08:38:17.127169 | controller |   "size": 6749,
2025-11-24 08:38:17.127184 | controller |   "uid": 1000,
2025-11-24 08:38:17.127198 | controller |   "wgrp": false,
2025-11-24 08:38:17.127214 | controller |   "woth": false,
2025-11-24 08:38:17.127229 | controller |   "wusr": true,
2025-11-24 08:38:17.127246 | controller |   "xgrp": false,
2025-11-24 08:38:17.127261 | controller |   "xoth": false,
2025-11-24 08:38:17.127276 | controller |   "xusr": false
2025-11-24 08:38:17.127291 | controller | }
2025-11-24 08:38:17.137413 | 
2025-11-24 08:38:17.137515 | TASK [Copy crio stats log file]
2025-11-24 08:38:17.182835 | controller | skipping: Conditional result was False
2025-11-24 08:38:17.192500 | 
2025-11-24 08:38:17.192583 | TASK [Get SELinux related data]
2025-11-24 08:38:17.459518 | controller | <no matches>
2025-11-24 08:38:17.750631 | controller | ERROR
2025-11-24 08:38:17.750851 | controller | {
2025-11-24 08:38:17.750892 | controller |   "delta": "0:00:00.009260",
2025-11-24 08:38:17.750915 | controller |   "end": "2025-11-24 08:38:17.460473",
2025-11-24 08:38:17.750936 | controller |   "msg": "non-zero return code",
2025-11-24 08:38:17.750953 | controller |   "rc": 1,
2025-11-24 08:38:17.750970 | controller |   "start": "2025-11-24 08:38:17.451213"
2025-11-24 08:38:17.751009 | controller | }
2025-11-24 08:38:17.751036 | controller | ERROR: Ignoring Errors
2025-11-24 08:38:17.756820 | 
2025-11-24 08:38:17.756911 | TASK [Create system configuration directory]
2025-11-24 08:38:17.983524 | controller | changed
2025-11-24 08:38:17.989020 | 
2025-11-24 08:38:17.989084 | TASK [Get some of the system configurations]
2025-11-24 08:38:18.531413 | controller | changed
2025-11-24 08:38:18.536955 | 
2025-11-24 08:38:18.537693 | TASK [Copy generated documentation if available]
2025-11-24 08:38:18.592489 | controller | skipping: Conditional result was False
2025-11-24 08:38:18.599472 | 
2025-11-24 08:38:18.599544 | TASK [Copy generated AsciiDoc documentation if available]
2025-11-24 08:38:18.642446 | controller | skipping: Conditional result was False
2025-11-24 08:38:18.649677 | 
2025-11-24 08:38:18.649743 | TASK [Compress logs bigger than 2MB]
2025-11-24 08:38:19.200694 | controller | changed
2025-11-24 08:38:19.206316 | 
2025-11-24 08:38:19.206422 | TASK [Copy files from workspace on node]
2025-11-24 08:38:19.245789 | controller | ok
2025-11-24 08:38:19.268936 | 
2025-11-24 08:38:19.269036 | TASK [fetch-output : Set log path for multiple nodes]
2025-11-24 08:38:19.296166 | controller | skipping: Conditional result was False
2025-11-24 08:38:19.303521 | 
2025-11-24 08:38:19.303594 | TASK [fetch-output : Set log path for single node]
2025-11-24 08:38:19.331925 | controller | ok
2025-11-24 08:38:19.336912 | 
2025-11-24 08:38:19.337001 | LOOP [fetch-output : Ensure local output dirs]
2025-11-24 08:38:19.576805 | controller -> localhost | ok: "/var/lib/zuul/builds/ac15b306401046d9b4e704832eed6e9b/work/logs"
2025-11-24 08:38:19.577152 | controller -> localhost | changed: All items complete
2025-11-24 08:38:19.577183 | 
2025-11-24 08:38:19.819780 | controller -> localhost | changed: "/var/lib/zuul/builds/ac15b306401046d9b4e704832eed6e9b/work/artifacts"
2025-11-24 08:38:20.055354 | controller -> localhost | changed: "/var/lib/zuul/builds/ac15b306401046d9b4e704832eed6e9b/work/docs"
2025-11-24 08:38:20.074466 | 
2025-11-24 08:38:20.074600 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-11-24 08:38:20.678484 | controller | changed:
2025-11-24 08:38:20.678711 | controller | .d..t...... ./
2025-11-24 08:38:20.678745 | controller | >f+++++++++ README.html
2025-11-24 08:38:20.678768 | controller | >f+++++++++ ansible-execution.log
2025-11-24 08:38:20.678791 | controller | >f+++++++++ ansible.log
2025-11-24 08:38:20.678815 | controller | >f+++++++++ dmesg.log
2025-11-24 08:38:20.678834 | controller | >f+++++++++ installed-pkgs.log
2025-11-24 08:38:20.678851 | controller | >f+++++++++ python.log
2025-11-24 08:38:20.678872 | controller | >f+++++++++ registries.conf
2025-11-24 08:38:20.678891 | controller | >f+++++++++ report.html
2025-11-24 08:38:20.678909 | controller | >f+++++++++ selinux-denials.log
2025-11-24 08:38:20.678928 | controller | >f+++++++++ selinux-listing.log
2025-11-24 08:38:20.678946 | controller | cd+++++++++ ci-framework-data/
2025-11-24 08:38:20.678964 | controller | cd+++++++++ ci-framework-data/artifacts/
2025-11-24 08:38:20.678994 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2025-11-24 08:38:20.679014 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2025-11-24 08:38:20.679033 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2025-11-24 08:38:20.679050 | controller | cd+++++++++ ci-framework-data/logs/
2025-11-24 08:38:20.679067 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2025-11-24 08:38:20.679085 | controller | cd+++++++++ ci-framework-data/tests/
2025-11-24 08:38:20.679102 | controller | cd+++++++++ ci-framework-data/tests/compliance/
2025-11-24 08:38:20.679119 | controller | cd+++++++++ ci-framework-data/tests/compliance/cis/
2025-11-24 08:38:20.679135 | controller | cd+++++++++ ci-framework-data/tests/compliance/cis/ocp4-cis/
2025-11-24 08:38:20.679151 | controller | cd+++++++++ ci-framework-data/tests/compliance/e8/
2025-11-24 08:38:20.679167 | controller | cd+++++++++ ci-framework-data/tests/compliance/e8/ocp4-e8/
2025-11-24 08:38:20.679183 | controller | cd+++++++++ ci-framework-data/tests/compliance/e8/rhcos4-e8/
2025-11-24 08:38:20.679199 | controller | cd+++++++++ ci-framework-data/tests/compliance/high/
2025-11-24 08:38:20.679215 | controller | cd+++++++++ ci-framework-data/tests/compliance/high/ocp4-high-node/
2025-11-24 08:38:20.679230 | controller | cd+++++++++ ci-framework-data/tests/compliance/high/ocp4-high/
2025-11-24 08:38:20.679246 | controller | cd+++++++++ ci-framework-data/tests/compliance/high/rhcos4-high/
2025-11-24 08:38:20.679261 | controller | cd+++++++++ ci-framework-data/tests/compliance/moderate/
2025-11-24 08:38:20.679276 | controller | cd+++++++++ ci-framework-data/tests/compliance/moderate/ocp4-moderate-node/
2025-11-24 08:38:20.679292 | controller | cd+++++++++ ci-framework-data/tests/compliance/moderate/ocp4-moderate/
2025-11-24 08:38:20.679308 | controller | cd+++++++++ ci-framework-data/tests/compliance/moderate/rhcos4-moderate/
2025-11-24 08:38:20.679323 | controller | cd+++++++++ ci-framework-data/tests/compliance/nerc-cip/
2025-11-24 08:38:20.679339 | controller | cd+++++++++ ci-framework-data/tests/compliance/nerc-cip/ocp4-nerc-cip-node/
2025-11-24 08:38:20.679354 | controller | cd+++++++++ ci-framework-data/tests/compliance/nerc-cip/ocp4-nerc-cip/
2025-11-24 08:38:20.679369 | controller | cd+++++++++ ci-framework-data/tests/compliance/pci-dss/
2025-11-24 08:38:20.679405 | controller | cd+++++++++ ci-framework-data/tests/compliance/pci-dss/ocp4-pci-dss-node/
2025-11-24 08:38:20.679430 | controller | cd+++++++++ ci-framework-data/tests/compliance/pci-dss/ocp4-pci-dss/
2025-11-24 08:38:20.679458 | controller | cd+++++++++ ci-framework-data/tests/compliance/stig/
2025-11-24 08:38:20.679476 | controller | cd+++++++++ ci-framework-data/tests/compliance/stig/ocp4-stig-node/
2025-11-24 08:38:20.679492 | controller | cd+++++++++ ci-framework-data/tests/compliance/stig/ocp4-stig/
2025-11-24 08:38:20.679508 | controller | cd+++++++++ ci-framework-data/tests/compliance/stig/rhcos4-stig/
2025-11-24 08:38:20.679523 | controller | cd+++++++++ registries.conf.d/
2025-11-24 08:38:20.679539 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-11-24 08:38:20.679554 | controller | cd+++++++++ system-config/
2025-11-24 08:38:20.679569 | controller | cd+++++++++ system-config/libvirt/
2025-11-24 08:38:20.679584 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2025-11-24 08:38:20.679603 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2025-11-24 08:38:21.051332 | controller | changed: .d..t...... ./
2025-11-24 08:38:21.437082 | controller | changed: .d..t...... ./
2025-11-24 08:38:21.455653 | 
2025-11-24 08:38:21.455751 | TASK [Return artifact to Zuul]
2025-11-24 08:38:21.525221 | controller | ok
2025-11-24 08:38:21.572587 | 
2025-11-24 08:38:21.572686 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-11-24 08:38:21.572791 | 
2025-11-24 08:38:21.572818 | PLAY RECAP
2025-11-24 08:38:21.572857 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2025-11-24 08:38:21.572877 | 
2025-11-24 08:38:21.705003 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-11-24 08:38:21.705949 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-11-24 08:38:22.419585 | 
2025-11-24 08:38:22.419718 | PLAY [all]
2025-11-24 08:38:22.442541 | 
2025-11-24 08:38:22.442655 | TASK [include_role : fetch-output]
2025-11-24 08:38:22.515892 | controller | ok
2025-11-24 08:38:22.538025 | 
2025-11-24 08:38:22.538117 | TASK [fetch-output : Set log path for multiple nodes]
2025-11-24 08:38:22.594796 | controller | skipping: Conditional result was False
2025-11-24 08:38:22.600642 | 
2025-11-24 08:38:22.600716 | TASK [fetch-output : Set log path for single node]
2025-11-24 08:38:22.629302 | controller | ok
2025-11-24 08:38:22.635319 | 
2025-11-24 08:38:22.635408 | LOOP [fetch-output : Ensure local output dirs]
2025-11-24 08:38:22.971933 | controller -> localhost | ok: "/var/lib/zuul/builds/ac15b306401046d9b4e704832eed6e9b/work/logs"
2025-11-24 08:38:23.190914 | controller -> localhost | ok: "/var/lib/zuul/builds/ac15b306401046d9b4e704832eed6e9b/work/artifacts"
2025-11-24 08:38:23.496871 | controller -> localhost | ok: "/var/lib/zuul/builds/ac15b306401046d9b4e704832eed6e9b/work/docs"
2025-11-24 08:38:23.516689 | 
2025-11-24 08:38:23.516760 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-11-24 08:38:24.147540 | controller | ok
2025-11-24 08:38:24.147730 | controller | ok: All items complete
2025-11-24 08:38:24.147759 | 
2025-11-24 08:38:24.584121 | controller | ok
2025-11-24 08:38:25.015318 | controller | ok
2025-11-24 08:38:25.035208 | 
2025-11-24 08:38:25.035314 | TASK [include_role : fetch-output-openshift]
2025-11-24 08:38:25.059313 | controller | skipping: Conditional result was False
2025-11-24 08:38:25.065718 | 
2025-11-24 08:38:25.065793 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-11-24 08:38:25.451677 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006856
2025-11-24 08:38:25.657119 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007383
2025-11-24 08:38:25.718243 | 
2025-11-24 08:38:25.718372 | PLAY [all]
2025-11-24 08:38:25.736123 | 
2025-11-24 08:38:25.736248 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-11-24 08:38:26.156518 | controller | changed
2025-11-24 08:38:26.179310 | 
2025-11-24 08:38:26.179364 | PLAY RECAP
2025-11-24 08:38:26.179436 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-11-24 08:38:26.179462 | 
2025-11-24 08:38:26.279179 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-11-24 08:38:26.279941 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-11-24 08:38:26.944768 | 
2025-11-24 08:38:26.944883 | PLAY [localhost]
2025-11-24 08:38:26.973680 | 
2025-11-24 08:38:26.973761 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-11-24 08:38:27.422239 | localhost | changed
2025-11-24 08:38:27.426899 | 
2025-11-24 08:38:27.427014 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-11-24 08:38:27.456054 | localhost | ok
2025-11-24 08:38:27.464486 | 
2025-11-24 08:38:27.464576 | TASK [add-fileserver : Create SSH private key tempfile]
2025-11-24 08:38:27.961113 | localhost | changed
2025-11-24 08:38:27.969889 | 
2025-11-24 08:38:27.969959 | TASK [add-fileserver : Create SSH private key from secret]
2025-11-24 08:38:28.650955 | localhost | changed
2025-11-24 08:38:28.655873 | 
2025-11-24 08:38:28.655938 | TASK [add-fileserver : Add fileserver ssh key]
2025-11-24 08:38:29.104814 | localhost | Identity added: /var/lib/zuul/builds/ac15b306401046d9b4e704832eed6e9b/work/tmp/ansible.avbugt1b (/var/lib/zuul/builds/ac15b306401046d9b4e704832eed6e9b/work/tmp/ansible.avbugt1b)
2025-11-24 08:38:29.104984 | localhost | ok: Runtime: 0:00:00.009723
2025-11-24 08:38:29.109419 | 
2025-11-24 08:38:29.109487 | TASK [add-fileserver : Remove SSH private key from disk]
2025-11-24 08:38:29.428686 | localhost | ok: Runtime: 0:00:00.005836
2025-11-24 08:38:29.434555 | 
2025-11-24 08:38:29.434621 | TASK [add-fileserver : Add fileserver to inventory]
2025-11-24 08:38:29.489893 | localhost | changed
2025-11-24 08:38:29.494477 | 
2025-11-24 08:38:29.494543 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-11-24 08:38:29.943315 | localhost | changed
2025-11-24 08:38:29.965230 | 
2025-11-24 08:38:29.965364 | PLAY [localhost]
2025-11-24 08:38:29.978195 | 
2025-11-24 08:38:29.978261 | TASK [Generate bulk log download script]
2025-11-24 08:38:29.997215 | localhost | ok
2025-11-24 08:38:30.010329 | 
2025-11-24 08:38:30.010418 | TASK [local-log-download : Check API endpoint is defined]
2025-11-24 08:38:30.038698 | localhost | ok: All assertions passed
2025-11-24 08:38:30.043264 | 
2025-11-24 08:38:30.043330 | TASK [local-log-download : Create download script]
2025-11-24 08:38:30.453619 | localhost -> localhost | changed
2025-11-24 08:38:30.464305 | 
2025-11-24 08:38:30.464415 | TASK [Register quick-download link]
2025-11-24 08:38:30.503594 | localhost | ok
2025-11-24 08:38:30.519240 | 
2025-11-24 08:38:30.519302 | PLAY [logserver.rdoproject.org]
2025-11-24 08:38:30.529362 | 
2025-11-24 08:38:30.529441 | TASK [Set zuul-log-path fact]
2025-11-24 08:38:30.550724 | logserver.rdoproject.org | ok
2025-11-24 08:38:30.560536 | 
2025-11-24 08:38:30.560605 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-11-24 08:38:30.586959 | logserver.rdoproject.org | ok
2025-11-24 08:38:30.594248 | 
2025-11-24 08:38:30.594429 | TASK [upload-logs : Create log directories]
2025-11-24 08:38:32.288040 | logserver.rdoproject.org | changed
2025-11-24 08:38:32.293155 | 
2025-11-24 08:38:32.293219 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-11-24 08:38:32.554198 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.008468
2025-11-24 08:38:32.559305 | 
2025-11-24 08:38:32.559405 | TASK [upload-logs : Upload logs to log server]
2025-11-24 08:38:34.099704 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-11-24 08:38:34.102761 | 
2025-11-24 08:38:34.102830 | LOOP [upload-logs : Compress console log and json output]
2025-11-24 08:38:34.150219 | logserver.rdoproject.org | skipping: Conditional result was False
2025-11-24 08:38:34.160028 | logserver.rdoproject.org | skipping: Conditional result was False
2025-11-24 08:38:34.172542 | 
2025-11-24 08:38:34.172616 | LOOP [upload-logs : Upload compressed console log and json output]
2025-11-24 08:38:34.214148 | logserver.rdoproject.org | skipping: Conditional result was False
2025-11-24 08:38:34.214355 | 
2025-11-24 08:38:34.219405 | logserver.rdoproject.org | skipping: Conditional result was False
2025-11-24 08:38:34.230934 | 
2025-11-24 08:38:34.231024 | LOOP [upload-logs : Upload console log and json output]