2026-01-21 14:58:30.770245 | Job console starting...
2026-01-21 14:58:30.966551 | Updating repositories
2026-01-21 14:58:31.819160 | Preparing job workspace
2026-01-21 14:58:49.301613 | Running Ansible setup...
2026-01-21 14:58:58.385711 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-01-21 14:59:00.678890 | 
2026-01-21 14:59:00.679012 | PLAY [localhost]
2026-01-21 14:59:00.711374 | 
2026-01-21 14:59:00.711475 | TASK [Gathering Facts]
2026-01-21 14:59:04.495464 | localhost | ok
2026-01-21 14:59:04.543650 | 
2026-01-21 14:59:04.543783 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-01-21 14:59:06.375162 | localhost -> localhost | changed
2026-01-21 14:59:06.380758 | 
2026-01-21 14:59:06.380847 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-01-21 14:59:09.909996 | localhost -> localhost | changed
2026-01-21 14:59:09.918450 | 
2026-01-21 14:59:09.918533 | TASK [Setup log path fact]
2026-01-21 14:59:09.961282 | localhost | ok
2026-01-21 14:59:10.018143 | 
2026-01-21 14:59:10.018229 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-01-21 14:59:10.124034 | localhost | ok
2026-01-21 14:59:10.142599 | 
2026-01-21 14:59:10.142680 | TASK [emit-job-header : Print job information]
2026-01-21 14:59:10.246900 | # Job Information
2026-01-21 14:59:10.247049 | Ansible Version: 2.15.12
2026-01-21 14:59:10.247082 | Job: cifmw-molecule-compliance
2026-01-21 14:59:10.247107 | Pipeline: github-check
2026-01-21 14:59:10.247128 | Executor: ibm-bm3-ze.softwarefactory-project.io
2026-01-21 14:59:10.247147 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3612
2026-01-21 14:59:10.247168 | Log URL (when completed): https://logserver.rdoproject.org/048/rdoproject.org/048562c1260c475890de1086a113b87b/
2026-01-21 14:59:10.247188 | Event ID: 74607520-f6d9-11f0-9dda-0587936d9c0f
2026-01-21 14:59:10.252996 | 
2026-01-21 14:59:10.253078 | LOOP [emit-job-header : Print node information]
2026-01-21 14:59:10.672130 | localhost | ok:
2026-01-21 14:59:10.672338 | localhost | # Node Information
2026-01-21 14:59:10.672374 | localhost | Inventory Hostname: controller
2026-01-21 14:59:10.672401 | localhost | Hostname: np0005590736
2026-01-21 14:59:10.672422 | localhost | Username: zuul
2026-01-21 14:59:10.672443 | localhost | Distro: CentOS 9
2026-01-21 14:59:10.672462 | localhost | Provider: ibm-bm3-nodepool
2026-01-21 14:59:10.672482 | localhost | Region: regionOne
2026-01-21 14:59:10.672501 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2026-01-21 14:59:10.672521 | localhost | Product Name: OpenStack Compute
2026-01-21 14:59:10.672539 | localhost | Interface IP: 192.168.25.223
2026-01-21 14:59:10.742659 | 
2026-01-21 14:59:10.742745 | PLAY [all]
2026-01-21 14:59:10.769797 | 
2026-01-21 14:59:10.769877 | TASK [Gather network facts]
2026-01-21 14:59:11.246357 | controller | ok
2026-01-21 14:59:11.278393 | 
2026-01-21 14:59:11.278475 | TASK [include_role : start-zuul-console]
2026-01-21 14:59:11.370552 | controller | ok
2026-01-21 14:59:11.411746 | 
2026-01-21 14:59:11.411827 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-01-21 14:59:11.908236 | controller | ok
2026-01-21 14:59:11.946749 | 
2026-01-21 14:59:11.946861 | TASK [include_role : add-build-sshkey]
2026-01-21 14:59:12.036250 | controller | ok
2026-01-21 14:59:12.090405 | 
2026-01-21 14:59:12.094764 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-01-21 14:59:12.842527 | controller -> localhost | ok
2026-01-21 14:59:12.847897 | 
2026-01-21 14:59:12.847977 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-01-21 14:59:12.907700 | controller | ok
2026-01-21 14:59:12.938362 | controller | included: /var/lib/zuul/builds/048562c1260c475890de1086a113b87b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-01-21 14:59:12.970347 | 
2026-01-21 14:59:12.970419 | TASK [add-build-sshkey : Create Temp SSH key]
2026-01-21 14:59:15.168100 | controller -> localhost | Generating public/private rsa key pair.
2026-01-21 14:59:15.168294 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/048562c1260c475890de1086a113b87b/work/048562c1260c475890de1086a113b87b_id_rsa.
2026-01-21 14:59:15.168340 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/048562c1260c475890de1086a113b87b/work/048562c1260c475890de1086a113b87b_id_rsa.pub.
2026-01-21 14:59:15.168367 | controller -> localhost | The key fingerprint is:
2026-01-21 14:59:15.168389 | controller -> localhost | SHA256:0cpwtyxzV0SVQ9iXnBm0Tmk2D78FIiZLXe512cCOtbU zuul-build-sshkey
2026-01-21 14:59:15.168409 | controller -> localhost | The key's randomart image is:
2026-01-21 14:59:15.168428 | controller -> localhost | +---[RSA 3072]----+
2026-01-21 14:59:15.168448 | controller -> localhost | |            .oX=B|
2026-01-21 14:59:15.168467 | controller -> localhost | |         o o ooXB|
2026-01-21 14:59:15.168486 | controller -> localhost | |      . = * o+=@*|
2026-01-21 14:59:15.168505 | controller -> localhost | |       = O +.+BEo|
2026-01-21 14:59:15.168522 | controller -> localhost | |        S + o  .+|
2026-01-21 14:59:15.168540 | controller -> localhost | |         + .    o|
2026-01-21 14:59:15.168557 | controller -> localhost | |               . |
2026-01-21 14:59:15.168574 | controller -> localhost | |                 |
2026-01-21 14:59:15.168592 | controller -> localhost | |                 |
2026-01-21 14:59:15.168609 | controller -> localhost | +----[SHA256]-----+
2026-01-21 14:59:15.168655 | controller -> localhost | ok: Runtime: 0:00:00.978995
2026-01-21 14:59:15.174968 | 
2026-01-21 14:59:15.175051 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-01-21 14:59:15.275873 | controller | ok
2026-01-21 14:59:15.307378 | controller | included: /var/lib/zuul/builds/048562c1260c475890de1086a113b87b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-01-21 14:59:15.349941 | 
2026-01-21 14:59:15.350050 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-01-21 14:59:15.432477 | controller | skipping: Conditional result was False
2026-01-21 14:59:15.443039 | 
2026-01-21 14:59:15.443124 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-01-21 14:59:16.390936 | controller | changed
2026-01-21 14:59:16.395873 | 
2026-01-21 14:59:16.395954 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-01-21 14:59:16.814402 | controller | ok
2026-01-21 14:59:16.834364 | 
2026-01-21 14:59:16.834453 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-01-21 14:59:17.748002 | controller | changed
2026-01-21 14:59:17.753237 | 
2026-01-21 14:59:17.753326 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-01-21 14:59:18.633189 | controller | changed
2026-01-21 14:59:18.638134 | 
2026-01-21 14:59:18.638215 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-01-21 14:59:18.741790 | controller | skipping: Conditional result was False
2026-01-21 14:59:18.753864 | 
2026-01-21 14:59:18.753984 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-01-21 14:59:20.482055 | controller -> localhost | changed
2026-01-21 14:59:20.498162 | 
2026-01-21 14:59:20.498258 | TASK [add-build-sshkey : Add back temp key]
2026-01-21 14:59:21.921962 | controller -> localhost | Identity added: /var/lib/zuul/builds/048562c1260c475890de1086a113b87b/work/048562c1260c475890de1086a113b87b_id_rsa (zuul-build-sshkey)
2026-01-21 14:59:21.922163 | controller -> localhost | ok: Runtime: 0:00:00.140230
2026-01-21 14:59:21.928857 | 
2026-01-21 14:59:21.928930 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-01-21 14:59:22.451001 | controller | ok
2026-01-21 14:59:22.456072 | 
2026-01-21 14:59:22.456142 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-01-21 14:59:22.550819 | controller | skipping: Conditional result was False
2026-01-21 14:59:22.572817 | 
2026-01-21 14:59:22.572900 | TASK [include_role : validate-host]
2026-01-21 14:59:22.656519 | controller | ok
2026-01-21 14:59:22.832934 | 
2026-01-21 14:59:22.833046 | TASK [validate-host : Define zuul_info_dir fact]
2026-01-21 14:59:22.962805 | controller | ok
2026-01-21 14:59:22.970246 | 
2026-01-21 14:59:22.970328 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-01-21 14:59:24.075861 | controller -> localhost | ok
2026-01-21 14:59:24.081806 | 
2026-01-21 14:59:24.081872 | TASK [validate-host : Collect information about the host]
2026-01-21 14:59:24.721781 | controller | ok
2026-01-21 14:59:24.754228 | 
2026-01-21 14:59:24.754357 | TASK [validate-host : Sanitize hostname]
2026-01-21 14:59:24.941824 | controller | ok
2026-01-21 14:59:24.947787 | 
2026-01-21 14:59:24.947879 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-01-21 14:59:26.869403 | controller -> localhost | changed
2026-01-21 14:59:26.875491 | 
2026-01-21 14:59:26.875569 | TASK [validate-host : Collect information about zuul worker]
2026-01-21 14:59:28.137930 | controller | ok
2026-01-21 14:59:28.142546 | 
2026-01-21 14:59:28.142611 | TASK [validate-host : Write out all zuul information for each host]
2026-01-21 14:59:29.762674 | controller -> localhost | changed
2026-01-21 14:59:29.783197 | 
2026-01-21 14:59:29.783547 | TASK [include_role : prepare-workspace-openshift]
2026-01-21 14:59:29.877179 | controller | skipping: Conditional result was False
2026-01-21 14:59:29.883335 | 
2026-01-21 14:59:29.883419 | TASK [include_role : remove-zuul-sshkey]
2026-01-21 14:59:29.949906 | controller | skipping: Conditional result was False
2026-01-21 14:59:29.957015 | 
2026-01-21 14:59:29.957115 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-01-21 14:59:30.256896 | controller | ok: "logs"
2026-01-21 14:59:30.257120 | controller | ok: All items complete
2026-01-21 14:59:30.257151 | 
2026-01-21 14:59:30.447751 | controller | ok: "artifacts"
2026-01-21 14:59:30.650642 | controller | ok: "docs"
2026-01-21 14:59:30.666473 | 
2026-01-21 14:59:30.666554 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-01-21 14:59:30.995535 | controller | changed: "logs"
2026-01-21 14:59:31.206147 | controller | changed: "artifacts"
2026-01-21 14:59:31.431166 | controller | changed: "docs"
2026-01-21 14:59:31.519904 | 
2026-01-21 14:59:31.519986 | PLAY RECAP
2026-01-21 14:59:31.520045 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-01-21 14:59:31.520087 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-01-21 14:59:31.520108 | 
2026-01-21 14:59:32.506232 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-01-21 14:59:32.506993 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-01-21 14:59:34.459124 | 
2026-01-21 14:59:34.459237 | PLAY [all]
2026-01-21 14:59:34.528326 | 
2026-01-21 14:59:34.528472 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-01-21 14:59:34.785461 | controller | ok
2026-01-21 14:59:34.795916 | 
2026-01-21 14:59:34.796000 | TASK [mirror-info-fork : Create /etc/ci]
2026-01-21 14:59:35.917676 | controller | changed
2026-01-21 14:59:35.923499 | 
2026-01-21 14:59:35.923575 | TASK [mirror-info-fork : Install ci_mirror script]
2026-01-21 14:59:38.134047 | controller | changed
2026-01-21 14:59:38.171222 | 
2026-01-21 14:59:38.171335 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2026-01-21 14:59:38.685104 | controller | changed:
2026-01-21 14:59:38.685436 | controller | {
2026-01-21 14:59:38.685481 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2026-01-21 14:59:38.685515 | controller | }
2026-01-21 14:59:38.901642 | controller | changed:
2026-01-21 14:59:38.901742 | controller | {
2026-01-21 14:59:38.901773 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2026-01-21 14:59:38.901795 | controller | }
2026-01-21 14:59:39.181146 | controller | changed:
2026-01-21 14:59:39.181239 | controller | {
2026-01-21 14:59:39.181289 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2026-01-21 14:59:39.181316 | controller | }
2026-01-21 14:59:39.392492 | controller | changed:
2026-01-21 14:59:39.392580 | controller | {
2026-01-21 14:59:39.392610 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2026-01-21 14:59:39.392631 | controller | }
2026-01-21 14:59:39.619246 | controller | changed:
2026-01-21 14:59:39.619370 | controller | {
2026-01-21 14:59:39.619401 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2026-01-21 14:59:39.619422 | controller | }
2026-01-21 14:59:39.869547 | controller | changed:
2026-01-21 14:59:39.869637 | controller | {
2026-01-21 14:59:39.869669 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2026-01-21 14:59:39.869692 | controller | }
2026-01-21 14:59:40.122122 | controller | changed:
2026-01-21 14:59:40.122214 | controller | {
2026-01-21 14:59:40.122453 | 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"
2026-01-21 14:59:40.122500 | controller | }
2026-01-21 14:59:40.490899 | controller | changed:
2026-01-21 14:59:40.490992 | controller | {
2026-01-21 14:59:40.491021 | 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"
2026-01-21 14:59:40.491062 | controller | }
2026-01-21 14:59:40.618179 | controller | changed:
2026-01-21 14:59:40.618282 | controller | {
2026-01-21 14:59:40.618316 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2026-01-21 14:59:40.618340 | controller | }
2026-01-21 14:59:40.869548 | controller | changed:
2026-01-21 14:59:40.869630 | controller | {
2026-01-21 14:59:40.869659 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2026-01-21 14:59:40.869680 | controller | }
2026-01-21 14:59:41.102723 | controller | changed:
2026-01-21 14:59:41.102830 | controller | {
2026-01-21 14:59:41.102858 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2026-01-21 14:59:41.102880 | controller | }
2026-01-21 14:59:41.347454 | controller | changed:
2026-01-21 14:59:41.347544 | controller | {
2026-01-21 14:59:41.347574 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2026-01-21 14:59:41.347596 | controller | }
2026-01-21 14:59:41.576132 | controller | changed:
2026-01-21 14:59:41.576210 | controller | {
2026-01-21 14:59:41.576237 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2026-01-21 14:59:41.576259 | controller | }
2026-01-21 14:59:41.793985 | controller | changed:
2026-01-21 14:59:41.794074 | controller | {
2026-01-21 14:59:41.794104 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2026-01-21 14:59:41.794126 | controller | }
2026-01-21 14:59:42.036439 | controller | changed:
2026-01-21 14:59:42.036519 | controller | {
2026-01-21 14:59:42.036546 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2026-01-21 14:59:42.036567 | controller | }
2026-01-21 14:59:42.260648 | controller | changed:
2026-01-21 14:59:42.260729 | controller | {
2026-01-21 14:59:42.260757 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2026-01-21 14:59:42.260777 | controller | }
2026-01-21 14:59:42.476794 | controller | changed:
2026-01-21 14:59:42.476885 | controller | {
2026-01-21 14:59:42.476913 | 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"
2026-01-21 14:59:42.476935 | controller | }
2026-01-21 14:59:42.728812 | controller | changed:
2026-01-21 14:59:42.728890 | controller | {
2026-01-21 14:59:42.728919 | 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"
2026-01-21 14:59:42.728947 | controller | }
2026-01-21 14:59:42.944947 | controller | changed:
2026-01-21 14:59:42.945077 | controller | {
2026-01-21 14:59:42.945107 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2026-01-21 14:59:42.945137 | controller | }
2026-01-21 14:59:43.179798 | controller | changed:
2026-01-21 14:59:43.179881 | controller | {
2026-01-21 14:59:43.179934 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2026-01-21 14:59:43.179958 | controller | }
2026-01-21 14:59:43.392705 | controller | changed:
2026-01-21 14:59:43.392787 | controller | {
2026-01-21 14:59:43.392815 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2026-01-21 14:59:43.392836 | controller | }
2026-01-21 14:59:43.652826 | controller | changed:
2026-01-21 14:59:43.652905 | controller | {
2026-01-21 14:59:43.652932 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2026-01-21 14:59:43.652954 | controller | }
2026-01-21 14:59:43.936534 | controller | changed:
2026-01-21 14:59:43.936685 | controller | {
2026-01-21 14:59:43.936722 | 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"
2026-01-21 14:59:43.936747 | controller | }
2026-01-21 14:59:44.170814 | controller | changed:
2026-01-21 14:59:44.170911 | controller | {
2026-01-21 14:59:44.170937 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2026-01-21 14:59:44.170957 | controller | }
2026-01-21 14:59:44.383666 | controller | changed:
2026-01-21 14:59:44.383748 | controller | {
2026-01-21 14:59:44.383775 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2026-01-21 14:59:44.383795 | controller | }
2026-01-21 14:59:44.603528 | controller | changed:
2026-01-21 14:59:44.603692 | controller | {
2026-01-21 14:59:44.603724 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2026-01-21 14:59:44.603746 | controller | }
2026-01-21 14:59:44.656221 | 
2026-01-21 14:59:44.656351 | TASK [Set timezone to UTC]
2026-01-21 14:59:45.358196 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2026-01-21 14:59:45.366206 | 
2026-01-21 14:59:45.366307 | TASK [Create nodepool directory]
2026-01-21 14:59:45.643979 | controller | changed
2026-01-21 14:59:45.649899 | 
2026-01-21 14:59:45.649981 | TASK [Create nodepool sub_nodes file]
2026-01-21 14:59:46.492587 | controller | changed
2026-01-21 14:59:46.497666 | 
2026-01-21 14:59:46.497749 | TASK [Create nodepool sub_nodes_private file]
2026-01-21 14:59:47.305123 | controller | changed
2026-01-21 14:59:47.313582 | 
2026-01-21 14:59:47.313666 | LOOP [Populate nodepool sub_nodes file]
2026-01-21 14:59:47.473938 | 
2026-01-21 14:59:47.474090 | LOOP [Populate nodepool sub_nodes_private file]
2026-01-21 14:59:47.568850 | 
2026-01-21 14:59:47.569059 | TASK [Create nodepool primary file]
2026-01-21 14:59:47.656581 | controller | skipping: Conditional result was False
2026-01-21 14:59:47.662862 | 
2026-01-21 14:59:47.662955 | TASK [Create nodepool node_private for this node]
2026-01-21 14:59:48.560065 | controller | changed
2026-01-21 14:59:48.568008 | 
2026-01-21 14:59:48.568097 | LOOP [Copy ssh keys to nodepool directory]
2026-01-21 14:59:49.551374 | controller | ok: Item: id_rsa Runtime: 0:00:00.004628
2026-01-21 14:59:49.551533 | 
2026-01-21 14:59:49.765693 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004344
2026-01-21 14:59:49.776615 | 
2026-01-21 14:59:49.776719 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2026-01-21 14:59:50.603970 | controller | changed
2026-01-21 14:59:50.609698 | 
2026-01-21 14:59:50.609777 | TASK [Validate sudoers config after edits]
2026-01-21 14:59:50.933615 | controller | /etc/sudoers: parsed OK
2026-01-21 14:59:50.933689 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2026-01-21 14:59:50.933700 | controller | /etc/sudoers.d/zuul: parsed OK
2026-01-21 14:59:50.933707 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2026-01-21 14:59:51.184468 | controller | ok: Runtime: 0:00:00.005457
2026-01-21 14:59:51.191468 | 
2026-01-21 14:59:51.191538 | TASK [Show the environment passed in to job shell scripts]
2026-01-21 14:59:51.548228 | controller | SHELL=/bin/bash
2026-01-21 14:59:51.548348 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2026-01-21 14:59:51.548362 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2026-01-21 14:59:51.548370 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/12/3612/ad59be263468c9d65538fe1fed8944959129e83c
2026-01-21 14:59:51.548377 | controller | PWD=/home/zuul
2026-01-21 14:59:51.548382 | controller | ZUUL_PIPELINE=github-check
2026-01-21 14:59:51.548388 | controller | LOGNAME=zuul
2026-01-21 14:59:51.548394 | controller | XDG_SESSION_TYPE=tty
2026-01-21 14:59:51.548399 | controller | _=/usr/bin/env
2026-01-21 14:59:51.548405 | controller | MOTD_SHOWN=pam
2026-01-21 14:59:51.548410 | controller | HOME=/home/zuul
2026-01-21 14:59:51.548415 | controller | LANG=en_US.UTF-8
2026-01-21 14:59:51.548421 | controller | SSH_CONNECTION=192.168.25.12 54658 192.168.25.223 22
2026-01-21 14:59:51.548427 | 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
2026-01-21 14:59:51.548436 | controller | ZUUL_CHANGE_IDS=3612,ad59be263468c9d65538fe1fed8944959129e83c
2026-01-21 14:59:51.548441 | controller | WORKSPACE=/home/zuul/workspace
2026-01-21 14:59:51.548447 | controller | XDG_SESSION_CLASS=user
2026-01-21 14:59:51.548453 | controller | SELINUX_ROLE_REQUESTED=
2026-01-21 14:59:51.548458 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2026-01-21 14:59:51.548464 | controller | USER=zuul
2026-01-21 14:59:51.548469 | controller | ZUUL_VOTING=True
2026-01-21 14:59:51.548475 | controller | BUILD_TIMEOUT=1800000
2026-01-21 14:59:51.548480 | controller | SELINUX_USE_CURRENT_RANGE=
2026-01-21 14:59:51.548486 | controller | SHLVL=1
2026-01-21 14:59:51.548491 | controller | ZUUL_PATCHSET=ad59be263468c9d65538fe1fed8944959129e83c
2026-01-21 14:59:51.548496 | controller | XDG_SESSION_ID=1
2026-01-21 14:59:51.548502 | controller | ZUUL_BRANCH=main
2026-01-21 14:59:51.548508 | controller | XDG_RUNTIME_DIR=/run/user/1000
2026-01-21 14:59:51.548514 | controller | SSH_CLIENT=192.168.25.12 54658 22
2026-01-21 14:59:51.548519 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2026-01-21 14:59:51.548525 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2026-01-21 14:59:51.548532 | controller | which_declare=declare -f
2026-01-21 14:59:51.548539 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2026-01-21 14:59:51.548545 | controller | SELINUX_LEVEL_REQUESTED=
2026-01-21 14:59:51.548551 | controller | ZUUL_CHANGE=3612
2026-01-21 14:59:51.548556 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2026-01-21 14:59:51.548561 | controller | ZUUL_UUID=048562c1260c475890de1086a113b87b
2026-01-21 14:59:51.548567 | controller | BASH_FUNC_which%%=() {  ( alias;
2026-01-21 14:59:51.548573 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2026-01-21 14:59:51.548579 | controller | }
2026-01-21 14:59:51.778218 | controller | ok: Runtime: 0:00:00.005364
2026-01-21 14:59:51.784157 | 
2026-01-21 14:59:51.784237 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2026-01-21 14:59:51.836061 | controller | skipping: Conditional result was False
2026-01-21 14:59:51.842004 | 
2026-01-21 14:59:51.842292 | TASK [Symlink /home/zuul-worker/workspace]
2026-01-21 14:59:52.668559 | controller | skipping: Conditional result was False
2026-01-21 14:59:52.674779 | 
2026-01-21 14:59:52.674865 | TASK [Ensure legacy workspace directory]
2026-01-21 14:59:52.998193 | controller | changed
2026-01-21 14:59:53.078865 | 
2026-01-21 14:59:53.078966 | PLAY RECAP
2026-01-21 14:59:53.079014 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-01-21 14:59:53.079038 | 
2026-01-21 14:59:53.515325 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-01-21 14:59:53.516492 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-01-21 14:59:55.995223 | 
2026-01-21 14:59:55.995383 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2026-01-21 14:59:56.142511 | 
2026-01-21 14:59:56.145692 | TASK [Create zuul-output directory]
2026-01-21 14:59:57.130872 | controller | changed
2026-01-21 14:59:57.138234 | 
2026-01-21 14:59:57.138344 | TASK [Slurp Zuul inventory test]
2026-01-21 14:59:58.450728 | controller -> localhost | ok
2026-01-21 14:59:58.457510 | 
2026-01-21 14:59:58.457577 | TASK [Save zuul inventory]
2026-01-21 15:00:00.463108 | controller | changed
2026-01-21 15:00:00.483715 | 
2026-01-21 15:00:00.483827 | TASK [Save zuul vars without the change_message]
2026-01-21 15:00:01.271626 | controller | changed
2026-01-21 15:00:01.348793 | 
2026-01-21 15:00:01.348901 | PLAY RECAP
2026-01-21 15:00:01.348948 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-01-21 15:00:01.348972 | 
2026-01-21 15:00:01.757505 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-01-21 15:00:01.758257 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-01-21 15:00:04.182947 | 
2026-01-21 15:00:04.183077 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2026-01-21 15:00:04.267709 | 
2026-01-21 15:00:04.267829 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2026-01-21 15:00:04.318930 | controller | ok
2026-01-21 15:00:04.376797 | 
2026-01-21 15:00:04.376917 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-01-21 15:00:04.475611 | controller | skipping: Conditional result was False
2026-01-21 15:00:04.482248 | 
2026-01-21 15:00:04.482387 | TASK [mirror-info-fork : Create /etc/ci]
2026-01-21 15:00:05.183638 | controller | ok
2026-01-21 15:00:05.190513 | 
2026-01-21 15:00:05.190586 | TASK [mirror-info-fork : Install ci_mirror script]
2026-01-21 15:00:06.347548 | controller | ok
2026-01-21 15:00:06.395674 | 
2026-01-21 15:00:06.395790 | TASK [Prepare workspace]
2026-01-21 15:00:06.471142 | controller | ok
2026-01-21 15:00:06.536658 | 
2026-01-21 15:00:06.536779 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-01-21 15:00:07.199363 | controller | ok
2026-01-21 15:00:07.208866 | 
2026-01-21 15:00:07.208944 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-01-21 15:00:11.594837 | controller | Output suppressed because no_log was given
2026-01-21 15:00:11.618635 | 
2026-01-21 15:00:11.618743 | LOOP [Create zuul-output directory]
2026-01-21 15:00:11.857905 | controller | changed: "/home/zuul/ci-framework-data/logs"
2026-01-21 15:00:12.043926 | controller | ok: "/home/zuul/zuul-output/logs"
2026-01-21 15:00:12.059166 | 
2026-01-21 15:00:12.059481 | TASK [Install required packages]
2026-01-21 15:00:47.330569 | controller | changed
2026-01-21 15:00:47.339361 | 
2026-01-21 15:00:47.339453 | TASK [Install venv]
2026-01-21 15:01:49.592033 | controller | changed
2026-01-21 15:01:49.621186 | 
2026-01-21 15:01:49.621290 | PLAY RECAP
2026-01-21 15:01:49.621338 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-01-21 15:01:49.621363 | 
2026-01-21 15:01:49.704390 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-01-21 15:01:49.705171 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-01-21 15:01:50.274768 | 
2026-01-21 15:01:50.274884 | PLAY [Run ci/playbooks/molecule-test.yml]
2026-01-21 15:01:50.296467 | 
2026-01-21 15:01:50.296586 | TASK [Gather required facts]
2026-01-21 15:01:50.782613 | controller | ok
2026-01-21 15:01:50.791326 | 
2026-01-21 15:01:50.791432 | TASK [Load environment var if instructed to]
2026-01-21 15:01:50.815381 | controller | skipping: Conditional result was False
2026-01-21 15:01:50.820751 | 
2026-01-21 15:01:50.820820 | TASK [Ensure group_vars dir exists]
2026-01-21 15:01:51.153614 | controller | ok
2026-01-21 15:01:51.160081 | 
2026-01-21 15:01:51.160195 | TASK [Print related variables]
2026-01-21 15:01:51.188420 | controller | ok:
2026-01-21 15:01:51.188538 | controller | mol_config_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config_local.yml
2026-01-21 15:01:51.188567 | controller | roles_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance
2026-01-21 15:01:51.193392 | 
2026-01-21 15:01:51.193457 | TASK [Run molecule]
2026-01-21 15:01:52.149958 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2026-01-21 15:01:52.220590 | controller | INFO     Performing prerun with role_name_check=0...
2026-01-21 15:02:10.217383 | 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).
2026-01-21 15:02:10.217848 | 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).
2026-01-21 15:02:10.218297 | 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).
2026-01-21 15:02:10.218732 | 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).
2026-01-21 15:02:10.219201 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+ad59be26 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 1.0.0+ad59be26 (/home/zuul/.ansible/collections/ansible_collections).
2026-01-21 15:02:10.219637 | 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).
2026-01-21 15:02:10.220106 | 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).
2026-01-21 15:02:10.220536 | 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).
2026-01-21 15:02:10.220992 | 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).
2026-01-21 15:02:10.221421 | 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).
2026-01-21 15:02:10.221898 | 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).
2026-01-21 15:02:10.222342 | 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).
2026-01-21 15:02:10.222784 | 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).
2026-01-21 15:02:10.223246 | 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).
2026-01-21 15:02:10.223695 | 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).
2026-01-21 15:02:10.233190 | controller | INFO     Running default > prepare
2026-01-21 15:02:10.233633 | controller | WARNING  Skipping, prepare playbook not configured.
2026-01-21 15:02:10.240983 | controller | INFO     Running default > converge
2026-01-21 15:02:10.903180 | controller |
2026-01-21 15:02:10.903240 | controller | PLAY [Converge test of controller tasks] ***************************************
2026-01-21 15:02:10.903325 | controller |
2026-01-21 15:02:10.903416 | controller | TASK [Gathering Facts] *********************************************************
2026-01-21 15:02:10.903520 | controller | Wednesday 21 January 2026  15:02:10 +0000 (0:00:00.010)       0:00:00.010 *****
2026-01-21 15:02:11.740216 | controller | ok: [instance]
2026-01-21 15:02:11.740323 | controller |
2026-01-21 15:02:11.740461 | controller | TASK [compliance : Ensure compliance folder exists] ****************************
2026-01-21 15:02:11.740585 | controller | Wednesday 21 January 2026  15:02:11 +0000 (0:00:00.837)       0:00:00.848 *****
2026-01-21 15:02:12.036065 | controller | changed: [instance]
2026-01-21 15:02:12.036113 | controller |
2026-01-21 15:02:12.036217 | controller | TASK [compliance : Install the compliance operator and plugin] *****************
2026-01-21 15:02:12.036319 | controller | Wednesday 21 January 2026  15:02:12 +0000 (0:00:00.295)       0:00:01.144 *****
2026-01-21 15:02:12.069337 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/install.yml for instance
2026-01-21 15:02:12.069418 | controller |
2026-01-21 15:02:12.069519 | controller | TASK [compliance : Create the compliance namespace] ****************************
2026-01-21 15:02:12.069623 | controller | Wednesday 21 January 2026  15:02:12 +0000 (0:00:00.033)       0:00:01.177 *****
2026-01-21 15:02:12.094807 | controller | skipping: [instance]
2026-01-21 15:02:12.094895 | controller |
2026-01-21 15:02:12.095010 | controller | TASK [compliance : Ensure OperatorGroup for the compliance-operator is present] ***
2026-01-21 15:02:12.095115 | controller | Wednesday 21 January 2026  15:02:12 +0000 (0:00:00.025)       0:00:01.203 *****
2026-01-21 15:02:12.120143 | controller | skipping: [instance]
2026-01-21 15:02:12.120238 | controller |
2026-01-21 15:02:12.120365 | controller | TASK [compliance : Ensure Subscription for the compliance-operator is present] ***
2026-01-21 15:02:12.120485 | controller | Wednesday 21 January 2026  15:02:12 +0000 (0:00:00.025)       0:00:01.228 *****
2026-01-21 15:02:12.148142 | controller | skipping: [instance]
2026-01-21 15:02:12.148202 | controller |
2026-01-21 15:02:12.148302 | controller | TASK [compliance : Wait until the compliance-operator csv is present] **********
2026-01-21 15:02:12.148401 | controller | Wednesday 21 January 2026  15:02:12 +0000 (0:00:00.027)       0:00:01.256 *****
2026-01-21 15:02:12.173950 | controller | skipping: [instance]
2026-01-21 15:02:12.174041 | controller |
2026-01-21 15:02:12.174159 | controller | TASK [compliance : Get full name of the compliance-operator csv] ***************
2026-01-21 15:02:12.174294 | controller | Wednesday 21 January 2026  15:02:12 +0000 (0:00:00.025)       0:00:01.282 *****
2026-01-21 15:02:12.199008 | controller | skipping: [instance]
2026-01-21 15:02:12.199093 | controller |
2026-01-21 15:02:12.199224 | controller | TASK [compliance : Wait for the compliance-operator csv to Succeed] ************
2026-01-21 15:02:12.199347 | controller | Wednesday 21 January 2026  15:02:12 +0000 (0:00:00.025)       0:00:01.307 *****
2026-01-21 15:02:12.226476 | controller | skipping: [instance]
2026-01-21 15:02:12.226549 | controller |
2026-01-21 15:02:12.226648 | controller | TASK [podman : Ensure podman is installed] *************************************
2026-01-21 15:02:12.226770 | controller | Wednesday 21 January 2026  15:02:12 +0000 (0:00:00.027)       0:00:01.335 *****
2026-01-21 15:02:13.009601 | controller | ok: [instance]
2026-01-21 15:02:13.009931 | controller |
2026-01-21 15:02:13.010054 | controller | TASK [podman : Enable loginctl linger for ansible_user_id] *********************
2026-01-21 15:02:13.010166 | controller | Wednesday 21 January 2026  15:02:13 +0000 (0:00:00.782)       0:00:02.117 *****
2026-01-21 15:02:13.435951 | controller | changed: [instance]
2026-01-21 15:02:13.436022 | controller |
2026-01-21 15:02:13.436127 | controller | TASK [podman : Ensure subordinate UID entry exists for zuul] *******************
2026-01-21 15:02:13.436227 | controller | Wednesday 21 January 2026  15:02:13 +0000 (0:00:00.426)       0:00:02.544 *****
2026-01-21 15:02:13.459216 | controller | skipping: [instance]
2026-01-21 15:02:13.459313 | controller |
2026-01-21 15:02:13.459436 | controller | TASK [podman : Ensure subordinate GID entry exists for zuul] *******************
2026-01-21 15:02:13.459555 | controller | Wednesday 21 January 2026  15:02:13 +0000 (0:00:00.023)       0:00:02.567 *****
2026-01-21 15:02:13.479280 | controller | skipping: [instance]
2026-01-21 15:02:13.479362 | controller |
2026-01-21 15:02:13.479467 | controller | TASK [podman : Run podman system migrate if subuid/subgid files were changed] ***
2026-01-21 15:02:13.479567 | controller | Wednesday 21 January 2026  15:02:13 +0000 (0:00:00.020)       0:00:02.587 *****
2026-01-21 15:02:13.503362 | controller | skipping: [instance]
2026-01-21 15:02:13.503448 | controller |
2026-01-21 15:02:13.503564 | controller | TASK [compliance : Log into registry] ******************************************
2026-01-21 15:02:13.503697 | controller | Wednesday 21 January 2026  15:02:13 +0000 (0:00:00.024)       0:00:02.611 *****
2026-01-21 15:02:13.520582 | controller | skipping: [instance]
2026-01-21 15:02:13.520661 | controller |
2026-01-21 15:02:13.520782 | controller | TASK [compliance : Copy out the compliance plugin from the oc-compliance image] ***
2026-01-21 15:02:13.520909 | controller | Wednesday 21 January 2026  15:02:13 +0000 (0:00:00.017)       0:00:02.629 *****
2026-01-21 15:02:13.537214 | controller | skipping: [instance]
2026-01-21 15:02:13.537317 | controller |
2026-01-21 15:02:13.537429 | controller | TASK [compliance : Install packages to process results] ************************
2026-01-21 15:02:13.537548 | controller | Wednesday 21 January 2026  15:02:13 +0000 (0:00:00.016)       0:00:02.645 *****
2026-01-21 15:02:17.212885 | controller | changed: [instance]
2026-01-21 15:02:17.212968 | controller |
2026-01-21 15:02:17.213079 | controller | TASK [compliance : Run compliance scans and extract results] *******************
2026-01-21 15:02:17.213190 | controller | Wednesday 21 January 2026  15:02:17 +0000 (0:00:03.675)       0:00:06.321 *****
2026-01-21 15:02:17.254499 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=cis)
2026-01-21 15:02:17.254624 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=e8)
2026-01-21 15:02:17.254781 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=high)
2026-01-21 15:02:17.254999 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=moderate)
2026-01-21 15:02:17.255122 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=nerc-cip)
2026-01-21 15:02:17.255230 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=pci-dss)
2026-01-21 15:02:17.255334 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=stig)
2026-01-21 15:02:17.255427 | controller |
2026-01-21 15:02:17.255528 | controller | TASK [compliance : Log start of scans] *****************************************
2026-01-21 15:02:17.255630 | controller | Wednesday 21 January 2026  15:02:17 +0000 (0:00:00.041)       0:00:06.362 *****
2026-01-21 15:02:17.271664 | controller | ok: [instance] =>
2026-01-21 15:02:17.271800 | controller |   msg: Starting scans for cis
2026-01-21 15:02:17.271947 | controller |
2026-01-21 15:02:17.272071 | controller | TASK [compliance : Run scans and extract results] ******************************
2026-01-21 15:02:17.272191 | controller | Wednesday 21 January 2026  15:02:17 +0000 (0:00:00.017)       0:00:06.380 *****
2026-01-21 15:02:17.297025 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-cis)
2026-01-21 15:02:17.297137 | controller |
2026-01-21 15:02:17.297263 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:17.297380 | controller | Wednesday 21 January 2026  15:02:17 +0000 (0:00:00.025)       0:00:06.405 *****
2026-01-21 15:02:17.317481 | controller | ok: [instance]
2026-01-21 15:02:17.317577 | controller |
2026-01-21 15:02:17.317716 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:17.317863 | controller | Wednesday 21 January 2026  15:02:17 +0000 (0:00:00.020)       0:00:06.425 *****
2026-01-21 15:02:17.332410 | controller | skipping: [instance]
2026-01-21 15:02:17.332515 | controller |
2026-01-21 15:02:17.332642 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:17.332794 | controller | Wednesday 21 January 2026  15:02:17 +0000 (0:00:00.015)       0:00:06.441 *****
2026-01-21 15:02:17.347088 | controller | skipping: [instance]
2026-01-21 15:02:17.347174 | controller |
2026-01-21 15:02:17.347278 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:17.347379 | controller | Wednesday 21 January 2026  15:02:17 +0000 (0:00:00.014)       0:00:06.455 *****
2026-01-21 15:02:17.515696 | controller | ok: [instance]
2026-01-21 15:02:17.515770 | controller |
2026-01-21 15:02:17.515907 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:17.516014 | controller | Wednesday 21 January 2026  15:02:17 +0000 (0:00:00.168)       0:00:06.624 *****
2026-01-21 15:02:17.694640 | controller | changed: [instance]
2026-01-21 15:02:17.694713 | controller |
2026-01-21 15:02:17.694824 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:17.694949 | controller | Wednesday 21 January 2026  15:02:17 +0000 (0:00:00.178)       0:00:06.803 *****
2026-01-21 15:02:17.711288 | controller | skipping: [instance]
2026-01-21 15:02:17.711380 | controller |
2026-01-21 15:02:17.711488 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:17.711590 | controller | Wednesday 21 January 2026  15:02:17 +0000 (0:00:00.016)       0:00:06.819 *****
2026-01-21 15:02:17.984124 | controller | ok: [instance]
2026-01-21 15:02:17.984192 | controller |
2026-01-21 15:02:17.984296 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:17.984395 | controller | Wednesday 21 January 2026  15:02:17 +0000 (0:00:00.272)       0:00:07.092 *****
2026-01-21 15:02:17.997720 | controller | skipping: [instance]
2026-01-21 15:02:17.997844 | controller |
2026-01-21 15:02:17.997978 | controller | TASK [compliance : Log start of scans] *****************************************
2026-01-21 15:02:17.998097 | controller | Wednesday 21 January 2026  15:02:17 +0000 (0:00:00.013)       0:00:07.106 *****
2026-01-21 15:02:18.014596 | controller | ok: [instance] =>
2026-01-21 15:02:18.014685 | controller |   msg: Starting scans for e8
2026-01-21 15:02:18.014794 | controller |
2026-01-21 15:02:18.014919 | controller | TASK [compliance : Run scans and extract results] ******************************
2026-01-21 15:02:18.015016 | controller | Wednesday 21 January 2026  15:02:18 +0000 (0:00:00.016)       0:00:07.123 *****
2026-01-21 15:02:18.045101 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-e8)
2026-01-21 15:02:18.045235 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-e8)
2026-01-21 15:02:18.045350 | controller |
2026-01-21 15:02:18.045471 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:18.045588 | controller | Wednesday 21 January 2026  15:02:18 +0000 (0:00:00.030)       0:00:07.153 *****
2026-01-21 15:02:18.065662 | controller | ok: [instance]
2026-01-21 15:02:18.065762 | controller |
2026-01-21 15:02:18.065906 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:18.066010 | controller | Wednesday 21 January 2026  15:02:18 +0000 (0:00:00.020)       0:00:07.174 *****
2026-01-21 15:02:18.081586 | controller | skipping: [instance]
2026-01-21 15:02:18.081701 | controller |
2026-01-21 15:02:18.081819 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:18.081940 | controller | Wednesday 21 January 2026  15:02:18 +0000 (0:00:00.015)       0:00:07.190 *****
2026-01-21 15:02:18.096797 | controller | skipping: [instance]
2026-01-21 15:02:18.096898 | controller |
2026-01-21 15:02:18.097000 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:18.097098 | controller | Wednesday 21 January 2026  15:02:18 +0000 (0:00:00.015)       0:00:07.205 *****
2026-01-21 15:02:18.270853 | controller | ok: [instance]
2026-01-21 15:02:18.271164 | controller |
2026-01-21 15:02:18.452357 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:18.452387 | controller | Wednesday 21 January 2026  15:02:18 +0000 (0:00:00.173)       0:00:07.379 *****
2026-01-21 15:02:18.452399 | controller | changed: [instance]
2026-01-21 15:02:18.468601 | controller |
2026-01-21 15:02:18.468626 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:18.468634 | controller | Wednesday 21 January 2026  15:02:18 +0000 (0:00:00.181)       0:00:07.560 *****
2026-01-21 15:02:18.468644 | controller | skipping: [instance]
2026-01-21 15:02:18.645222 | controller |
2026-01-21 15:02:18.645252 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:18.645260 | controller | Wednesday 21 January 2026  15:02:18 +0000 (0:00:00.016)       0:00:07.576 *****
2026-01-21 15:02:18.645271 | controller | ok: [instance]
2026-01-21 15:02:18.659538 | controller |
2026-01-21 15:02:18.659563 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:18.659570 | controller | Wednesday 21 January 2026  15:02:18 +0000 (0:00:00.176)       0:00:07.753 *****
2026-01-21 15:02:18.659581 | controller | skipping: [instance]
2026-01-21 15:02:18.680897 | controller |
2026-01-21 15:02:18.680922 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:18.680930 | controller | Wednesday 21 January 2026  15:02:18 +0000 (0:00:00.014)       0:00:07.767 *****
2026-01-21 15:02:18.680940 | controller | ok: [instance]
2026-01-21 15:02:18.681010 | controller |
2026-01-21 15:02:18.681026 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:18.681036 | controller | Wednesday 21 January 2026  15:02:18 +0000 (0:00:00.021)       0:00:07.789 *****
2026-01-21 15:02:18.697458 | controller | skipping: [instance]
2026-01-21 15:02:18.713938 | controller |
2026-01-21 15:02:18.713975 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:18.713985 | controller | Wednesday 21 January 2026  15:02:18 +0000 (0:00:00.016)       0:00:07.805 *****
2026-01-21 15:02:18.713998 | controller | skipping: [instance]
2026-01-21 15:02:18.714006 | controller |
2026-01-21 15:02:18.714013 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:18.714023 | controller | Wednesday 21 January 2026  15:02:18 +0000 (0:00:00.016)       0:00:07.822 *****
2026-01-21 15:02:18.890410 | controller | ok: [instance]
2026-01-21 15:02:19.085371 | controller |
2026-01-21 15:02:19.085412 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:19.085420 | controller | Wednesday 21 January 2026  15:02:18 +0000 (0:00:00.176)       0:00:07.998 *****
2026-01-21 15:02:19.085430 | controller | changed: [instance]
2026-01-21 15:02:19.104797 | controller |
2026-01-21 15:02:19.104819 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:19.104844 | controller | Wednesday 21 January 2026  15:02:19 +0000 (0:00:00.194)       0:00:08.193 *****
2026-01-21 15:02:19.104857 | controller | skipping: [instance]
2026-01-21 15:02:19.280590 | controller |
2026-01-21 15:02:19.280620 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:19.280628 | controller | Wednesday 21 January 2026  15:02:19 +0000 (0:00:00.019)       0:00:08.212 *****
2026-01-21 15:02:19.280639 | controller | ok: [instance]
2026-01-21 15:02:19.295301 | controller |
2026-01-21 15:02:19.295327 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:19.295334 | controller | Wednesday 21 January 2026  15:02:19 +0000 (0:00:00.175)       0:00:08.388 *****
2026-01-21 15:02:19.295345 | controller | skipping: [instance]
2026-01-21 15:02:19.314384 | controller |
2026-01-21 15:02:19.314406 | controller | TASK [compliance : Log start of scans] *****************************************
2026-01-21 15:02:19.314413 | controller | Wednesday 21 January 2026  15:02:19 +0000 (0:00:00.014)       0:00:08.403 *****
2026-01-21 15:02:19.314423 | controller | ok: [instance] =>
2026-01-21 15:02:19.352656 | controller |   msg: Starting scans for high
2026-01-21 15:02:19.352709 | controller |
2026-01-21 15:02:19.352719 | controller | TASK [compliance : Run scans and extract results] ******************************
2026-01-21 15:02:19.352726 | controller | Wednesday 21 January 2026  15:02:19 +0000 (0:00:00.018)       0:00:08.422 *****
2026-01-21 15:02:19.352736 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-high)
2026-01-21 15:02:19.374898 | 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)
2026-01-21 15:02:19.374935 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-high)
2026-01-21 15:02:19.374943 | controller |
2026-01-21 15:02:19.374949 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:19.374955 | controller | Wednesday 21 January 2026  15:02:19 +0000 (0:00:00.037)       0:00:08.460 *****
2026-01-21 15:02:19.374964 | controller | ok: [instance]
2026-01-21 15:02:19.391514 | controller |
2026-01-21 15:02:19.391545 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:19.391553 | controller | Wednesday 21 January 2026  15:02:19 +0000 (0:00:00.022)       0:00:08.482 *****
2026-01-21 15:02:19.391563 | controller | skipping: [instance]
2026-01-21 15:02:19.391724 | controller |
2026-01-21 15:02:19.391898 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:19.392046 | controller | Wednesday 21 January 2026  15:02:19 +0000 (0:00:00.017)       0:00:08.500 *****
2026-01-21 15:02:19.408599 | controller | skipping: [instance]
2026-01-21 15:02:19.408856 | controller |
2026-01-21 15:02:19.409065 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:19.409241 | controller | Wednesday 21 January 2026  15:02:19 +0000 (0:00:00.016)       0:00:08.517 *****
2026-01-21 15:02:19.590894 | controller | ok: [instance]
2026-01-21 15:02:19.777369 | controller |
2026-01-21 15:02:19.777400 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:19.777408 | controller | Wednesday 21 January 2026  15:02:19 +0000 (0:00:00.181)       0:00:08.698 *****
2026-01-21 15:02:19.777418 | controller | changed: [instance]
2026-01-21 15:02:19.794866 | controller |
2026-01-21 15:02:19.794896 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:19.794903 | controller | Wednesday 21 January 2026  15:02:19 +0000 (0:00:00.186)       0:00:08.885 *****
2026-01-21 15:02:19.794913 | controller | skipping: [instance]
2026-01-21 15:02:19.966574 | controller |
2026-01-21 15:02:19.966605 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:19.966613 | controller | Wednesday 21 January 2026  15:02:19 +0000 (0:00:00.017)       0:00:08.902 *****
2026-01-21 15:02:19.966623 | controller | ok: [instance]
2026-01-21 15:02:19.980913 | controller |
2026-01-21 15:02:19.980948 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:19.980956 | controller | Wednesday 21 January 2026  15:02:19 +0000 (0:00:00.171)       0:00:09.074 *****
2026-01-21 15:02:19.980966 | controller | skipping: [instance]
2026-01-21 15:02:20.003427 | controller |
2026-01-21 15:02:20.003452 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:20.003460 | controller | Wednesday 21 January 2026  15:02:19 +0000 (0:00:00.014)       0:00:09.089 *****
2026-01-21 15:02:20.003470 | controller | ok: [instance]
2026-01-21 15:02:20.020448 | controller |
2026-01-21 15:02:20.020472 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:20.020480 | controller | Wednesday 21 January 2026  15:02:20 +0000 (0:00:00.022)       0:00:09.111 *****
2026-01-21 15:02:20.020490 | controller | skipping: [instance]
2026-01-21 15:02:20.036893 | controller |
2026-01-21 15:02:20.036915 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:20.036924 | controller | Wednesday 21 January 2026  15:02:20 +0000 (0:00:00.016)       0:00:09.128 *****
2026-01-21 15:02:20.036933 | controller | skipping: [instance]
2026-01-21 15:02:20.036965 | controller |
2026-01-21 15:02:20.037247 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:20.219658 | controller | Wednesday 21 January 2026  15:02:20 +0000 (0:00:00.016)       0:00:09.145 *****
2026-01-21 15:02:20.219691 | controller | ok: [instance]
2026-01-21 15:02:20.401903 | controller |
2026-01-21 15:02:20.401933 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:20.401941 | controller | Wednesday 21 January 2026  15:02:20 +0000 (0:00:00.182)       0:00:09.327 *****
2026-01-21 15:02:20.401952 | controller | changed: [instance]
2026-01-21 15:02:20.401975 | controller |
2026-01-21 15:02:20.402127 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:20.417217 | controller | Wednesday 21 January 2026  15:02:20 +0000 (0:00:00.182)       0:00:09.510 *****
2026-01-21 15:02:20.417237 | controller | skipping: [instance]
2026-01-21 15:02:20.586914 | controller |
2026-01-21 15:02:20.586943 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:20.586951 | controller | Wednesday 21 January 2026  15:02:20 +0000 (0:00:00.015)       0:00:09.525 *****
2026-01-21 15:02:20.586961 | controller | ok: [instance]
2026-01-21 15:02:20.600246 | controller |
2026-01-21 15:02:20.600273 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:20.600281 | controller | Wednesday 21 January 2026  15:02:20 +0000 (0:00:00.169)       0:00:09.695 *****
2026-01-21 15:02:20.600291 | controller | skipping: [instance]
2026-01-21 15:02:20.620765 | controller |
2026-01-21 15:02:20.620791 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:20.620798 | controller | Wednesday 21 January 2026  15:02:20 +0000 (0:00:00.013)       0:00:09.708 *****
2026-01-21 15:02:20.620808 | controller | ok: [instance]
2026-01-21 15:02:20.635557 | controller |
2026-01-21 15:02:20.635581 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:20.635589 | controller | Wednesday 21 January 2026  15:02:20 +0000 (0:00:00.020)       0:00:09.729 *****
2026-01-21 15:02:20.635606 | controller | skipping: [instance]
2026-01-21 15:02:20.650499 | controller |
2026-01-21 15:02:20.650523 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:20.650534 | controller | Wednesday 21 January 2026  15:02:20 +0000 (0:00:00.014)       0:00:09.743 *****
2026-01-21 15:02:20.650544 | controller | skipping: [instance]
2026-01-21 15:02:20.818914 | controller |
2026-01-21 15:02:20.818943 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:20.818950 | controller | Wednesday 21 January 2026  15:02:20 +0000 (0:00:00.014)       0:00:09.758 *****
2026-01-21 15:02:20.818960 | controller | ok: [instance]
2026-01-21 15:02:20.819118 | controller |
2026-01-21 15:02:20.819138 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:20.998917 | controller | Wednesday 21 January 2026  15:02:20 +0000 (0:00:00.168)       0:00:09.927 *****
2026-01-21 15:02:20.998949 | controller | changed: [instance]
2026-01-21 15:02:20.998973 | controller |
2026-01-21 15:02:20.998982 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:20.999091 | controller | Wednesday 21 January 2026  15:02:20 +0000 (0:00:00.179)       0:00:10.107 *****
2026-01-21 15:02:21.013915 | controller | skipping: [instance]
2026-01-21 15:02:21.014117 | controller |
2026-01-21 15:02:21.014135 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:21.179415 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.015)       0:00:10.122 *****
2026-01-21 15:02:21.179449 | controller | ok: [instance]
2026-01-21 15:02:21.193120 | controller |
2026-01-21 15:02:21.193147 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:21.193155 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.165)       0:00:10.287 *****
2026-01-21 15:02:21.193165 | controller | skipping: [instance]
2026-01-21 15:02:21.210611 | controller |
2026-01-21 15:02:21.210638 | controller | TASK [compliance : Log start of scans] *****************************************
2026-01-21 15:02:21.210646 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.013)       0:00:10.301 *****
2026-01-21 15:02:21.210662 | controller | ok: [instance] =>
2026-01-21 15:02:21.246610 | controller |   msg: Starting scans for moderate
2026-01-21 15:02:21.246642 | controller |
2026-01-21 15:02:21.246652 | controller | TASK [compliance : Run scans and extract results] ******************************
2026-01-21 15:02:21.246660 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.017)       0:00:10.318 *****
2026-01-21 15:02:21.246671 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-moderate)
2026-01-21 15:02:21.267511 | 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)
2026-01-21 15:02:21.267538 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-moderate)
2026-01-21 15:02:21.267545 | controller |
2026-01-21 15:02:21.267552 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:21.267558 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.035)       0:00:10.354 *****
2026-01-21 15:02:21.267567 | controller | ok: [instance]
2026-01-21 15:02:21.282680 | controller |
2026-01-21 15:02:21.282722 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:21.282732 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.021)       0:00:10.375 *****
2026-01-21 15:02:21.282743 | controller | skipping: [instance]
2026-01-21 15:02:21.297885 | controller |
2026-01-21 15:02:21.297906 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:21.297914 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.015)       0:00:10.390 *****
2026-01-21 15:02:21.297924 | controller | skipping: [instance]
2026-01-21 15:02:21.297980 | controller |
2026-01-21 15:02:21.297996 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:21.298006 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.015)       0:00:10.406 *****
2026-01-21 15:02:21.469544 | controller | ok: [instance]
2026-01-21 15:02:21.646502 | controller |
2026-01-21 15:02:21.646531 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:21.646539 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.171)       0:00:10.577 *****
2026-01-21 15:02:21.646550 | controller | changed: [instance]
2026-01-21 15:02:21.661504 | controller |
2026-01-21 15:02:21.661528 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:21.661537 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.176)       0:00:10.754 *****
2026-01-21 15:02:21.661546 | controller | skipping: [instance]
2026-01-21 15:02:21.827061 | controller |
2026-01-21 15:02:21.827090 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:21.827098 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.015)       0:00:10.769 *****
2026-01-21 15:02:21.827107 | controller | ok: [instance]
2026-01-21 15:02:21.840480 | controller |
2026-01-21 15:02:21.840504 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:21.840512 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.165)       0:00:10.935 *****
2026-01-21 15:02:21.840526 | controller | skipping: [instance]
2026-01-21 15:02:21.861291 | controller |
2026-01-21 15:02:21.861313 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:21.861321 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.013)       0:00:10.948 *****
2026-01-21 15:02:21.861330 | controller | ok: [instance]
2026-01-21 15:02:21.876601 | controller |
2026-01-21 15:02:21.876623 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:21.876630 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.020)       0:00:10.969 *****
2026-01-21 15:02:21.876640 | controller | skipping: [instance]
2026-01-21 15:02:21.891876 | controller |
2026-01-21 15:02:21.891898 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:21.891906 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.015)       0:00:10.984 *****
2026-01-21 15:02:21.891922 | controller | skipping: [instance]
2026-01-21 15:02:21.891982 | controller |
2026-01-21 15:02:21.891992 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:21.892101 | controller | Wednesday 21 January 2026  15:02:21 +0000 (0:00:00.015)       0:00:11.000 *****
2026-01-21 15:02:22.061896 | controller | ok: [instance]
2026-01-21 15:02:22.238890 | controller |
2026-01-21 15:02:22.238917 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:22.238925 | controller | Wednesday 21 January 2026  15:02:22 +0000 (0:00:00.169)       0:00:11.170 *****
2026-01-21 15:02:22.238935 | controller | changed: [instance]
2026-01-21 15:02:22.238957 | controller |
2026-01-21 15:02:22.238965 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:22.239058 | controller | Wednesday 21 January 2026  15:02:22 +0000 (0:00:00.177)       0:00:11.347 *****
2026-01-21 15:02:22.253460 | controller | skipping: [instance]
2026-01-21 15:02:22.416562 | controller |
2026-01-21 15:02:22.416591 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:22.416599 | controller | Wednesday 21 January 2026  15:02:22 +0000 (0:00:00.014)       0:00:11.361 *****
2026-01-21 15:02:22.416609 | controller | ok: [instance]
2026-01-21 15:02:22.430745 | controller |
2026-01-21 15:02:22.430769 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:22.430778 | controller | Wednesday 21 January 2026  15:02:22 +0000 (0:00:00.162)       0:00:11.524 *****
2026-01-21 15:02:22.430789 | controller | skipping: [instance]
2026-01-21 15:02:22.450902 | controller |
2026-01-21 15:02:22.450927 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:22.450936 | controller | Wednesday 21 January 2026  15:02:22 +0000 (0:00:00.014)       0:00:11.539 *****
2026-01-21 15:02:22.450948 | controller | ok: [instance]
2026-01-21 15:02:22.465367 | controller |
2026-01-21 15:02:22.465385 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:22.465393 | controller | Wednesday 21 January 2026  15:02:22 +0000 (0:00:00.020)       0:00:11.559 *****
2026-01-21 15:02:22.465402 | controller | skipping: [instance]
2026-01-21 15:02:22.479869 | controller |
2026-01-21 15:02:22.479888 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:22.479896 | controller | Wednesday 21 January 2026  15:02:22 +0000 (0:00:00.014)       0:00:11.573 *****
2026-01-21 15:02:22.479905 | controller | skipping: [instance]
2026-01-21 15:02:22.480178 | controller |
2026-01-21 15:02:22.648911 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:22.648939 | controller | Wednesday 21 January 2026  15:02:22 +0000 (0:00:00.014)       0:00:11.588 *****
2026-01-21 15:02:22.648951 | controller | ok: [instance]
2026-01-21 15:02:22.828444 | controller |
2026-01-21 15:02:22.828474 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:22.828482 | controller | Wednesday 21 January 2026  15:02:22 +0000 (0:00:00.168)       0:00:11.757 *****
2026-01-21 15:02:22.828492 | controller | changed: [instance]
2026-01-21 15:02:22.843926 | controller |
2026-01-21 15:02:22.843950 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:22.843958 | controller | Wednesday 21 January 2026  15:02:22 +0000 (0:00:00.179)       0:00:11.936 *****
2026-01-21 15:02:22.843967 | controller | skipping: [instance]
2026-01-21 15:02:23.009632 | controller |
2026-01-21 15:02:23.009661 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:23.009669 | controller | Wednesday 21 January 2026  15:02:22 +0000 (0:00:00.015)       0:00:11.952 *****
2026-01-21 15:02:23.009679 | controller | ok: [instance]
2026-01-21 15:02:23.022932 | controller |
2026-01-21 15:02:23.022957 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:23.022973 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.165)       0:00:12.117 *****
2026-01-21 15:02:23.022985 | controller | skipping: [instance]
2026-01-21 15:02:23.039366 | controller |
2026-01-21 15:02:23.039386 | controller | TASK [compliance : Log start of scans] *****************************************
2026-01-21 15:02:23.039399 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.013)       0:00:12.131 *****
2026-01-21 15:02:23.039408 | controller | ok: [instance] =>
2026-01-21 15:02:23.069925 | controller |   msg: Starting scans for nerc-cip
2026-01-21 15:02:23.069954 | controller |
2026-01-21 15:02:23.069964 | controller | TASK [compliance : Run scans and extract results] ******************************
2026-01-21 15:02:23.069972 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.016)       0:00:12.147 *****
2026-01-21 15:02:23.069983 | 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)
2026-01-21 15:02:23.070013 | 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)
2026-01-21 15:02:23.070038 | controller |
2026-01-21 15:02:23.070243 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:23.091502 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.030)       0:00:12.178 *****
2026-01-21 15:02:23.091534 | controller | ok: [instance]
2026-01-21 15:02:23.106504 | controller |
2026-01-21 15:02:23.106527 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:23.106534 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.021)       0:00:12.199 *****
2026-01-21 15:02:23.106544 | controller | skipping: [instance]
2026-01-21 15:02:23.121890 | controller |
2026-01-21 15:02:23.121916 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:23.121924 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.015)       0:00:12.214 *****
2026-01-21 15:02:23.121933 | controller | skipping: [instance]
2026-01-21 15:02:23.122015 | controller |
2026-01-21 15:02:23.122025 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:23.122033 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.015)       0:00:12.230 *****
2026-01-21 15:02:23.294978 | controller | ok: [instance]
2026-01-21 15:02:23.475894 | controller |
2026-01-21 15:02:23.475924 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:23.475932 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.172)       0:00:12.403 *****
2026-01-21 15:02:23.475942 | controller | changed: [instance]
2026-01-21 15:02:23.476112 | controller |
2026-01-21 15:02:23.476126 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:23.491172 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.181)       0:00:12.584 *****
2026-01-21 15:02:23.491191 | controller | skipping: [instance]
2026-01-21 15:02:23.657579 | controller |
2026-01-21 15:02:23.657607 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:23.657615 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.015)       0:00:12.599 *****
2026-01-21 15:02:23.657625 | controller | ok: [instance]
2026-01-21 15:02:23.671056 | controller |
2026-01-21 15:02:23.671089 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:23.671098 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.166)       0:00:12.765 *****
2026-01-21 15:02:23.671110 | controller | skipping: [instance]
2026-01-21 15:02:23.691899 | controller |
2026-01-21 15:02:23.691928 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:23.691936 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.013)       0:00:12.779 *****
2026-01-21 15:02:23.691946 | controller | ok: [instance]
2026-01-21 15:02:23.707309 | controller |
2026-01-21 15:02:23.707335 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:23.707343 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.020)       0:00:12.800 *****
2026-01-21 15:02:23.707353 | controller | skipping: [instance]
2026-01-21 15:02:23.722924 | controller |
2026-01-21 15:02:23.722952 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:23.722960 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.015)       0:00:12.815 *****
2026-01-21 15:02:23.722969 | controller | skipping: [instance]
2026-01-21 15:02:23.898551 | controller |
2026-01-21 15:02:23.898581 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:23.898589 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.015)       0:00:12.831 *****
2026-01-21 15:02:23.898599 | controller | ok: [instance]
2026-01-21 15:02:24.084275 | controller |
2026-01-21 15:02:24.084306 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:24.084314 | controller | Wednesday 21 January 2026  15:02:23 +0000 (0:00:00.175)       0:00:13.006 *****
2026-01-21 15:02:24.084329 | controller | changed: [instance]
2026-01-21 15:02:24.100561 | controller |
2026-01-21 15:02:24.100583 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:24.100590 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.185)       0:00:13.192 *****
2026-01-21 15:02:24.100600 | controller | skipping: [instance]
2026-01-21 15:02:24.273944 | controller |
2026-01-21 15:02:24.273975 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:24.273984 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.016)       0:00:13.208 *****
2026-01-21 15:02:24.273994 | controller | ok: [instance]
2026-01-21 15:02:24.287926 | controller |
2026-01-21 15:02:24.287961 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:24.287972 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.173)       0:00:13.381 *****
2026-01-21 15:02:24.287984 | controller | skipping: [instance]
2026-01-21 15:02:24.288012 | controller |
2026-01-21 15:02:24.288029 | controller | TASK [compliance : Log start of scans] *****************************************
2026-01-21 15:02:24.288096 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.014)       0:00:13.396 *****
2026-01-21 15:02:24.306548 | controller | ok: [instance] =>
2026-01-21 15:02:24.338452 | controller |   msg: Starting scans for pci-dss
2026-01-21 15:02:24.338480 | controller |
2026-01-21 15:02:24.338490 | controller | TASK [compliance : Run scans and extract results] ******************************
2026-01-21 15:02:24.338498 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.018)       0:00:13.414 *****
2026-01-21 15:02:24.338510 | 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)
2026-01-21 15:02:24.360331 | 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)
2026-01-21 15:02:24.360351 | controller |
2026-01-21 15:02:24.360358 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:24.360364 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.031)       0:00:13.446 *****
2026-01-21 15:02:24.360373 | controller | ok: [instance]
2026-01-21 15:02:24.376926 | controller |
2026-01-21 15:02:24.376960 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:24.376968 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.022)       0:00:13.468 *****
2026-01-21 15:02:24.376985 | controller | skipping: [instance]
2026-01-21 15:02:24.393869 | controller |
2026-01-21 15:02:24.393892 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:24.393900 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.016)       0:00:13.485 *****
2026-01-21 15:02:24.393909 | controller | skipping: [instance]
2026-01-21 15:02:24.567506 | controller |
2026-01-21 15:02:24.567536 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:24.567544 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.016)       0:00:13.502 *****
2026-01-21 15:02:24.567554 | controller | ok: [instance]
2026-01-21 15:02:24.748871 | controller |
2026-01-21 15:02:24.748910 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:24.748919 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.173)       0:00:13.675 *****
2026-01-21 15:02:24.748929 | controller | changed: [instance]
2026-01-21 15:02:24.765528 | controller |
2026-01-21 15:02:24.765554 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:24.765569 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.181)       0:00:13.856 *****
2026-01-21 15:02:24.765579 | controller | skipping: [instance]
2026-01-21 15:02:24.937057 | controller |
2026-01-21 15:02:24.937086 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:24.937094 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.016)       0:00:13.873 *****
2026-01-21 15:02:24.937104 | controller | ok: [instance]
2026-01-21 15:02:24.950314 | controller |
2026-01-21 15:02:24.950337 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:24.950345 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.171)       0:00:14.045 *****
2026-01-21 15:02:24.950355 | controller | skipping: [instance]
2026-01-21 15:02:24.970936 | controller |
2026-01-21 15:02:24.970969 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:24.970977 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.013)       0:00:14.058 *****
2026-01-21 15:02:24.970987 | controller | ok: [instance]
2026-01-21 15:02:24.971063 | controller |
2026-01-21 15:02:24.971089 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:24.971100 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.020)       0:00:14.079 *****
2026-01-21 15:02:24.986480 | controller | skipping: [instance]
2026-01-21 15:02:25.001914 | controller |
2026-01-21 15:02:25.001939 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:25.001955 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.015)       0:00:14.094 *****
2026-01-21 15:02:25.001967 | controller | skipping: [instance]
2026-01-21 15:02:25.172900 | controller |
2026-01-21 15:02:25.172946 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:25.172954 | controller | Wednesday 21 January 2026  15:02:24 +0000 (0:00:00.015)       0:00:14.110 *****
2026-01-21 15:02:25.172966 | controller | ok: [instance]
2026-01-21 15:02:25.173107 | controller |
2026-01-21 15:02:25.173139 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:25.355417 | controller | Wednesday 21 January 2026  15:02:25 +0000 (0:00:00.170)       0:00:14.281 *****
2026-01-21 15:02:25.355449 | controller | changed: [instance]
2026-01-21 15:02:25.370571 | controller |
2026-01-21 15:02:25.370594 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:25.370602 | controller | Wednesday 21 January 2026  15:02:25 +0000 (0:00:00.182)       0:00:14.463 *****
2026-01-21 15:02:25.370612 | controller | skipping: [instance]
2026-01-21 15:02:25.540512 | controller |
2026-01-21 15:02:25.540541 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:25.540550 | controller | Wednesday 21 January 2026  15:02:25 +0000 (0:00:00.015)       0:00:14.478 *****
2026-01-21 15:02:25.540559 | controller | ok: [instance]
2026-01-21 15:02:25.554587 | controller |
2026-01-21 15:02:25.554608 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:25.554616 | controller | Wednesday 21 January 2026  15:02:25 +0000 (0:00:00.169)       0:00:14.648 *****
2026-01-21 15:02:25.554625 | controller | skipping: [instance]
2026-01-21 15:02:25.572659 | controller |
2026-01-21 15:02:25.572682 | controller | TASK [compliance : Log start of scans] *****************************************
2026-01-21 15:02:25.572690 | controller | Wednesday 21 January 2026  15:02:25 +0000 (0:00:00.014)       0:00:14.662 *****
2026-01-21 15:02:25.572699 | controller | ok: [instance] =>
2026-01-21 15:02:25.609934 | controller |   msg: Starting scans for stig
2026-01-21 15:02:25.609964 | controller |
2026-01-21 15:02:25.609974 | controller | TASK [compliance : Run scans and extract results] ******************************
2026-01-21 15:02:25.609981 | controller | Wednesday 21 January 2026  15:02:25 +0000 (0:00:00.017)       0:00:14.680 *****
2026-01-21 15:02:25.609993 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-stig)
2026-01-21 15:02:25.632434 | 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)
2026-01-21 15:02:25.632465 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-stig)
2026-01-21 15:02:25.632473 | controller |
2026-01-21 15:02:25.632479 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:25.632485 | controller | Wednesday 21 January 2026  15:02:25 +0000 (0:00:00.037)       0:00:14.717 *****
2026-01-21 15:02:25.632495 | controller | ok: [instance]
2026-01-21 15:02:25.663959 | controller |
2026-01-21 15:02:25.663993 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:25.664003 | controller | Wednesday 21 January 2026  15:02:25 +0000 (0:00:00.022)       0:00:14.740 *****
2026-01-21 15:02:25.664015 | controller | skipping: [instance]
2026-01-21 15:02:25.664044 | controller |
2026-01-21 15:02:25.664054 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:25.664123 | controller | Wednesday 21 January 2026  15:02:25 +0000 (0:00:00.031)       0:00:14.772 *****
2026-01-21 15:02:25.679955 | controller | skipping: [instance]
2026-01-21 15:02:25.680015 | controller |
2026-01-21 15:02:25.680029 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:25.680140 | controller | Wednesday 21 January 2026  15:02:25 +0000 (0:00:00.016)       0:00:14.788 *****
2026-01-21 15:02:25.857215 | controller | ok: [instance]
2026-01-21 15:02:26.053788 | controller |
2026-01-21 15:02:26.053818 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:26.053839 | controller | Wednesday 21 January 2026  15:02:25 +0000 (0:00:00.176)       0:00:14.965 *****
2026-01-21 15:02:26.053854 | controller | changed: [instance]
2026-01-21 15:02:26.070380 | controller |
2026-01-21 15:02:26.070419 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:26.070429 | controller | Wednesday 21 January 2026  15:02:26 +0000 (0:00:00.196)       0:00:15.161 *****
2026-01-21 15:02:26.070441 | controller | skipping: [instance]
2026-01-21 15:02:26.242767 | controller |
2026-01-21 15:02:26.242797 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:26.242805 | controller | Wednesday 21 January 2026  15:02:26 +0000 (0:00:00.016)       0:00:15.178 *****
2026-01-21 15:02:26.242815 | controller | ok: [instance]
2026-01-21 15:02:26.256911 | controller |
2026-01-21 15:02:26.256937 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:26.256945 | controller | Wednesday 21 January 2026  15:02:26 +0000 (0:00:00.172)       0:00:15.350 *****
2026-01-21 15:02:26.256959 | controller | skipping: [instance]
2026-01-21 15:02:26.279683 | controller |
2026-01-21 15:02:26.279714 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:26.279722 | controller | Wednesday 21 January 2026  15:02:26 +0000 (0:00:00.014)       0:00:15.365 *****
2026-01-21 15:02:26.279732 | controller | ok: [instance]
2026-01-21 15:02:26.297513 | controller |
2026-01-21 15:02:26.297539 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:26.297547 | controller | Wednesday 21 January 2026  15:02:26 +0000 (0:00:00.022)       0:00:15.387 *****
2026-01-21 15:02:26.297556 | controller | skipping: [instance]
2026-01-21 15:02:26.313583 | controller |
2026-01-21 15:02:26.313609 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:26.313617 | controller | Wednesday 21 January 2026  15:02:26 +0000 (0:00:00.018)       0:00:15.405 *****
2026-01-21 15:02:26.313627 | controller | skipping: [instance]
2026-01-21 15:02:26.498723 | controller |
2026-01-21 15:02:26.498768 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:26.498776 | controller | Wednesday 21 January 2026  15:02:26 +0000 (0:00:00.016)       0:00:15.421 *****
2026-01-21 15:02:26.498786 | controller | ok: [instance]
2026-01-21 15:02:26.684685 | controller |
2026-01-21 15:02:26.684715 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:26.684723 | controller | Wednesday 21 January 2026  15:02:26 +0000 (0:00:00.184)       0:00:15.606 *****
2026-01-21 15:02:26.684734 | controller | changed: [instance]
2026-01-21 15:02:26.700933 | controller |
2026-01-21 15:02:26.700970 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:26.700988 | controller | Wednesday 21 January 2026  15:02:26 +0000 (0:00:00.185)       0:00:15.792 *****
2026-01-21 15:02:26.701001 | controller | skipping: [instance]
2026-01-21 15:02:26.701030 | controller |
2026-01-21 15:02:26.701040 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:26.701132 | controller | Wednesday 21 January 2026  15:02:26 +0000 (0:00:00.016)       0:00:15.809 *****
2026-01-21 15:02:26.873361 | controller | ok: [instance]
2026-01-21 15:02:26.887911 | controller |
2026-01-21 15:02:26.887934 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:26.887942 | controller | Wednesday 21 January 2026  15:02:26 +0000 (0:00:00.172)       0:00:15.981 *****
2026-01-21 15:02:26.887951 | controller | skipping: [instance]
2026-01-21 15:02:26.888000 | controller |
2026-01-21 15:02:26.888016 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:26.888026 | controller | Wednesday 21 January 2026  15:02:26 +0000 (0:00:00.014)       0:00:15.996 *****
2026-01-21 15:02:26.910942 | controller | ok: [instance]
2026-01-21 15:02:26.910992 | controller |
2026-01-21 15:02:26.911003 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:26.911103 | controller | Wednesday 21 January 2026  15:02:26 +0000 (0:00:00.023)       0:00:16.019 *****
2026-01-21 15:02:26.929604 | controller | skipping: [instance]
2026-01-21 15:02:26.945946 | controller |
2026-01-21 15:02:26.945984 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:26.945994 | controller | Wednesday 21 January 2026  15:02:26 +0000 (0:00:00.018)       0:00:16.037 *****
2026-01-21 15:02:26.946007 | controller | skipping: [instance]
2026-01-21 15:02:26.946015 | controller |
2026-01-21 15:02:26.946022 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:26.946031 | controller | Wednesday 21 January 2026  15:02:26 +0000 (0:00:00.016)       0:00:16.054 *****
2026-01-21 15:02:27.123306 | controller | ok: [instance]
2026-01-21 15:02:27.316020 | controller |
2026-01-21 15:02:27.316050 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:27.316058 | controller | Wednesday 21 January 2026  15:02:27 +0000 (0:00:00.176)       0:00:16.231 *****
2026-01-21 15:02:27.316068 | controller | changed: [instance]
2026-01-21 15:02:27.333109 | controller |
2026-01-21 15:02:27.333135 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:27.333143 | controller | Wednesday 21 January 2026  15:02:27 +0000 (0:00:00.192)       0:00:16.424 *****
2026-01-21 15:02:27.333153 | controller | skipping: [instance]
2026-01-21 15:02:27.504905 | controller |
2026-01-21 15:02:27.504934 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:27.504942 | controller | Wednesday 21 January 2026  15:02:27 +0000 (0:00:00.017)       0:00:16.441 *****
2026-01-21 15:02:27.504952 | controller | ok: [instance]
2026-01-21 15:02:27.504975 | controller |
2026-01-21 15:02:27.505196 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:27.521056 | controller | Wednesday 21 January 2026  15:02:27 +0000 (0:00:00.171)       0:00:16.613 *****
2026-01-21 15:02:27.521082 | controller | skipping: [instance]
2026-01-21 15:02:27.561562 | controller |
2026-01-21 15:02:27.561583 | controller | TASK [compliance : Delete all resources created by the role] *******************
2026-01-21 15:02:27.561592 | controller | Wednesday 21 January 2026  15:02:27 +0000 (0:00:00.015)       0:00:16.629 *****
2026-01-21 15:02:27.561603 | controller | skipping: [instance]
2026-01-21 15:02:28.156916 | controller |
2026-01-21 15:02:28.156949 | controller | PLAY [Converge test of compute tasks] ******************************************
2026-01-21 15:02:28.156957 | controller |
2026-01-21 15:02:28.156963 | controller | TASK [Gathering Facts] *********************************************************
2026-01-21 15:02:28.156969 | controller | Wednesday 21 January 2026  15:02:27 +0000 (0:00:00.040)       0:00:16.669 *****
2026-01-21 15:02:28.156979 | controller | ok: [instance]
2026-01-21 15:02:28.366741 | controller |
2026-01-21 15:02:28.366786 | controller | TASK [compliance : Ensure compliance folder exists] ****************************
2026-01-21 15:02:28.366795 | controller | Wednesday 21 January 2026  15:02:28 +0000 (0:00:00.595)       0:00:17.264 *****
2026-01-21 15:02:28.366811 | controller | ok: [instance]
2026-01-21 15:02:28.395959 | controller |
2026-01-21 15:02:28.395998 | controller | TASK [compliance : Install the compliance operator and plugin] *****************
2026-01-21 15:02:28.396006 | controller | Wednesday 21 January 2026  15:02:28 +0000 (0:00:00.209)       0:00:17.474 *****
2026-01-21 15:02:28.396018 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/install.yml for instance
2026-01-21 15:02:28.396044 | controller |
2026-01-21 15:02:28.396053 | controller | TASK [compliance : Create the compliance namespace] ****************************
2026-01-21 15:02:28.396167 | controller | Wednesday 21 January 2026  15:02:28 +0000 (0:00:00.029)       0:00:17.504 *****
2026-01-21 15:02:28.414145 | controller | skipping: [instance]
2026-01-21 15:02:28.431885 | controller |
2026-01-21 15:02:28.431908 | controller | TASK [compliance : Ensure OperatorGroup for the compliance-operator is present] ***
2026-01-21 15:02:28.431916 | controller | Wednesday 21 January 2026  15:02:28 +0000 (0:00:00.018)       0:00:17.522 *****
2026-01-21 15:02:28.431925 | controller | skipping: [instance]
2026-01-21 15:02:28.450074 | controller |
2026-01-21 15:02:28.450093 | controller | TASK [compliance : Ensure Subscription for the compliance-operator is present] ***
2026-01-21 15:02:28.450100 | controller | Wednesday 21 January 2026  15:02:28 +0000 (0:00:00.017)       0:00:17.540 *****
2026-01-21 15:02:28.450110 | controller | skipping: [instance]
2026-01-21 15:02:28.466882 | controller |
2026-01-21 15:02:28.466904 | controller | TASK [compliance : Wait until the compliance-operator csv is present] **********
2026-01-21 15:02:28.466913 | controller | Wednesday 21 January 2026  15:02:28 +0000 (0:00:00.018)       0:00:17.558 *****
2026-01-21 15:02:28.466924 | controller | skipping: [instance]
2026-01-21 15:02:28.467249 | controller |
2026-01-21 15:02:28.484118 | controller | TASK [compliance : Get full name of the compliance-operator csv] ***************
2026-01-21 15:02:28.484138 | controller | Wednesday 21 January 2026  15:02:28 +0000 (0:00:00.016)       0:00:17.575 *****
2026-01-21 15:02:28.484149 | controller | skipping: [instance]
2026-01-21 15:02:28.500800 | controller |
2026-01-21 15:02:28.500820 | controller | TASK [compliance : Wait for the compliance-operator csv to Succeed] ************
2026-01-21 15:02:28.500849 | controller | Wednesday 21 January 2026  15:02:28 +0000 (0:00:00.016)       0:00:17.592 *****
2026-01-21 15:02:28.500863 | controller | skipping: [instance]
2026-01-21 15:02:29.146720 | controller |
2026-01-21 15:02:29.146748 | controller | TASK [podman : Ensure podman is installed] *************************************
2026-01-21 15:02:29.146772 | controller | Wednesday 21 January 2026  15:02:28 +0000 (0:00:00.016)       0:00:17.608 *****
2026-01-21 15:02:29.146783 | controller | ok: [instance]
2026-01-21 15:02:29.344869 | controller |
2026-01-21 15:02:29.344899 | controller | TASK [podman : Enable loginctl linger for ansible_user_id] *********************
2026-01-21 15:02:29.344907 | controller | Wednesday 21 January 2026  15:02:29 +0000 (0:00:00.646)       0:00:18.254 *****
2026-01-21 15:02:29.344917 | controller | changed: [instance]
2026-01-21 15:02:29.366377 | controller |
2026-01-21 15:02:29.366398 | controller | TASK [podman : Ensure subordinate UID entry exists for zuul] *******************
2026-01-21 15:02:29.366406 | controller | Wednesday 21 January 2026  15:02:29 +0000 (0:00:00.198)       0:00:18.452 *****
2026-01-21 15:02:29.366415 | controller | skipping: [instance]
2026-01-21 15:02:29.384876 | controller |
2026-01-21 15:02:29.384899 | controller | TASK [podman : Ensure subordinate GID entry exists for zuul] *******************
2026-01-21 15:02:29.384907 | controller | Wednesday 21 January 2026  15:02:29 +0000 (0:00:00.021)       0:00:18.474 *****
2026-01-21 15:02:29.384916 | controller | skipping: [instance]
2026-01-21 15:02:29.407958 | controller |
2026-01-21 15:02:29.407989 | controller | TASK [podman : Run podman system migrate if subuid/subgid files were changed] ***
2026-01-21 15:02:29.408005 | controller | Wednesday 21 January 2026  15:02:29 +0000 (0:00:00.018)       0:00:18.493 *****
2026-01-21 15:02:29.408017 | controller | skipping: [instance]
2026-01-21 15:02:29.423122 | controller |
2026-01-21 15:02:29.423145 | controller | TASK [compliance : Log into registry] ******************************************
2026-01-21 15:02:29.423153 | controller | Wednesday 21 January 2026  15:02:29 +0000 (0:00:00.022)       0:00:18.516 *****
2026-01-21 15:02:29.423162 | controller | skipping: [instance]
2026-01-21 15:02:29.437914 | controller |
2026-01-21 15:02:29.437941 | controller | TASK [compliance : Copy out the compliance plugin from the oc-compliance image] ***
2026-01-21 15:02:29.437951 | controller | Wednesday 21 January 2026  15:02:29 +0000 (0:00:00.015)       0:00:18.531 *****
2026-01-21 15:02:29.437963 | controller | skipping: [instance]
2026-01-21 15:02:29.437990 | controller |
2026-01-21 15:02:29.437998 | controller | TASK [compliance : Install packages to process results] ************************
2026-01-21 15:02:29.438007 | controller | Wednesday 21 January 2026  15:02:29 +0000 (0:00:00.014)       0:00:18.546 *****
2026-01-21 15:02:30.070624 | controller | ok: [instance]
2026-01-21 15:02:30.111985 | controller |
2026-01-21 15:02:30.112025 | controller | TASK [compliance : Run compliance scans and extract results] *******************
2026-01-21 15:02:30.112035 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.632)       0:00:19.178 *****
2026-01-21 15:02:30.112047 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=cis)
2026-01-21 15:02:30.112074 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=e8)
2026-01-21 15:02:30.112084 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=high)
2026-01-21 15:02:30.112915 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=moderate)
2026-01-21 15:02:30.129641 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=nerc-cip)
2026-01-21 15:02:30.129659 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=pci-dss)
2026-01-21 15:02:30.129667 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=stig)
2026-01-21 15:02:30.129673 | controller |
2026-01-21 15:02:30.129679 | controller | TASK [compliance : Log start of scans] *****************************************
2026-01-21 15:02:30.129685 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.041)       0:00:19.220 *****
2026-01-21 15:02:30.129694 | controller | ok: [instance] =>
2026-01-21 15:02:30.154353 | controller |   msg: Starting scans for cis
2026-01-21 15:02:30.154373 | controller |
2026-01-21 15:02:30.154381 | controller | TASK [compliance : Run scans and extract results] ******************************
2026-01-21 15:02:30.154387 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.017)       0:00:19.237 *****
2026-01-21 15:02:30.154396 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-cis)
2026-01-21 15:02:30.175447 | controller |
2026-01-21 15:02:30.175470 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:30.175477 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.024)       0:00:19.262 *****
2026-01-21 15:02:30.175487 | controller | ok: [instance]
2026-01-21 15:02:30.191914 | controller |
2026-01-21 15:02:30.191936 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:30.191944 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.021)       0:00:19.283 *****
2026-01-21 15:02:30.191953 | controller | skipping: [instance]
2026-01-21 15:02:30.207465 | controller |
2026-01-21 15:02:30.207487 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:30.207495 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.016)       0:00:19.300 *****
2026-01-21 15:02:30.207505 | controller | skipping: [instance]
2026-01-21 15:02:30.378510 | controller |
2026-01-21 15:02:30.378538 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:30.378546 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.015)       0:00:19.315 *****
2026-01-21 15:02:30.378556 | controller | changed: [instance]
2026-01-21 15:02:30.561959 | controller |
2026-01-21 15:02:30.561990 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:30.562007 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.170)       0:00:19.486 *****
2026-01-21 15:02:30.562018 | controller | changed: [instance]
2026-01-21 15:02:30.562177 | controller |
2026-01-21 15:02:30.562188 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:30.562197 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.183)       0:00:19.670 *****
2026-01-21 15:02:30.577584 | controller | skipping: [instance]
2026-01-21 15:02:30.749069 | controller |
2026-01-21 15:02:30.749102 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:30.749110 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.015)       0:00:19.685 *****
2026-01-21 15:02:30.749120 | controller | ok: [instance]
2026-01-21 15:02:30.763365 | controller |
2026-01-21 15:02:30.763396 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:30.763404 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.171)       0:00:19.857 *****
2026-01-21 15:02:30.763414 | controller | skipping: [instance]
2026-01-21 15:02:30.781654 | controller |
2026-01-21 15:02:30.781682 | controller | TASK [compliance : Log start of scans] *****************************************
2026-01-21 15:02:30.781689 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.014)       0:00:19.871 *****
2026-01-21 15:02:30.781703 | controller | ok: [instance] =>
2026-01-21 15:02:30.813595 | controller |   msg: Starting scans for e8
2026-01-21 15:02:30.813626 | controller |
2026-01-21 15:02:30.813634 | controller | TASK [compliance : Run scans and extract results] ******************************
2026-01-21 15:02:30.813640 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.018)       0:00:19.889 *****
2026-01-21 15:02:30.813649 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-e8)
2026-01-21 15:02:30.834986 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-e8)
2026-01-21 15:02:30.835031 | controller |
2026-01-21 15:02:30.835038 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:30.835044 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.031)       0:00:19.921 *****
2026-01-21 15:02:30.835054 | controller | ok: [instance]
2026-01-21 15:02:30.850274 | controller |
2026-01-21 15:02:30.850303 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:30.850310 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.021)       0:00:19.943 *****
2026-01-21 15:02:30.850320 | controller | skipping: [instance]
2026-01-21 15:02:30.850459 | controller |
2026-01-21 15:02:30.850599 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:30.850733 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.015)       0:00:19.958 *****
2026-01-21 15:02:30.865788 | controller | skipping: [instance]
2026-01-21 15:02:30.865989 | controller |
2026-01-21 15:02:30.866131 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:30.866264 | controller | Wednesday 21 January 2026  15:02:30 +0000 (0:00:00.015)       0:00:19.974 *****
2026-01-21 15:02:31.040664 | controller | changed: [instance]
2026-01-21 15:02:31.229542 | controller |
2026-01-21 15:02:31.229574 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:31.229583 | controller | Wednesday 21 January 2026  15:02:31 +0000 (0:00:00.174)       0:00:20.148 *****
2026-01-21 15:02:31.229592 | controller | changed: [instance]
2026-01-21 15:02:31.247080 | controller |
2026-01-21 15:02:31.247110 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:31.247118 | controller | Wednesday 21 January 2026  15:02:31 +0000 (0:00:00.188)       0:00:20.337 *****
2026-01-21 15:02:31.247128 | controller | skipping: [instance]
2026-01-21 15:02:31.425321 | controller |
2026-01-21 15:02:31.425353 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:31.425361 | controller | Wednesday 21 January 2026  15:02:31 +0000 (0:00:00.017)       0:00:20.355 *****
2026-01-21 15:02:31.425377 | controller | ok: [instance]
2026-01-21 15:02:31.440177 | controller |
2026-01-21 15:02:31.440208 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:31.440216 | controller | Wednesday 21 January 2026  15:02:31 +0000 (0:00:00.178)       0:00:20.533 *****
2026-01-21 15:02:31.440227 | controller | skipping: [instance]
2026-01-21 15:02:31.463595 | controller |
2026-01-21 15:02:31.463621 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:31.463628 | controller | Wednesday 21 January 2026  15:02:31 +0000 (0:00:00.014)       0:00:20.548 *****
2026-01-21 15:02:31.463638 | controller | ok: [instance]
2026-01-21 15:02:31.480640 | controller |
2026-01-21 15:02:31.480661 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:31.480669 | controller | Wednesday 21 January 2026  15:02:31 +0000 (0:00:00.023)       0:00:20.571 *****
2026-01-21 15:02:31.480678 | controller | skipping: [instance]
2026-01-21 15:02:31.497923 | controller |
2026-01-21 15:02:31.497958 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:31.497967 | controller | Wednesday 21 January 2026  15:02:31 +0000 (0:00:00.017)       0:00:20.588 *****
2026-01-21 15:02:31.497977 | controller | skipping: [instance]
2026-01-21 15:02:31.677947 | controller |
2026-01-21 15:02:31.677985 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:31.677998 | controller | Wednesday 21 January 2026  15:02:31 +0000 (0:00:00.017)       0:00:20.606 *****
2026-01-21 15:02:31.678011 | controller | changed: [instance]
2026-01-21 15:02:31.678189 | controller |
2026-01-21 15:02:31.678225 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:31.868455 | controller | Wednesday 21 January 2026  15:02:31 +0000 (0:00:00.179)       0:00:20.786 *****
2026-01-21 15:02:31.868490 | controller | changed: [instance]
2026-01-21 15:02:31.885942 | controller |
2026-01-21 15:02:31.885977 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:31.885986 | controller | Wednesday 21 January 2026  15:02:31 +0000 (0:00:00.190)       0:00:20.976 *****
2026-01-21 15:02:31.885996 | controller | skipping: [instance]
2026-01-21 15:02:31.886015 | controller |
2026-01-21 15:02:31.886210 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:32.066613 | controller | Wednesday 21 January 2026  15:02:31 +0000 (0:00:00.017)       0:00:20.994 *****
2026-01-21 15:02:32.066657 | controller | ok: [instance]
2026-01-21 15:02:32.080331 | controller |
2026-01-21 15:02:32.080360 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:32.080367 | controller | Wednesday 21 January 2026  15:02:32 +0000 (0:00:00.180)       0:00:21.174 *****
2026-01-21 15:02:32.080377 | controller | skipping: [instance]
2026-01-21 15:02:32.097930 | controller |
2026-01-21 15:02:32.097965 | controller | TASK [compliance : Log start of scans] *****************************************
2026-01-21 15:02:32.097975 | controller | Wednesday 21 January 2026  15:02:32 +0000 (0:00:00.013)       0:00:21.188 *****
2026-01-21 15:02:32.097987 | controller | ok: [instance] =>
2026-01-21 15:02:32.098015 | controller |   msg: Starting scans for high
2026-01-21 15:02:32.098030 | controller |
2026-01-21 15:02:32.098039 | controller | TASK [compliance : Run scans and extract results] ******************************
2026-01-21 15:02:32.098155 | controller | Wednesday 21 January 2026  15:02:32 +0000 (0:00:00.017)       0:00:21.206 *****
2026-01-21 15:02:32.135989 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-high)
2026-01-21 15:02:32.136037 | 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)
2026-01-21 15:02:32.136047 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-high)
2026-01-21 15:02:32.136055 | controller |
2026-01-21 15:02:32.136067 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:32.157379 | controller | Wednesday 21 January 2026  15:02:32 +0000 (0:00:00.037)       0:00:21.243 *****
2026-01-21 15:02:32.157423 | controller | ok: [instance]
2026-01-21 15:02:32.173506 | controller |
2026-01-21 15:02:32.173535 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:32.173543 | controller | Wednesday 21 January 2026  15:02:32 +0000 (0:00:00.021)       0:00:21.265 *****
2026-01-21 15:02:32.173553 | controller | skipping: [instance]
2026-01-21 15:02:32.188904 | controller |
2026-01-21 15:02:32.188934 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:32.188942 | controller | Wednesday 21 January 2026  15:02:32 +0000 (0:00:00.016)       0:00:21.281 *****
2026-01-21 15:02:32.188953 | controller | skipping: [instance]
2026-01-21 15:02:32.189196 | controller |
2026-01-21 15:02:32.189213 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:32.372637 | controller | Wednesday 21 January 2026  15:02:32 +0000 (0:00:00.015)       0:00:21.297 *****
2026-01-21 15:02:32.372674 | controller | changed: [instance]
2026-01-21 15:02:32.572663 | controller |
2026-01-21 15:02:32.572694 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:32.572702 | controller | Wednesday 21 January 2026  15:02:32 +0000 (0:00:00.183)       0:00:21.480 *****
2026-01-21 15:02:32.572712 | controller | changed: [instance]
2026-01-21 15:02:32.590502 | controller |
2026-01-21 15:02:32.590533 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:32.590541 | controller | Wednesday 21 January 2026  15:02:32 +0000 (0:00:00.200)       0:00:21.680 *****
2026-01-21 15:02:32.590551 | controller | skipping: [instance]
2026-01-21 15:02:32.775960 | controller |
2026-01-21 15:02:32.775992 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:32.776000 | controller | Wednesday 21 January 2026  15:02:32 +0000 (0:00:00.017)       0:00:21.698 *****
2026-01-21 15:02:32.776009 | controller | ok: [instance]
2026-01-21 15:02:32.794873 | controller |
2026-01-21 15:02:32.794900 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:32.794908 | controller | Wednesday 21 January 2026  15:02:32 +0000 (0:00:00.184)       0:00:21.883 *****
2026-01-21 15:02:32.794917 | controller | skipping: [instance]
2026-01-21 15:02:32.827966 | controller |
2026-01-21 15:02:32.828013 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:32.828023 | controller | Wednesday 21 January 2026  15:02:32 +0000 (0:00:00.019)       0:00:21.902 *****
2026-01-21 15:02:32.828036 | controller | ok: [instance]
2026-01-21 15:02:32.828070 | controller |
2026-01-21 15:02:32.828080 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:32.847935 | controller | Wednesday 21 January 2026  15:02:32 +0000 (0:00:00.032)       0:00:21.935 *****
2026-01-21 15:02:32.847975 | controller | skipping: [instance]
2026-01-21 15:02:32.848008 | controller |
2026-01-21 15:02:32.848253 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:32.869557 | controller | Wednesday 21 January 2026  15:02:32 +0000 (0:00:00.020)       0:00:21.956 *****
2026-01-21 15:02:32.869595 | controller | skipping: [instance]
2026-01-21 15:02:33.056683 | controller |
2026-01-21 15:02:33.056716 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:33.056724 | controller | Wednesday 21 January 2026  15:02:32 +0000 (0:00:00.021)       0:00:21.977 *****
2026-01-21 15:02:33.056739 | controller | changed: [instance]
2026-01-21 15:02:33.251648 | controller |
2026-01-21 15:02:33.251679 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:33.251687 | controller | Wednesday 21 January 2026  15:02:33 +0000 (0:00:00.187)       0:00:22.164 *****
2026-01-21 15:02:33.251697 | controller | changed: [instance]
2026-01-21 15:02:33.272386 | controller |
2026-01-21 15:02:33.272412 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:33.272421 | controller | Wednesday 21 January 2026  15:02:33 +0000 (0:00:00.194)       0:00:22.359 *****
2026-01-21 15:02:33.272433 | controller | skipping: [instance]
2026-01-21 15:02:33.454023 | controller |
2026-01-21 15:02:33.454054 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:33.454067 | controller | Wednesday 21 January 2026  15:02:33 +0000 (0:00:00.020)       0:00:22.380 *****
2026-01-21 15:02:33.454077 | controller | ok: [instance]
2026-01-21 15:02:33.471931 | controller |
2026-01-21 15:02:33.471968 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:33.471978 | controller | Wednesday 21 January 2026  15:02:33 +0000 (0:00:00.181)       0:00:22.561 *****
2026-01-21 15:02:33.471990 | controller | skipping: [instance]
2026-01-21 15:02:33.472018 | controller |
2026-01-21 15:02:33.472028 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:33.472119 | controller | Wednesday 21 January 2026  15:02:33 +0000 (0:00:00.018)       0:00:22.580 *****
2026-01-21 15:02:33.499492 | controller | ok: [instance]
2026-01-21 15:02:33.524674 | controller |
2026-01-21 15:02:33.524701 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:33.524710 | controller | Wednesday 21 January 2026  15:02:33 +0000 (0:00:00.027)       0:00:22.607 *****
2026-01-21 15:02:33.524722 | controller | skipping: [instance]
2026-01-21 15:02:33.545330 | controller |
2026-01-21 15:02:33.545351 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:33.545358 | controller | Wednesday 21 January 2026  15:02:33 +0000 (0:00:00.025)       0:00:22.632 *****
2026-01-21 15:02:33.545367 | controller | skipping: [instance]
2026-01-21 15:02:33.738632 | controller |
2026-01-21 15:02:33.738667 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:33.738683 | controller | Wednesday 21 January 2026  15:02:33 +0000 (0:00:00.020)       0:00:22.653 *****
2026-01-21 15:02:33.738694 | controller | changed: [instance]
2026-01-21 15:02:33.948966 | controller |
2026-01-21 15:02:33.949019 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:33.949028 | controller | Wednesday 21 January 2026  15:02:33 +0000 (0:00:00.192)       0:00:22.846 *****
2026-01-21 15:02:33.949041 | controller | changed: [instance]
2026-01-21 15:02:33.969806 | controller |
2026-01-21 15:02:33.969871 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:33.969880 | controller | Wednesday 21 January 2026  15:02:33 +0000 (0:00:00.210)       0:00:23.056 *****
2026-01-21 15:02:33.969891 | controller | skipping: [instance]
2026-01-21 15:02:34.161649 | controller |
2026-01-21 15:02:34.161681 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:34.161689 | controller | Wednesday 21 January 2026  15:02:33 +0000 (0:00:00.021)       0:00:23.077 *****
2026-01-21 15:02:34.161700 | controller | ok: [instance]
2026-01-21 15:02:34.180738 | controller |
2026-01-21 15:02:34.180765 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:34.180793 | controller | Wednesday 21 January 2026  15:02:34 +0000 (0:00:00.191)       0:00:23.269 *****
2026-01-21 15:02:34.180805 | controller | skipping: [instance]
2026-01-21 15:02:34.204433 | controller |
2026-01-21 15:02:34.204458 | controller | TASK [compliance : Log start of scans] *****************************************
2026-01-21 15:02:34.204465 | controller | Wednesday 21 January 2026  15:02:34 +0000 (0:00:00.019)       0:00:23.288 *****
2026-01-21 15:02:34.204474 | controller | ok: [instance] =>
2026-01-21 15:02:34.244735 | controller |   msg: Starting scans for moderate
2026-01-21 15:02:34.244760 | controller |
2026-01-21 15:02:34.244767 | controller | TASK [compliance : Run scans and extract results] ******************************
2026-01-21 15:02:34.244773 | controller | Wednesday 21 January 2026  15:02:34 +0000 (0:00:00.023)       0:00:23.312 *****
2026-01-21 15:02:34.244806 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-moderate)
2026-01-21 15:02:34.270696 | 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)
2026-01-21 15:02:34.270725 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-moderate)
2026-01-21 15:02:34.270734 | controller |
2026-01-21 15:02:34.270742 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:34.270759 | controller | Wednesday 21 January 2026  15:02:34 +0000 (0:00:00.040)       0:00:23.352 *****
2026-01-21 15:02:34.270771 | controller | ok: [instance]
2026-01-21 15:02:34.271008 | controller |
2026-01-21 15:02:34.271189 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:34.271379 | controller | Wednesday 21 January 2026  15:02:34 +0000 (0:00:00.026)       0:00:23.379 *****
2026-01-21 15:02:34.290475 | controller | skipping: [instance]
2026-01-21 15:02:34.290663 | controller |
2026-01-21 15:02:34.290881 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:34.291062 | controller | Wednesday 21 January 2026  15:02:34 +0000 (0:00:00.019)       0:00:23.398 *****
2026-01-21 15:02:34.310961 | controller | skipping: [instance]
2026-01-21 15:02:34.311149 | controller |
2026-01-21 15:02:34.311323 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:34.311486 | controller | Wednesday 21 January 2026  15:02:34 +0000 (0:00:00.020)       0:00:23.419 *****
2026-01-21 15:02:34.504572 | controller | changed: [instance]
2026-01-21 15:02:34.706175 | controller |
2026-01-21 15:02:34.706207 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:34.706215 | controller | Wednesday 21 January 2026  15:02:34 +0000 (0:00:00.192)       0:00:23.612 *****
2026-01-21 15:02:34.706225 | controller | changed: [instance]
2026-01-21 15:02:34.727592 | controller |
2026-01-21 15:02:34.727617 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:34.727626 | controller | Wednesday 21 January 2026  15:02:34 +0000 (0:00:00.201)       0:00:23.814 *****
2026-01-21 15:02:34.727635 | controller | skipping: [instance]
2026-01-21 15:02:34.919907 | controller |
2026-01-21 15:02:34.919940 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:34.919949 | controller | Wednesday 21 January 2026  15:02:34 +0000 (0:00:00.021)       0:00:23.835 *****
2026-01-21 15:02:34.919959 | controller | ok: [instance]
2026-01-21 15:02:34.920107 | controller |
2026-01-21 15:02:34.920119 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:34.920128 | controller | Wednesday 21 January 2026  15:02:34 +0000 (0:00:00.192)       0:00:24.027 *****
2026-01-21 15:02:34.937876 | controller | skipping: [instance]
2026-01-21 15:02:34.964908 | controller |
2026-01-21 15:02:34.964933 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:34.964942 | controller | Wednesday 21 January 2026  15:02:34 +0000 (0:00:00.018)       0:00:24.046 *****
2026-01-21 15:02:34.964953 | controller | ok: [instance]
2026-01-21 15:02:34.986289 | controller |
2026-01-21 15:02:34.986313 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:34.986323 | controller | Wednesday 21 January 2026  15:02:34 +0000 (0:00:00.026)       0:00:24.072 *****
2026-01-21 15:02:34.986335 | controller | skipping: [instance]
2026-01-21 15:02:35.005901 | controller |
2026-01-21 15:02:35.005923 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:35.005932 | controller | Wednesday 21 January 2026  15:02:34 +0000 (0:00:00.021)       0:00:24.094 *****
2026-01-21 15:02:35.005943 | controller | skipping: [instance]
2026-01-21 15:02:35.005971 | controller |
2026-01-21 15:02:35.006135 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:35.196734 | controller | Wednesday 21 January 2026  15:02:35 +0000 (0:00:00.019)       0:00:24.114 *****
2026-01-21 15:02:35.196771 | controller | changed: [instance]
2026-01-21 15:02:35.416739 | controller |
2026-01-21 15:02:35.416770 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:35.416825 | controller | Wednesday 21 January 2026  15:02:35 +0000 (0:00:00.190)       0:00:24.304 *****
2026-01-21 15:02:35.416864 | controller | changed: [instance]
2026-01-21 15:02:35.436649 | controller |
2026-01-21 15:02:35.436670 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:35.436677 | controller | Wednesday 21 January 2026  15:02:35 +0000 (0:00:00.220)       0:00:24.524 *****
2026-01-21 15:02:35.436687 | controller | skipping: [instance]
2026-01-21 15:02:35.623974 | controller |
2026-01-21 15:02:35.624005 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:35.624013 | controller | Wednesday 21 January 2026  15:02:35 +0000 (0:00:00.019)       0:00:24.544 *****
2026-01-21 15:02:35.624024 | controller | ok: [instance]
2026-01-21 15:02:35.640890 | controller |
2026-01-21 15:02:35.640918 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:35.640928 | controller | Wednesday 21 January 2026  15:02:35 +0000 (0:00:00.187)       0:00:24.731 *****
2026-01-21 15:02:35.640939 | controller | skipping: [instance]
2026-01-21 15:02:35.641227 | controller |
2026-01-21 15:02:35.666637 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:35.666660 | controller | Wednesday 21 January 2026  15:02:35 +0000 (0:00:00.017)       0:00:24.749 *****
2026-01-21 15:02:35.666680 | controller | ok: [instance]
2026-01-21 15:02:35.686904 | controller |
2026-01-21 15:02:35.686929 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:35.686938 | controller | Wednesday 21 January 2026  15:02:35 +0000 (0:00:00.025)       0:00:24.774 *****
2026-01-21 15:02:35.686949 | controller | skipping: [instance]
2026-01-21 15:02:35.686976 | controller |
2026-01-21 15:02:35.686985 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:35.687051 | controller | Wednesday 21 January 2026  15:02:35 +0000 (0:00:00.020)       0:00:24.795 *****
2026-01-21 15:02:35.707303 | controller | skipping: [instance]
2026-01-21 15:02:35.900899 | controller |
2026-01-21 15:02:35.900930 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:35.900938 | controller | Wednesday 21 January 2026  15:02:35 +0000 (0:00:00.020)       0:00:24.815 *****
2026-01-21 15:02:35.900948 | controller | changed: [instance]
2026-01-21 15:02:35.901044 | controller |
2026-01-21 15:02:35.901054 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:35.901063 | controller | Wednesday 21 January 2026  15:02:35 +0000 (0:00:00.193)       0:00:25.008 *****
2026-01-21 15:02:36.099191 | controller | changed: [instance]
2026-01-21 15:02:36.119719 | controller |
2026-01-21 15:02:36.119744 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:36.119752 | controller | Wednesday 21 January 2026  15:02:36 +0000 (0:00:00.198)       0:00:25.207 *****
2026-01-21 15:02:36.119761 | controller | skipping: [instance]
2026-01-21 15:02:36.303003 | controller |
2026-01-21 15:02:36.303051 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:36.303059 | controller | Wednesday 21 January 2026  15:02:36 +0000 (0:00:00.020)       0:00:25.227 *****
2026-01-21 15:02:36.303071 | controller | ok: [instance]
2026-01-21 15:02:36.303097 | controller |
2026-01-21 15:02:36.303105 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:36.303129 | controller | Wednesday 21 January 2026  15:02:36 +0000 (0:00:00.183)       0:00:25.411 *****
2026-01-21 15:02:36.320906 | controller | skipping: [instance]
2026-01-21 15:02:36.343444 | controller |
2026-01-21 15:02:36.343478 | controller | TASK [compliance : Log start of scans] *****************************************
2026-01-21 15:02:36.343486 | controller | Wednesday 21 January 2026  15:02:36 +0000 (0:00:00.017)       0:00:25.428 *****
2026-01-21 15:02:36.343497 | controller | ok: [instance] =>
2026-01-21 15:02:36.379460 | controller |   msg: Starting scans for nerc-cip
2026-01-21 15:02:36.379487 | controller |
2026-01-21 15:02:36.379494 | controller | TASK [compliance : Run scans and extract results] ******************************
2026-01-21 15:02:36.379501 | controller | Wednesday 21 January 2026  15:02:36 +0000 (0:00:00.022)       0:00:25.451 *****
2026-01-21 15:02:36.379510 | 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)
2026-01-21 15:02:36.406447 | 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)
2026-01-21 15:02:36.406478 | controller |
2026-01-21 15:02:36.406485 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:36.406499 | controller | Wednesday 21 January 2026  15:02:36 +0000 (0:00:00.036)       0:00:25.487 *****
2026-01-21 15:02:36.406509 | controller | ok: [instance]
2026-01-21 15:02:36.406656 | controller |
2026-01-21 15:02:36.406843 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:36.407002 | controller | Wednesday 21 January 2026  15:02:36 +0000 (0:00:00.027)       0:00:25.514 *****
2026-01-21 15:02:36.427097 | controller | skipping: [instance]
2026-01-21 15:02:36.427297 | controller |
2026-01-21 15:02:36.427469 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:36.427615 | controller | Wednesday 21 January 2026  15:02:36 +0000 (0:00:00.020)       0:00:25.535 *****
2026-01-21 15:02:36.448266 | controller | skipping: [instance]
2026-01-21 15:02:36.448451 | controller |
2026-01-21 15:02:36.448598 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:36.448732 | controller | Wednesday 21 January 2026  15:02:36 +0000 (0:00:00.021)       0:00:25.556 *****
2026-01-21 15:02:36.644677 | controller | changed: [instance]
2026-01-21 15:02:36.837817 | controller |
2026-01-21 15:02:36.837861 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:36.837869 | controller | Wednesday 21 January 2026  15:02:36 +0000 (0:00:00.196)       0:00:25.752 *****
2026-01-21 15:02:36.837880 | controller | changed: [instance]
2026-01-21 15:02:36.854089 | controller |
2026-01-21 15:02:36.854116 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:36.854125 | controller | Wednesday 21 January 2026  15:02:36 +0000 (0:00:00.193)       0:00:25.945 *****
2026-01-21 15:02:36.854137 | controller | skipping: [instance]
2026-01-21 15:02:37.027776 | controller |
2026-01-21 15:02:37.027824 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:37.027867 | controller | Wednesday 21 January 2026  15:02:36 +0000 (0:00:00.016)       0:00:25.962 *****
2026-01-21 15:02:37.027879 | controller | ok: [instance]
2026-01-21 15:02:37.041269 | controller |
2026-01-21 15:02:37.041296 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:37.041304 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.172)       0:00:26.134 *****
2026-01-21 15:02:37.041315 | controller | skipping: [instance]
2026-01-21 15:02:37.042203 | controller |
2026-01-21 15:02:37.063374 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:37.063401 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.014)       0:00:26.149 *****
2026-01-21 15:02:37.063412 | controller | ok: [instance]
2026-01-21 15:02:37.080488 | controller |
2026-01-21 15:02:37.080518 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:37.080526 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.022)       0:00:26.171 *****
2026-01-21 15:02:37.080536 | controller | skipping: [instance]
2026-01-21 15:02:37.097927 | controller |
2026-01-21 15:02:37.097956 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:37.097966 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.017)       0:00:26.188 *****
2026-01-21 15:02:37.097978 | controller | skipping: [instance]
2026-01-21 15:02:37.098300 | controller |
2026-01-21 15:02:37.281765 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:37.281811 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.017)       0:00:26.206 *****
2026-01-21 15:02:37.281824 | controller | changed: [instance]
2026-01-21 15:02:37.464665 | controller |
2026-01-21 15:02:37.464694 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:37.464702 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.183)       0:00:26.389 *****
2026-01-21 15:02:37.464712 | controller | changed: [instance]
2026-01-21 15:02:37.481230 | controller |
2026-01-21 15:02:37.481256 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:37.481265 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.182)       0:00:26.572 *****
2026-01-21 15:02:37.481276 | controller | skipping: [instance]
2026-01-21 15:02:37.648890 | controller |
2026-01-21 15:02:37.648920 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:37.648934 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.016)       0:00:26.589 *****
2026-01-21 15:02:37.648944 | controller | ok: [instance]
2026-01-21 15:02:37.662917 | controller |
2026-01-21 15:02:37.662946 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:37.662956 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.167)       0:00:26.756 *****
2026-01-21 15:02:37.662968 | controller | skipping: [instance]
2026-01-21 15:02:37.662994 | controller |
2026-01-21 15:02:37.663004 | controller | TASK [compliance : Log start of scans] *****************************************
2026-01-21 15:02:37.663114 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.014)       0:00:26.771 *****
2026-01-21 15:02:37.680824 | controller | ok: [instance] =>
2026-01-21 15:02:37.713549 | controller |   msg: Starting scans for pci-dss
2026-01-21 15:02:37.713577 | controller |
2026-01-21 15:02:37.713585 | controller | TASK [compliance : Run scans and extract results] ******************************
2026-01-21 15:02:37.713591 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.017)       0:00:26.788 *****
2026-01-21 15:02:37.713601 | 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)
2026-01-21 15:02:37.735112 | 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)
2026-01-21 15:02:37.735139 | controller |
2026-01-21 15:02:37.735147 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:37.735153 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.032)       0:00:26.821 *****
2026-01-21 15:02:37.735163 | controller | ok: [instance]
2026-01-21 15:02:37.750806 | controller |
2026-01-21 15:02:37.750851 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:37.750864 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.021)       0:00:26.843 *****
2026-01-21 15:02:37.750876 | controller | skipping: [instance]
2026-01-21 15:02:37.766966 | controller |
2026-01-21 15:02:37.766989 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:37.766997 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.015)       0:00:26.858 *****
2026-01-21 15:02:37.767007 | controller | skipping: [instance]
2026-01-21 15:02:37.941609 | controller |
2026-01-21 15:02:37.941640 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:37.941648 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.016)       0:00:26.875 *****
2026-01-21 15:02:37.941663 | controller | changed: [instance]
2026-01-21 15:02:38.130511 | controller |
2026-01-21 15:02:38.130542 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:38.130550 | controller | Wednesday 21 January 2026  15:02:37 +0000 (0:00:00.174)       0:00:27.049 *****
2026-01-21 15:02:38.130559 | controller | changed: [instance]
2026-01-21 15:02:38.148518 | controller |
2026-01-21 15:02:38.148539 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:38.148548 | controller | Wednesday 21 January 2026  15:02:38 +0000 (0:00:00.188)       0:00:27.238 *****
2026-01-21 15:02:38.148558 | controller | skipping: [instance]
2026-01-21 15:02:38.331549 | controller |
2026-01-21 15:02:38.331580 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:38.331589 | controller | Wednesday 21 January 2026  15:02:38 +0000 (0:00:00.018)       0:00:27.256 *****
2026-01-21 15:02:38.331599 | controller | ok: [instance]
2026-01-21 15:02:38.346430 | controller |
2026-01-21 15:02:38.346455 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:38.346462 | controller | Wednesday 21 January 2026  15:02:38 +0000 (0:00:00.182)       0:00:27.439 *****
2026-01-21 15:02:38.346472 | controller | skipping: [instance]
2026-01-21 15:02:38.368563 | controller |
2026-01-21 15:02:38.368584 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:38.368593 | controller | Wednesday 21 January 2026  15:02:38 +0000 (0:00:00.015)       0:00:27.454 *****
2026-01-21 15:02:38.368611 | controller | ok: [instance]
2026-01-21 15:02:38.385313 | controller |
2026-01-21 15:02:38.385334 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:38.385341 | controller | Wednesday 21 January 2026  15:02:38 +0000 (0:00:00.022)       0:00:27.476 *****
2026-01-21 15:02:38.385350 | controller | skipping: [instance]
2026-01-21 15:02:38.401658 | controller |
2026-01-21 15:02:38.401675 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:38.401682 | controller | Wednesday 21 January 2026  15:02:38 +0000 (0:00:00.016)       0:00:27.493 *****
2026-01-21 15:02:38.401690 | controller | skipping: [instance]
2026-01-21 15:02:38.586932 | controller |
2026-01-21 15:02:38.586971 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:38.586980 | controller | Wednesday 21 January 2026  15:02:38 +0000 (0:00:00.016)       0:00:27.510 *****
2026-01-21 15:02:38.586992 | controller | changed: [instance]
2026-01-21 15:02:38.776917 | controller |
2026-01-21 15:02:38.776959 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:38.776967 | controller | Wednesday 21 January 2026  15:02:38 +0000 (0:00:00.184)       0:00:27.695 *****
2026-01-21 15:02:38.776977 | controller | changed: [instance]
2026-01-21 15:02:38.777001 | controller |
2026-01-21 15:02:38.777007 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:38.777015 | controller | Wednesday 21 January 2026  15:02:38 +0000 (0:00:00.190)       0:00:27.885 *****
2026-01-21 15:02:38.794264 | controller | skipping: [instance]
2026-01-21 15:02:38.975069 | controller |
2026-01-21 15:02:38.975099 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:38.975107 | controller | Wednesday 21 January 2026  15:02:38 +0000 (0:00:00.017)       0:00:27.902 *****
2026-01-21 15:02:38.975117 | controller | ok: [instance]
2026-01-21 15:02:38.991753 | controller |
2026-01-21 15:02:38.991782 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:38.991790 | controller | Wednesday 21 January 2026  15:02:38 +0000 (0:00:00.180)       0:00:28.083 *****
2026-01-21 15:02:38.991814 | controller | skipping: [instance]
2026-01-21 15:02:39.012707 | controller |
2026-01-21 15:02:39.012736 | controller | TASK [compliance : Log start of scans] *****************************************
2026-01-21 15:02:39.012743 | controller | Wednesday 21 January 2026  15:02:38 +0000 (0:00:00.016)       0:00:28.099 *****
2026-01-21 15:02:39.012753 | controller | ok: [instance] =>
2026-01-21 15:02:39.050806 | controller |   msg: Starting scans for stig
2026-01-21 15:02:39.050860 | controller |
2026-01-21 15:02:39.050872 | controller | TASK [compliance : Run scans and extract results] ******************************
2026-01-21 15:02:39.050879 | controller | Wednesday 21 January 2026  15:02:39 +0000 (0:00:00.020)       0:00:28.120 *****
2026-01-21 15:02:39.050888 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-stig)
2026-01-21 15:02:39.072956 | 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)
2026-01-21 15:02:39.072983 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-stig)
2026-01-21 15:02:39.072992 | controller |
2026-01-21 15:02:39.072999 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:39.073006 | controller | Wednesday 21 January 2026  15:02:39 +0000 (0:00:00.037)       0:00:28.158 *****
2026-01-21 15:02:39.073018 | controller | ok: [instance]
2026-01-21 15:02:39.089537 | controller |
2026-01-21 15:02:39.089561 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:39.089575 | controller | Wednesday 21 January 2026  15:02:39 +0000 (0:00:00.022)       0:00:28.181 *****
2026-01-21 15:02:39.089585 | controller | skipping: [instance]
2026-01-21 15:02:39.106364 | controller |
2026-01-21 15:02:39.106392 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:39.106402 | controller | Wednesday 21 January 2026  15:02:39 +0000 (0:00:00.016)       0:00:28.197 *****
2026-01-21 15:02:39.106418 | controller | skipping: [instance]
2026-01-21 15:02:39.283935 | controller |
2026-01-21 15:02:39.283968 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:39.283976 | controller | Wednesday 21 January 2026  15:02:39 +0000 (0:00:00.016)       0:00:28.214 *****
2026-01-21 15:02:39.283986 | controller | changed: [instance]
2026-01-21 15:02:39.284009 | controller |
2026-01-21 15:02:39.284017 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:39.284166 | controller | Wednesday 21 January 2026  15:02:39 +0000 (0:00:00.177)       0:00:28.392 *****
2026-01-21 15:02:39.469658 | controller | changed: [instance]
2026-01-21 15:02:39.486936 | controller |
2026-01-21 15:02:39.486973 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:39.486983 | controller | Wednesday 21 January 2026  15:02:39 +0000 (0:00:00.185)       0:00:28.577 *****
2026-01-21 15:02:39.486995 | controller | skipping: [instance]
2026-01-21 15:02:39.487023 | controller |
2026-01-21 15:02:39.487033 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:39.487083 | controller | Wednesday 21 January 2026  15:02:39 +0000 (0:00:00.017)       0:00:28.595 *****
2026-01-21 15:02:39.660475 | controller | ok: [instance]
2026-01-21 15:02:39.675288 | controller |
2026-01-21 15:02:39.675311 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:39.675319 | controller | Wednesday 21 January 2026  15:02:39 +0000 (0:00:00.173)       0:00:28.768 *****
2026-01-21 15:02:39.675328 | controller | skipping: [instance]
2026-01-21 15:02:39.698660 | controller |
2026-01-21 15:02:39.698687 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:39.698697 | controller | Wednesday 21 January 2026  15:02:39 +0000 (0:00:00.015)       0:00:28.783 *****
2026-01-21 15:02:39.698708 | controller | ok: [instance]
2026-01-21 15:02:39.715616 | controller |
2026-01-21 15:02:39.715638 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:39.715646 | controller | Wednesday 21 January 2026  15:02:39 +0000 (0:00:00.023)       0:00:28.806 *****
2026-01-21 15:02:39.715657 | controller | skipping: [instance]
2026-01-21 15:02:39.732412 | controller |
2026-01-21 15:02:39.732439 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:39.732447 | controller | Wednesday 21 January 2026  15:02:39 +0000 (0:00:00.017)       0:00:28.823 *****
2026-01-21 15:02:39.732456 | controller | skipping: [instance]
2026-01-21 15:02:39.916548 | controller |
2026-01-21 15:02:39.916579 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:39.916587 | controller | Wednesday 21 January 2026  15:02:39 +0000 (0:00:00.016)       0:00:28.840 *****
2026-01-21 15:02:39.916597 | controller | changed: [instance]
2026-01-21 15:02:40.109026 | controller |
2026-01-21 15:02:40.109056 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:40.109064 | controller | Wednesday 21 January 2026  15:02:39 +0000 (0:00:00.183)       0:00:29.024 *****
2026-01-21 15:02:40.109074 | controller | changed: [instance]
2026-01-21 15:02:40.125624 | controller |
2026-01-21 15:02:40.125643 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:40.125650 | controller | Wednesday 21 January 2026  15:02:40 +0000 (0:00:00.192)       0:00:29.217 *****
2026-01-21 15:02:40.125659 | controller | skipping: [instance]
2026-01-21 15:02:40.301971 | controller |
2026-01-21 15:02:40.302004 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:40.302012 | controller | Wednesday 21 January 2026  15:02:40 +0000 (0:00:00.016)       0:00:29.233 *****
2026-01-21 15:02:40.302022 | controller | ok: [instance]
2026-01-21 15:02:40.316358 | controller |
2026-01-21 15:02:40.316376 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:40.316383 | controller | Wednesday 21 January 2026  15:02:40 +0000 (0:00:00.176)       0:00:29.409 *****
2026-01-21 15:02:40.316392 | controller | skipping: [instance]
2026-01-21 15:02:40.338786 | controller |
2026-01-21 15:02:40.338824 | controller | TASK [compliance : Set output directory] ***************************************
2026-01-21 15:02:40.338877 | controller | Wednesday 21 January 2026  15:02:40 +0000 (0:00:00.014)       0:00:29.424 *****
2026-01-21 15:02:40.338893 | controller | ok: [instance]
2026-01-21 15:02:40.355822 | controller |
2026-01-21 15:02:40.355858 | controller | TASK [compliance : Create scan binding] ****************************************
2026-01-21 15:02:40.355866 | controller | Wednesday 21 January 2026  15:02:40 +0000 (0:00:00.022)       0:00:29.447 *****
2026-01-21 15:02:40.355876 | controller | skipping: [instance]
2026-01-21 15:02:40.372748 | controller |
2026-01-21 15:02:40.372769 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2026-01-21 15:02:40.372777 | controller | Wednesday 21 January 2026  15:02:40 +0000 (0:00:00.017)       0:00:29.464 *****
2026-01-21 15:02:40.372787 | controller | skipping: [instance]
2026-01-21 15:02:40.552744 | controller |
2026-01-21 15:02:40.552774 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2026-01-21 15:02:40.552782 | controller | Wednesday 21 January 2026  15:02:40 +0000 (0:00:00.016)       0:00:29.481 *****
2026-01-21 15:02:40.552792 | controller | changed: [instance]
2026-01-21 15:02:40.740225 | controller |
2026-01-21 15:02:40.740256 | controller | TASK [compliance : Create directory for scan results] **************************
2026-01-21 15:02:40.740263 | controller | Wednesday 21 January 2026  15:02:40 +0000 (0:00:00.179)       0:00:29.660 *****
2026-01-21 15:02:40.740273 | controller | changed: [instance]
2026-01-21 15:02:40.756915 | controller |
2026-01-21 15:02:40.756940 | controller | TASK [compliance : Retrieve scan results] **************************************
2026-01-21 15:02:40.756949 | controller | Wednesday 21 January 2026  15:02:40 +0000 (0:00:00.187)       0:00:29.848 *****
2026-01-21 15:02:40.756958 | controller | skipping: [instance]
2026-01-21 15:02:40.756982 | controller |
2026-01-21 15:02:40.757174 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2026-01-21 15:02:40.928608 | controller | Wednesday 21 January 2026  15:02:40 +0000 (0:00:00.017)       0:00:29.865 *****
2026-01-21 15:02:40.928641 | controller | ok: [instance]
2026-01-21 15:02:40.943028 | controller |
2026-01-21 15:02:40.943054 | controller | TASK [compliance : Process scan result files] **********************************
2026-01-21 15:02:40.943062 | controller | Wednesday 21 January 2026  15:02:40 +0000 (0:00:00.171)       0:00:30.036 *****
2026-01-21 15:02:40.943072 | controller | skipping: [instance]
2026-01-21 15:02:40.975933 | controller |
2026-01-21 15:02:40.975968 | controller | TASK [compliance : Delete all resources created by the role] *******************
2026-01-21 15:02:40.975978 | controller | Wednesday 21 January 2026  15:02:40 +0000 (0:00:00.014)       0:00:30.051 *****
2026-01-21 15:02:40.975991 | controller | skipping: [instance]
2026-01-21 15:02:40.976020 | controller |
2026-01-21 15:02:40.976028 | controller | PLAY RECAP *********************************************************************
2026-01-21 15:02:40.976036 | controller | instance                   : ok=200  changed=52   unreachable=0    failed=0    skipped=152  rescued=0    ignored=0
2026-01-21 15:02:40.976043 | controller |
2026-01-21 15:02:40.976049 | controller | Wednesday 21 January 2026  15:02:40 +0000 (0:00:00.031)       0:00:30.083 *****
2026-01-21 15:02:40.976056 | controller | ===============================================================================
2026-01-21 15:02:40.976063 | controller | compliance : Install packages to process results ------------------------ 3.68s
2026-01-21 15:02:40.976070 | controller | Gathering Facts --------------------------------------------------------- 0.84s
2026-01-21 15:02:40.976079 | controller | podman : Ensure podman is installed ------------------------------------- 0.78s
2026-01-21 15:02:40.976104 | controller | podman : Ensure podman is installed ------------------------------------- 0.65s
2026-01-21 15:02:40.977633 | controller | compliance : Install packages to process results ------------------------ 0.63s
2026-01-21 15:02:41.032929 | controller | Gathering Facts --------------------------------------------------------- 0.60s
2026-01-21 15:02:41.032964 | controller | podman : Enable loginctl linger for ansible_user_id --------------------- 0.43s
2026-01-21 15:02:41.032972 | controller | compliance : Ensure compliance folder exists ---------------------------- 0.30s
2026-01-21 15:02:41.032978 | controller | compliance : Find all the compressed scan results ----------------------- 0.27s
2026-01-21 15:02:41.032983 | controller | compliance : Create directory for scan results -------------------------- 0.22s
2026-01-21 15:02:41.032992 | controller | compliance : Create directory for scan results -------------------------- 0.21s
2026-01-21 15:02:41.032998 | controller | compliance : Ensure compliance folder exists ---------------------------- 0.21s
2026-01-21 15:02:41.033006 | controller | compliance : Create directory for scan results -------------------------- 0.20s
2026-01-21 15:02:41.033012 | controller | compliance : Create directory for scan results -------------------------- 0.20s
2026-01-21 15:02:41.033017 | controller | compliance : Create directory for scan results -------------------------- 0.20s
2026-01-21 15:02:41.033023 | controller | podman : Enable loginctl linger for ansible_user_id --------------------- 0.20s
2026-01-21 15:02:41.033028 | controller | compliance : Create directory for scan results -------------------------- 0.20s
2026-01-21 15:02:41.033033 | controller | compliance : Delete directory for scan results if it exists ------------- 0.20s
2026-01-21 15:02:41.033038 | controller | compliance : Create directory for scan results -------------------------- 0.19s
2026-01-21 15:02:41.033044 | controller | compliance : Create directory for scan results -------------------------- 0.19s
2026-01-21 15:02:41.033054 | controller | INFO     Running default > cleanup
2026-01-21 15:02:41.033506 | controller | WARNING  Skipping, cleanup playbook not configured.
2026-01-21 15:02:41.034163 | controller | INFO     Writing /tmp/report.html report.
2026-01-21 15:02:41.276519 | controller | changed
2026-01-21 15:02:41.302954 | 
2026-01-21 15:02:41.303035 | PLAY RECAP
2026-01-21 15:02:41.303076 | controller | ok: 4 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-01-21 15:02:41.303098 | 
2026-01-21 15:02:41.379836 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-01-21 15:02:41.380782 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-01-21 15:02:41.933149 | 
2026-01-21 15:02:41.933287 | PLAY [Run ci/playbooks/collect-logs.yml]
2026-01-21 15:02:41.954149 | 
2026-01-21 15:02:41.954293 | TASK [Filter out host if needed]
2026-01-21 15:02:41.962953 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2026-01-21 15:02:41.967591 | 
2026-01-21 15:02:41.967661 | TASK [Ensure file is present]
2026-01-21 15:02:42.270259 | controller | ok
2026-01-21 15:02:42.276873 | 
2026-01-21 15:02:42.276957 | TASK [Manage molecule report file]
2026-01-21 15:02:42.802730 | controller | changed
2026-01-21 15:02:42.808869 | 
2026-01-21 15:02:42.808956 | TASK [Check if we get ci-framework-data basedir]
2026-01-21 15:02:43.020321 | controller | ok
2026-01-21 15:02:43.025461 | 
2026-01-21 15:02:43.025541 | TASK [Create ci-framework-data log directory for zuul]
2026-01-21 15:02:43.368684 | controller | changed
2026-01-21 15:02:43.373848 | 
2026-01-21 15:02:43.373918 | TASK [Copy ci-framework interesting files]
2026-01-21 15:02:43.896997 | controller | changed
2026-01-21 15:02:43.902412 | 
2026-01-21 15:02:43.902504 | TASK [Get SELinux listing]
2026-01-21 15:02:44.424948 | controller | changed
2026-01-21 15:02:44.430797 | 
2026-01-21 15:02:44.430874 | TASK [Generate log index]
2026-01-21 15:02:45.090490 | controller | changed
2026-01-21 15:02:45.095622 | 
2026-01-21 15:02:45.095711 | TASK [Get some env related data]
2026-01-21 15:02:45.625914 | controller | /home/zuul/.local/bin/ansible
2026-01-21 15:02:46.622133 | controller | changed
2026-01-21 15:02:46.628206 | 
2026-01-21 15:02:46.628300 | TASK [Generate list of logs to collect in home directory]
2026-01-21 15:02:46.955563 | controller | ok: All paths examined
2026-01-21 15:02:46.961015 | 
2026-01-21 15:02:46.961134 | LOOP [Copy logs from home directory]
2026-01-21 15:02:47.284530 | controller | changed:
2026-01-21 15:02:47.284648 | controller | {
2026-01-21 15:02:47.284676 | controller |   "atime": 1769007692.2779691,
2026-01-21 15:02:47.284696 | controller |   "ctime": 1769007709.16815,
2026-01-21 15:02:47.284714 | controller |   "dev": 64513,
2026-01-21 15:02:47.284730 | controller |   "gid": 1000,
2026-01-21 15:02:47.284746 | controller |   "gr_name": "zuul",
2026-01-21 15:02:47.284762 | controller |   "inode": 4333997,
2026-01-21 15:02:47.284780 | controller |   "isblk": false,
2026-01-21 15:02:47.284795 | controller |   "ischr": false,
2026-01-21 15:02:47.284810 | controller |   "isdir": false,
2026-01-21 15:02:47.284824 | controller |   "isfifo": false,
2026-01-21 15:02:47.284839 | controller |   "isgid": false,
2026-01-21 15:02:47.284855 | controller |   "islnk": false,
2026-01-21 15:02:47.284871 | controller |   "isreg": true,
2026-01-21 15:02:47.284885 | controller |   "issock": false,
2026-01-21 15:02:47.284900 | controller |   "isuid": false,
2026-01-21 15:02:47.284913 | controller |   "mode": "0644",
2026-01-21 15:02:47.284927 | controller |   "mtime": 1769007709.16815,
2026-01-21 15:02:47.284941 | controller |   "nlink": 1,
2026-01-21 15:02:47.284954 | controller |   "path": "/home/zuul/ansible.log",
2026-01-21 15:02:47.284973 | controller |   "pw_name": "zuul",
2026-01-21 15:02:47.284991 | controller |   "rgrp": true,
2026-01-21 15:02:47.285006 | controller |   "roth": true,
2026-01-21 15:02:47.285021 | controller |   "rusr": true,
2026-01-21 15:02:47.285036 | controller |   "size": 6749,
2026-01-21 15:02:47.285050 | controller |   "uid": 1000,
2026-01-21 15:02:47.285065 | controller |   "wgrp": false,
2026-01-21 15:02:47.285079 | controller |   "woth": false,
2026-01-21 15:02:47.285093 | controller |   "wusr": true,
2026-01-21 15:02:47.285109 | controller |   "xgrp": false,
2026-01-21 15:02:47.285124 | controller |   "xoth": false,
2026-01-21 15:02:47.285139 | controller |   "xusr": false
2026-01-21 15:02:47.285164 | controller | }
2026-01-21 15:02:47.298964 | 
2026-01-21 15:02:47.299307 | TASK [Copy crio stats log file]
2026-01-21 15:02:47.323797 | controller | skipping: Conditional result was False
2026-01-21 15:02:47.329291 | 
2026-01-21 15:02:47.329362 | TASK [Get SELinux related data]
2026-01-21 15:02:47.532002 | controller | <no matches>
2026-01-21 15:02:47.856982 | controller | ERROR
2026-01-21 15:02:47.857339 | controller | {
2026-01-21 15:02:47.857394 | controller |   "delta": "0:00:00.009182",
2026-01-21 15:02:47.857421 | controller |   "end": "2026-01-21 15:02:47.533113",
2026-01-21 15:02:47.857441 | controller |   "msg": "non-zero return code",
2026-01-21 15:02:47.857458 | controller |   "rc": 1,
2026-01-21 15:02:47.857474 | controller |   "start": "2026-01-21 15:02:47.523931"
2026-01-21 15:02:47.857724 | controller | }
2026-01-21 15:02:47.857763 | controller | ERROR: Ignoring Errors
2026-01-21 15:02:47.863465 | 
2026-01-21 15:02:47.863544 | TASK [Create system configuration directory]
2026-01-21 15:02:48.045365 | controller | changed
2026-01-21 15:02:48.050598 | 
2026-01-21 15:02:48.050686 | TASK [Get some of the system configurations]
2026-01-21 15:02:48.577731 | controller | changed
2026-01-21 15:02:48.583555 | 
2026-01-21 15:02:48.583639 | TASK [Copy generated documentation if available]
2026-01-21 15:02:48.597176 | controller | skipping: Conditional result was False
2026-01-21 15:02:48.603533 | 
2026-01-21 15:02:48.603618 | TASK [Copy generated AsciiDoc documentation if available]
2026-01-21 15:02:48.619926 | controller | skipping: Conditional result was False
2026-01-21 15:02:48.626580 | 
2026-01-21 15:02:48.626763 | TASK [Compress logs bigger than 2MB]
2026-01-21 15:02:49.153615 | controller | changed
2026-01-21 15:02:49.159761 | 
2026-01-21 15:02:49.159849 | TASK [Copy files from workspace on node]
2026-01-21 15:02:49.178485 | controller | ok
2026-01-21 15:02:49.202439 | 
2026-01-21 15:02:49.202525 | TASK [fetch-output : Set log path for multiple nodes]
2026-01-21 15:02:49.216308 | controller | skipping: Conditional result was False
2026-01-21 15:02:49.222729 | 
2026-01-21 15:02:49.222810 | TASK [fetch-output : Set log path for single node]
2026-01-21 15:02:49.254861 | controller | ok
2026-01-21 15:02:49.261819 | 
2026-01-21 15:02:49.261895 | LOOP [fetch-output : Ensure local output dirs]
2026-01-21 15:02:49.476133 | controller -> localhost | ok: "/var/lib/zuul/builds/048562c1260c475890de1086a113b87b/work/logs"
2026-01-21 15:02:49.476405 | controller -> localhost | changed: All items complete
2026-01-21 15:02:49.476442 | 
2026-01-21 15:02:49.665164 | controller -> localhost | changed: "/var/lib/zuul/builds/048562c1260c475890de1086a113b87b/work/artifacts"
2026-01-21 15:02:49.846450 | controller -> localhost | changed: "/var/lib/zuul/builds/048562c1260c475890de1086a113b87b/work/docs"
2026-01-21 15:02:49.861877 | 
2026-01-21 15:02:49.861987 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-01-21 15:02:50.403889 | controller | changed:
2026-01-21 15:02:50.404070 | controller | .d..t...... ./
2026-01-21 15:02:50.404100 | controller | >f+++++++++ README.html
2026-01-21 15:02:50.404123 | controller | >f+++++++++ ansible-execution.log
2026-01-21 15:02:50.404143 | controller | >f+++++++++ ansible.log
2026-01-21 15:02:50.404178 | controller | >f+++++++++ dmesg.log
2026-01-21 15:02:50.404205 | controller | >f+++++++++ installed-pkgs.log
2026-01-21 15:02:50.404224 | controller | >f+++++++++ python.log
2026-01-21 15:02:50.404244 | controller | >f+++++++++ registries.conf
2026-01-21 15:02:50.404282 | controller | >f+++++++++ report.html
2026-01-21 15:02:50.404309 | controller | >f+++++++++ selinux-denials.log
2026-01-21 15:02:50.404330 | controller | >f+++++++++ selinux-listing.log
2026-01-21 15:02:50.404347 | controller | cd+++++++++ ci-framework-data/
2026-01-21 15:02:50.404363 | controller | cd+++++++++ ci-framework-data/artifacts/
2026-01-21 15:02:50.404380 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2026-01-21 15:02:50.404396 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2026-01-21 15:02:50.404412 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2026-01-21 15:02:50.404428 | controller | cd+++++++++ ci-framework-data/logs/
2026-01-21 15:02:50.404444 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2026-01-21 15:02:50.404460 | controller | cd+++++++++ ci-framework-data/tests/
2026-01-21 15:02:50.404475 | controller | cd+++++++++ ci-framework-data/tests/compliance/
2026-01-21 15:02:50.404490 | controller | cd+++++++++ ci-framework-data/tests/compliance/cis/
2026-01-21 15:02:50.404505 | controller | cd+++++++++ ci-framework-data/tests/compliance/cis/ocp4-cis/
2026-01-21 15:02:50.404520 | controller | cd+++++++++ ci-framework-data/tests/compliance/e8/
2026-01-21 15:02:50.404536 | controller | cd+++++++++ ci-framework-data/tests/compliance/e8/ocp4-e8/
2026-01-21 15:02:50.404552 | controller | cd+++++++++ ci-framework-data/tests/compliance/e8/rhcos4-e8/
2026-01-21 15:02:50.404568 | controller | cd+++++++++ ci-framework-data/tests/compliance/high/
2026-01-21 15:02:50.404585 | controller | cd+++++++++ ci-framework-data/tests/compliance/high/ocp4-high-node/
2026-01-21 15:02:50.404600 | controller | cd+++++++++ ci-framework-data/tests/compliance/high/ocp4-high/
2026-01-21 15:02:50.404616 | controller | cd+++++++++ ci-framework-data/tests/compliance/high/rhcos4-high/
2026-01-21 15:02:50.404632 | controller | cd+++++++++ ci-framework-data/tests/compliance/moderate/
2026-01-21 15:02:50.404647 | controller | cd+++++++++ ci-framework-data/tests/compliance/moderate/ocp4-moderate-node/
2026-01-21 15:02:50.404662 | controller | cd+++++++++ ci-framework-data/tests/compliance/moderate/ocp4-moderate/
2026-01-21 15:02:50.404677 | controller | cd+++++++++ ci-framework-data/tests/compliance/moderate/rhcos4-moderate/
2026-01-21 15:02:50.404692 | controller | cd+++++++++ ci-framework-data/tests/compliance/nerc-cip/
2026-01-21 15:02:50.404708 | controller | cd+++++++++ ci-framework-data/tests/compliance/nerc-cip/ocp4-nerc-cip-node/
2026-01-21 15:02:50.404723 | controller | cd+++++++++ ci-framework-data/tests/compliance/nerc-cip/ocp4-nerc-cip/
2026-01-21 15:02:50.404738 | controller | cd+++++++++ ci-framework-data/tests/compliance/pci-dss/
2026-01-21 15:02:50.404753 | controller | cd+++++++++ ci-framework-data/tests/compliance/pci-dss/ocp4-pci-dss-node/
2026-01-21 15:02:50.404767 | controller | cd+++++++++ ci-framework-data/tests/compliance/pci-dss/ocp4-pci-dss/
2026-01-21 15:02:50.404782 | controller | cd+++++++++ ci-framework-data/tests/compliance/stig/
2026-01-21 15:02:50.404796 | controller | cd+++++++++ ci-framework-data/tests/compliance/stig/ocp4-stig-node/
2026-01-21 15:02:50.404811 | controller | cd+++++++++ ci-framework-data/tests/compliance/stig/ocp4-stig/
2026-01-21 15:02:50.404825 | controller | cd+++++++++ ci-framework-data/tests/compliance/stig/rhcos4-stig/
2026-01-21 15:02:50.404839 | controller | cd+++++++++ registries.conf.d/
2026-01-21 15:02:50.404854 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2026-01-21 15:02:50.404868 | controller | cd+++++++++ system-config/
2026-01-21 15:02:50.404882 | controller | cd+++++++++ system-config/libvirt/
2026-01-21 15:02:50.404896 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2026-01-21 15:02:50.404910 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2026-01-21 15:02:50.787068 | controller | changed: .d..t...... ./
2026-01-21 15:02:51.153395 | controller | changed: .d..t...... ./
2026-01-21 15:02:51.175614 | 
2026-01-21 15:02:51.175733 | TASK [Return artifact to Zuul]
2026-01-21 15:02:51.204981 | controller | ok
2026-01-21 15:02:51.225182 | 
2026-01-21 15:02:51.225260 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2026-01-21 15:02:51.225385 | 
2026-01-21 15:02:51.225414 | PLAY RECAP
2026-01-21 15:02:51.225450 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2026-01-21 15:02:51.225471 | 
2026-01-21 15:02:51.313007 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-01-21 15:02:51.313777 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-01-21 15:02:51.858284 | 
2026-01-21 15:02:51.858392 | PLAY [all]
2026-01-21 15:02:51.878117 | 
2026-01-21 15:02:51.878212 | TASK [include_role : fetch-output]
2026-01-21 15:02:51.906372 | controller | ok
2026-01-21 15:02:51.923708 | 
2026-01-21 15:02:51.923826 | TASK [fetch-output : Set log path for multiple nodes]
2026-01-21 15:02:51.967776 | controller | skipping: Conditional result was False
2026-01-21 15:02:51.973587 | 
2026-01-21 15:02:51.973677 | TASK [fetch-output : Set log path for single node]
2026-01-21 15:02:52.001638 | controller | ok
2026-01-21 15:02:52.006932 | 
2026-01-21 15:02:52.007011 | LOOP [fetch-output : Ensure local output dirs]
2026-01-21 15:02:52.339381 | controller -> localhost | ok: "/var/lib/zuul/builds/048562c1260c475890de1086a113b87b/work/logs"
2026-01-21 15:02:52.552336 | controller -> localhost | ok: "/var/lib/zuul/builds/048562c1260c475890de1086a113b87b/work/artifacts"
2026-01-21 15:02:52.757450 | controller -> localhost | ok: "/var/lib/zuul/builds/048562c1260c475890de1086a113b87b/work/docs"
2026-01-21 15:02:52.769245 | 
2026-01-21 15:02:52.769358 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-01-21 15:02:53.306653 | controller | ok
2026-01-21 15:02:53.306849 | controller | ok: All items complete
2026-01-21 15:02:53.306881 | 
2026-01-21 15:02:53.694763 | controller | ok
2026-01-21 15:02:54.111202 | controller | ok
2026-01-21 15:02:54.123647 | 
2026-01-21 15:02:54.123749 | TASK [include_role : fetch-output-openshift]
2026-01-21 15:02:54.137008 | controller | skipping: Conditional result was False
2026-01-21 15:02:54.143594 | 
2026-01-21 15:02:54.143669 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-01-21 15:02:54.497895 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006048
2026-01-21 15:02:54.690783 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006027
2026-01-21 15:02:54.719035 | 
2026-01-21 15:02:54.719139 | PLAY [all]
2026-01-21 15:02:54.733537 | 
2026-01-21 15:02:54.733609 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-01-21 15:02:55.148495 | controller | changed
2026-01-21 15:02:55.173367 | 
2026-01-21 15:02:55.173444 | PLAY RECAP
2026-01-21 15:02:55.173495 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-01-21 15:02:55.173520 | 
2026-01-21 15:02:55.252071 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-01-21 15:02:55.252845 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2026-01-21 15:02:55.825042 | 
2026-01-21 15:02:55.825162 | PLAY [localhost]
2026-01-21 15:02:55.843381 | 
2026-01-21 15:02:55.843464 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-01-21 15:02:56.175896 | localhost | changed
2026-01-21 15:02:56.180827 | 
2026-01-21 15:02:56.180932 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-01-21 15:02:56.209360 | localhost | ok
2026-01-21 15:02:56.217752 | 
2026-01-21 15:02:56.217842 | TASK [add-fileserver : Create SSH private key tempfile]
2026-01-21 15:02:56.561002 | localhost | changed
2026-01-21 15:02:56.567077 | 
2026-01-21 15:02:56.567165 | TASK [add-fileserver : Create SSH private key from secret]
2026-01-21 15:02:57.152501 | localhost | changed
2026-01-21 15:02:57.157548 | 
2026-01-21 15:02:57.157693 | TASK [add-fileserver : Add fileserver ssh key]
2026-01-21 15:02:57.530213 | localhost | Identity added: /var/lib/zuul/builds/048562c1260c475890de1086a113b87b/work/tmp/ansible.onph5_2t (/var/lib/zuul/builds/048562c1260c475890de1086a113b87b/work/tmp/ansible.onph5_2t)
2026-01-21 15:02:57.530404 | localhost | ok: Runtime: 0:00:00.006335
2026-01-21 15:02:57.535261 | 
2026-01-21 15:02:57.535350 | TASK [add-fileserver : Remove SSH private key from disk]
2026-01-21 15:02:57.786629 | localhost | ok: Runtime: 0:00:00.004743
2026-01-21 15:02:57.791674 | 
2026-01-21 15:02:57.791767 | TASK [add-fileserver : Add fileserver to inventory]
2026-01-21 15:02:57.841627 | localhost | changed
2026-01-21 15:02:57.845810 | 
2026-01-21 15:02:57.845902 | TASK [add-fileserver : Add fileserver server to known hosts]
2026-01-21 15:02:58.188515 | localhost | changed
2026-01-21 15:02:58.208669 | 
2026-01-21 15:02:58.208793 | PLAY [localhost]
2026-01-21 15:02:58.221346 | 
2026-01-21 15:02:58.221434 | TASK [Generate bulk log download script]
2026-01-21 15:02:58.239958 | localhost | ok
2026-01-21 15:02:58.252627 | 
2026-01-21 15:02:58.252733 | TASK [local-log-download : Check API endpoint is defined]
2026-01-21 15:02:58.281469 | localhost | ok: All assertions passed
2026-01-21 15:02:58.287236 | 
2026-01-21 15:02:58.287341 | TASK [local-log-download : Create download script]
2026-01-21 15:02:58.687618 | localhost -> localhost | changed
2026-01-21 15:02:58.696617 | 
2026-01-21 15:02:58.696701 | TASK [Register quick-download link]
2026-01-21 15:02:58.715606 | localhost | ok
2026-01-21 15:02:58.756780 | 
2026-01-21 15:02:58.756888 | PLAY [logserver.rdoproject.org]
2026-01-21 15:02:58.769533 | 
2026-01-21 15:02:58.769601 | TASK [Set zuul-log-path fact]
2026-01-21 15:02:58.787088 | logserver.rdoproject.org | ok
2026-01-21 15:02:58.799453 | 
2026-01-21 15:02:58.799536 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-01-21 15:02:58.817379 | logserver.rdoproject.org | ok
2026-01-21 15:02:58.822810 | 
2026-01-21 15:02:58.823004 | TASK [upload-logs : Create log directories]
2026-01-21 15:03:01.667318 | logserver.rdoproject.org | changed
2026-01-21 15:03:01.670787 | 
2026-01-21 15:03:01.670864 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-01-21 15:03:01.908408 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.005929
2026-01-21 15:03:01.913758 | 
2026-01-21 15:03:01.913826 | TASK [upload-logs : Upload logs to log server]
2026-01-21 15:03:03.362280 | logserver.rdoproject.org | Output suppressed because no_log was given
2026-01-21 15:03:03.366447 | 
2026-01-21 15:03:03.366519 | LOOP [upload-logs : Compress console log and json output]
2026-01-21 15:03:03.408224 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-21 15:03:03.417511 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-21 15:03:03.424902 | 
2026-01-21 15:03:03.425017 | LOOP [upload-logs : Upload compressed console log and json output]
2026-01-21 15:03:03.467189 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-21 15:03:03.467427 | 
2026-01-21 15:03:03.470773 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-21 15:03:03.484050 | 
2026-01-21 15:03:03.484179 | LOOP [upload-logs : Upload console log and json output]