2025-10-13 10:33:36.247535 | Job console starting...
2025-10-13 10:33:36.664244 | Updating repositories
2025-10-13 10:33:37.540542 | Preparing job workspace
2025-10-13 10:33:53.677940 | Running Ansible setup...
2025-10-13 10:34:01.356092 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-13 10:34:03.261447 | 
2025-10-13 10:34:03.261547 | PLAY [localhost]
2025-10-13 10:34:03.291285 | 
2025-10-13 10:34:03.291363 | TASK [Gathering Facts]
2025-10-13 10:34:04.915324 | localhost | ok
2025-10-13 10:34:04.955086 | 
2025-10-13 10:34:04.955236 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-10-13 10:34:06.551269 | localhost -> localhost | changed
2025-10-13 10:34:06.557206 | 
2025-10-13 10:34:06.557297 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-10-13 10:34:08.153368 | localhost -> localhost | changed
2025-10-13 10:34:08.167808 | 
2025-10-13 10:34:08.167881 | TASK [Setup log path fact]
2025-10-13 10:34:08.212112 | localhost | ok
2025-10-13 10:34:08.240251 | 
2025-10-13 10:34:08.240326 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-13 10:34:08.299638 | localhost | ok
2025-10-13 10:34:08.308636 | 
2025-10-13 10:34:08.308707 | TASK [emit-job-header : Print job information]
2025-10-13 10:34:08.409189 | # Job Information
2025-10-13 10:34:08.409329 | Ansible Version: 2.15.12
2025-10-13 10:34:08.409361 | Job: cifmw-molecule-compliance
2025-10-13 10:34:08.409384 | Pipeline: github-check
2025-10-13 10:34:08.409405 | Executor: ibm-bm4-ze.softwarefactory-project.io
2025-10-13 10:34:08.409424 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3402
2025-10-13 10:34:08.409444 | Log URL (when completed): https://logserver.rdoproject.org/c80/rdoproject.org/c8032caa3f61452c9996978080f07825/
2025-10-13 10:34:08.409463 | Event ID: c3280dc0-a81f-11f0-8d33-e350c072644d
2025-10-13 10:34:08.413063 | 
2025-10-13 10:34:08.413133 | LOOP [emit-job-header : Print node information]
2025-10-13 10:34:08.805124 | localhost | ok:
2025-10-13 10:34:08.805331 | localhost | # Node Information
2025-10-13 10:34:08.805363 | localhost | Inventory Hostname: controller
2025-10-13 10:34:08.805389 | localhost | Hostname: np0005483637
2025-10-13 10:34:08.805413 | localhost | Username: zuul
2025-10-13 10:34:08.805435 | localhost | Distro: CentOS 9
2025-10-13 10:34:08.805456 | localhost | Provider: ibm-bm4-nodepool
2025-10-13 10:34:08.805476 | localhost | Region: regionOne
2025-10-13 10:34:08.805494 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2025-10-13 10:34:08.805513 | localhost | Product Name: OpenStack Compute
2025-10-13 10:34:08.805532 | localhost | Interface IP: 192.168.26.61
2025-10-13 10:34:08.872280 | 
2025-10-13 10:34:08.872372 | PLAY [all]
2025-10-13 10:34:08.896647 | 
2025-10-13 10:34:08.896743 | TASK [Gather network facts]
2025-10-13 10:34:09.351709 | controller | ok
2025-10-13 10:34:09.378761 | 
2025-10-13 10:34:09.378847 | TASK [include_role : start-zuul-console]
2025-10-13 10:34:09.421877 | controller | ok
2025-10-13 10:34:09.440645 | 
2025-10-13 10:34:09.440733 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-10-13 10:34:10.209580 | controller | ok
2025-10-13 10:34:10.226160 | 
2025-10-13 10:34:10.226225 | TASK [include_role : add-build-sshkey]
2025-10-13 10:34:10.303179 | controller | ok
2025-10-13 10:34:10.346494 | 
2025-10-13 10:34:10.346573 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-13 10:34:11.257591 | controller -> localhost | ok
2025-10-13 10:34:11.263074 | 
2025-10-13 10:34:11.263149 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-13 10:34:11.385772 | controller | ok
2025-10-13 10:34:11.431245 | controller | included: /var/lib/zuul/builds/c8032caa3f61452c9996978080f07825/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-13 10:34:11.462752 | 
2025-10-13 10:34:11.462841 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-13 10:34:12.780216 | controller -> localhost | Generating public/private rsa key pair.
2025-10-13 10:34:12.780417 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/c8032caa3f61452c9996978080f07825/work/c8032caa3f61452c9996978080f07825_id_rsa.
2025-10-13 10:34:12.780454 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/c8032caa3f61452c9996978080f07825/work/c8032caa3f61452c9996978080f07825_id_rsa.pub.
2025-10-13 10:34:12.780479 | controller -> localhost | The key fingerprint is:
2025-10-13 10:34:12.780501 | controller -> localhost | SHA256:0pdSi48I/fFPOSB/aXvpmZc/XXc9gzerCSWkqqNmSwk zuul-build-sshkey
2025-10-13 10:34:12.780520 | controller -> localhost | The key's randomart image is:
2025-10-13 10:34:12.780538 | controller -> localhost | +---[RSA 3072]----+
2025-10-13 10:34:12.780557 | controller -> localhost | |                 |
2025-10-13 10:34:12.780575 | controller -> localhost | |                 |
2025-10-13 10:34:12.780593 | controller -> localhost | |          ..     |
2025-10-13 10:34:12.780624 | controller -> localhost | |     . . ooo     |
2025-10-13 10:34:12.780644 | controller -> localhost | | E  . o S.=. .. .|
2025-10-13 10:34:12.780662 | controller -> localhost | |  . .. +.X .o+ ==|
2025-10-13 10:34:12.780679 | controller -> localhost | |   o  ..o +.B ..@|
2025-10-13 10:34:12.780699 | controller -> localhost | |  .o ..    =.o+*o|
2025-10-13 10:34:12.780717 | controller -> localhost | |  ooo..     o==.+|
2025-10-13 10:34:12.780735 | controller -> localhost | +----[SHA256]-----+
2025-10-13 10:34:12.780780 | controller -> localhost | ok: Runtime: 0:00:00.139118
2025-10-13 10:34:12.786609 | 
2025-10-13 10:34:12.786681 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-13 10:34:12.892687 | controller | ok
2025-10-13 10:34:12.943390 | controller | included: /var/lib/zuul/builds/c8032caa3f61452c9996978080f07825/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-13 10:34:12.970834 | 
2025-10-13 10:34:12.970959 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-13 10:34:13.029751 | controller | skipping: Conditional result was False
2025-10-13 10:34:13.042176 | 
2025-10-13 10:34:13.042260 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-13 10:34:13.811717 | controller | changed
2025-10-13 10:34:13.816884 | 
2025-10-13 10:34:13.816969 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-13 10:34:14.082476 | controller | ok
2025-10-13 10:34:14.087811 | 
2025-10-13 10:34:14.087888 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-13 10:34:14.982942 | controller | changed
2025-10-13 10:34:14.988075 | 
2025-10-13 10:34:14.988139 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-13 10:34:15.846471 | controller | changed
2025-10-13 10:34:15.851583 | 
2025-10-13 10:34:15.851657 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-13 10:34:15.951347 | controller | skipping: Conditional result was False
2025-10-13 10:34:15.956874 | 
2025-10-13 10:34:15.956955 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-13 10:34:17.098111 | controller -> localhost | changed
2025-10-13 10:34:17.117483 | 
2025-10-13 10:34:17.117554 | TASK [add-build-sshkey : Add back temp key]
2025-10-13 10:34:17.829265 | controller -> localhost | Identity added: /var/lib/zuul/builds/c8032caa3f61452c9996978080f07825/work/c8032caa3f61452c9996978080f07825_id_rsa (zuul-build-sshkey)
2025-10-13 10:34:17.829451 | controller -> localhost | ok: Runtime: 0:00:00.032172
2025-10-13 10:34:17.836486 | 
2025-10-13 10:34:17.836551 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-13 10:34:18.370718 | controller | ok
2025-10-13 10:34:18.375614 | 
2025-10-13 10:34:18.375677 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-13 10:34:18.443247 | controller | skipping: Conditional result was False
2025-10-13 10:34:18.453611 | 
2025-10-13 10:34:18.453692 | TASK [include_role : validate-host]
2025-10-13 10:34:18.537560 | controller | ok
2025-10-13 10:34:18.604608 | 
2025-10-13 10:34:18.604694 | TASK [validate-host : Define zuul_info_dir fact]
2025-10-13 10:34:18.721828 | controller | ok
2025-10-13 10:34:18.732575 | 
2025-10-13 10:34:18.732653 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-10-13 10:34:19.546504 | controller -> localhost | ok
2025-10-13 10:34:19.552161 | 
2025-10-13 10:34:19.552226 | TASK [validate-host : Collect information about the host]
2025-10-13 10:34:20.213463 | controller | ok
2025-10-13 10:34:20.250830 | 
2025-10-13 10:34:20.250946 | TASK [validate-host : Sanitize hostname]
2025-10-13 10:34:20.356555 | controller | ok
2025-10-13 10:34:20.361945 | 
2025-10-13 10:34:20.362025 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-10-13 10:34:22.076612 | controller -> localhost | changed
2025-10-13 10:34:22.082349 | 
2025-10-13 10:34:22.082416 | TASK [validate-host : Collect information about zuul worker]
2025-10-13 10:34:22.899389 | controller | ok
2025-10-13 10:34:22.912976 | 
2025-10-13 10:34:22.913061 | TASK [validate-host : Write out all zuul information for each host]
2025-10-13 10:34:24.327656 | controller -> localhost | changed
2025-10-13 10:34:24.347258 | 
2025-10-13 10:34:24.347339 | TASK [include_role : prepare-workspace-openshift]
2025-10-13 10:34:24.393636 | controller | skipping: Conditional result was False
2025-10-13 10:34:24.399343 | 
2025-10-13 10:34:24.399417 | TASK [include_role : remove-zuul-sshkey]
2025-10-13 10:34:24.483094 | controller | skipping: Conditional result was False
2025-10-13 10:34:24.488963 | 
2025-10-13 10:34:24.489054 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-13 10:34:24.796606 | controller | ok: "logs"
2025-10-13 10:34:24.796821 | controller | ok: All items complete
2025-10-13 10:34:24.796851 | 
2025-10-13 10:34:24.970594 | controller | ok: "artifacts"
2025-10-13 10:34:25.189270 | controller | ok: "docs"
2025-10-13 10:34:25.209393 | 
2025-10-13 10:34:25.209476 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-13 10:34:25.544944 | controller | changed: "logs"
2025-10-13 10:34:25.747421 | controller | changed: "artifacts"
2025-10-13 10:34:25.959610 | controller | changed: "docs"
2025-10-13 10:34:26.032804 | 
2025-10-13 10:34:26.032882 | PLAY RECAP
2025-10-13 10:34:26.032947 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-13 10:34:26.032980 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-13 10:34:26.033006 | 
2025-10-13 10:34:26.426270 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-13 10:34:26.427171 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-13 10:34:28.496761 | 
2025-10-13 10:34:28.496875 | PLAY [all]
2025-10-13 10:34:28.572001 | 
2025-10-13 10:34:28.572106 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-13 10:34:28.746296 | controller | ok
2025-10-13 10:34:28.754634 | 
2025-10-13 10:34:28.754716 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-13 10:34:29.343481 | controller | changed
2025-10-13 10:34:29.349058 | 
2025-10-13 10:34:29.349134 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-13 10:34:31.636833 | controller | changed
2025-10-13 10:34:31.658096 | 
2025-10-13 10:34:31.658188 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-10-13 10:34:32.450026 | controller | changed:
2025-10-13 10:34:32.450183 | controller | {
2025-10-13 10:34:32.450218 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-10-13 10:34:32.450248 | controller | }
2025-10-13 10:34:32.694051 | controller | changed:
2025-10-13 10:34:32.694133 | controller | {
2025-10-13 10:34:32.694175 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-10-13 10:34:32.694200 | controller | }
2025-10-13 10:34:32.918190 | controller | changed:
2025-10-13 10:34:32.918274 | controller | {
2025-10-13 10:34:32.918301 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2025-10-13 10:34:32.918323 | controller | }
2025-10-13 10:34:33.142789 | controller | changed:
2025-10-13 10:34:33.143174 | controller | {
2025-10-13 10:34:33.143213 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-10-13 10:34:33.143239 | controller | }
2025-10-13 10:34:33.370096 | controller | changed:
2025-10-13 10:34:33.370181 | controller | {
2025-10-13 10:34:33.370208 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-10-13 10:34:33.370229 | controller | }
2025-10-13 10:34:33.606889 | controller | changed:
2025-10-13 10:34:33.606993 | controller | {
2025-10-13 10:34:33.607021 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-10-13 10:34:33.607043 | controller | }
2025-10-13 10:34:33.863197 | controller | changed:
2025-10-13 10:34:33.863276 | controller | {
2025-10-13 10:34:33.863306 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen"
2025-10-13 10:34:33.863329 | controller | }
2025-10-13 10:34:34.131246 | controller | changed:
2025-10-13 10:34:34.131407 | controller | {
2025-10-13 10:34:34.131445 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora"
2025-10-13 10:34:34.131470 | controller | }
2025-10-13 10:34:34.528129 | controller | changed:
2025-10-13 10:34:34.528219 | controller | {
2025-10-13 10:34:34.528249 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-10-13 10:34:34.528271 | controller | }
2025-10-13 10:34:34.673873 | controller | changed:
2025-10-13 10:34:34.673973 | controller | {
2025-10-13 10:34:34.674005 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-10-13 10:34:34.674027 | controller | }
2025-10-13 10:34:34.884483 | controller | changed:
2025-10-13 10:34:34.884561 | controller | {
2025-10-13 10:34:34.884588 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-10-13 10:34:34.884620 | controller | }
2025-10-13 10:34:35.111974 | controller | changed:
2025-10-13 10:34:35.112075 | controller | {
2025-10-13 10:34:35.112112 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-10-13 10:34:35.112135 | controller | }
2025-10-13 10:34:35.366016 | controller | changed:
2025-10-13 10:34:35.366153 | controller | {
2025-10-13 10:34:35.366183 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-10-13 10:34:35.366205 | controller | }
2025-10-13 10:34:35.622955 | controller | changed:
2025-10-13 10:34:35.623032 | controller | {
2025-10-13 10:34:35.623061 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-10-13 10:34:35.623083 | controller | }
2025-10-13 10:34:35.869690 | controller | changed:
2025-10-13 10:34:35.869775 | controller | {
2025-10-13 10:34:35.869803 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-10-13 10:34:35.869891 | controller | }
2025-10-13 10:34:36.110207 | controller | changed:
2025-10-13 10:34:36.110294 | controller | {
2025-10-13 10:34:36.110324 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-10-13 10:34:36.110346 | controller | }
2025-10-13 10:34:36.358732 | controller | changed:
2025-10-13 10:34:36.358817 | controller | {
2025-10-13 10:34:36.358853 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com"
2025-10-13 10:34:36.358882 | controller | }
2025-10-13 10:34:36.635128 | controller | changed:
2025-10-13 10:34:36.635207 | controller | {
2025-10-13 10:34:36.635235 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb"
2025-10-13 10:34:36.635267 | controller | }
2025-10-13 10:34:36.868697 | controller | changed:
2025-10-13 10:34:36.868774 | controller | {
2025-10-13 10:34:36.868803 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-10-13 10:34:36.868825 | controller | }
2025-10-13 10:34:37.110432 | controller | changed:
2025-10-13 10:34:37.110520 | controller | {
2025-10-13 10:34:37.110549 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-10-13 10:34:37.110572 | controller | }
2025-10-13 10:34:37.348458 | controller | changed:
2025-10-13 10:34:37.348532 | controller | {
2025-10-13 10:34:37.348560 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-10-13 10:34:37.348580 | controller | }
2025-10-13 10:34:37.596998 | controller | changed:
2025-10-13 10:34:37.597089 | controller | {
2025-10-13 10:34:37.597117 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-10-13 10:34:37.597140 | controller | }
2025-10-13 10:34:37.819995 | controller | changed:
2025-10-13 10:34:37.820071 | controller | {
2025-10-13 10:34:37.820099 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com"
2025-10-13 10:34:37.820121 | controller | }
2025-10-13 10:34:38.073463 | controller | changed:
2025-10-13 10:34:38.073538 | controller | {
2025-10-13 10:34:38.073564 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-10-13 10:34:38.073584 | controller | }
2025-10-13 10:34:38.350654 | controller | changed:
2025-10-13 10:34:38.350773 | controller | {
2025-10-13 10:34:38.350804 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-10-13 10:34:38.350828 | controller | }
2025-10-13 10:34:38.584160 | controller | changed:
2025-10-13 10:34:38.584236 | controller | {
2025-10-13 10:34:38.584263 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-10-13 10:34:38.584285 | controller | }
2025-10-13 10:34:38.640565 | 
2025-10-13 10:34:38.640680 | TASK [Set timezone to UTC]
2025-10-13 10:34:39.704041 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-10-13 10:34:39.709099 | 
2025-10-13 10:34:39.709165 | TASK [Create nodepool directory]
2025-10-13 10:34:39.980626 | controller | changed
2025-10-13 10:34:39.989330 | 
2025-10-13 10:34:39.989398 | TASK [Create nodepool sub_nodes file]
2025-10-13 10:34:40.830171 | controller | changed
2025-10-13 10:34:40.850925 | 
2025-10-13 10:34:40.851010 | TASK [Create nodepool sub_nodes_private file]
2025-10-13 10:34:41.613026 | controller | changed
2025-10-13 10:34:41.618959 | 
2025-10-13 10:34:41.626010 | LOOP [Populate nodepool sub_nodes file]
2025-10-13 10:34:41.717504 | 
2025-10-13 10:34:41.717652 | LOOP [Populate nodepool sub_nodes_private file]
2025-10-13 10:34:41.798657 | 
2025-10-13 10:34:41.798858 | TASK [Create nodepool primary file]
2025-10-13 10:34:41.917163 | controller | skipping: Conditional result was False
2025-10-13 10:34:41.922773 | 
2025-10-13 10:34:41.922852 | TASK [Create nodepool node_private for this node]
2025-10-13 10:34:42.784900 | controller | changed
2025-10-13 10:34:42.799657 | 
2025-10-13 10:34:42.799740 | LOOP [Copy ssh keys to nodepool directory]
2025-10-13 10:34:43.871235 | controller | ok: Item: id_rsa Runtime: 0:00:00.006296
2025-10-13 10:34:43.871414 | 
2025-10-13 10:34:44.108169 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.006251
2025-10-13 10:34:44.120174 | 
2025-10-13 10:34:44.120268 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-10-13 10:34:44.970170 | controller | changed
2025-10-13 10:34:44.979232 | 
2025-10-13 10:34:44.979301 | TASK [Validate sudoers config after edits]
2025-10-13 10:34:45.474767 | controller | /etc/sudoers: parsed OK
2025-10-13 10:34:45.474843 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-10-13 10:34:45.474854 | controller | /etc/sudoers.d/zuul: parsed OK
2025-10-13 10:34:45.474861 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-10-13 10:34:45.638274 | controller | ok: Runtime: 0:00:00.006057
2025-10-13 10:34:45.645009 | 
2025-10-13 10:34:45.645081 | TASK [Show the environment passed in to job shell scripts]
2025-10-13 10:34:46.059175 | controller | SHELL=/bin/bash
2025-10-13 10:34:46.059271 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2025-10-13 10:34:46.059284 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2025-10-13 10:34:46.059291 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/02/3402/c2e3cdb106c3c91ed9e4c69bd61e0ffd9bd88749
2025-10-13 10:34:46.059297 | controller | PWD=/home/zuul
2025-10-13 10:34:46.059303 | controller | ZUUL_PIPELINE=github-check
2025-10-13 10:34:46.059309 | controller | LOGNAME=zuul
2025-10-13 10:34:46.059314 | controller | XDG_SESSION_TYPE=tty
2025-10-13 10:34:46.059320 | controller | _=/usr/bin/env
2025-10-13 10:34:46.059325 | controller | MOTD_SHOWN=pam
2025-10-13 10:34:46.059331 | controller | HOME=/home/zuul
2025-10-13 10:34:46.059336 | controller | LANG=en_US.UTF-8
2025-10-13 10:34:46.059341 | controller | SSH_CONNECTION=192.168.26.12 48836 192.168.26.61 22
2025-10-13 10:34:46.059347 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET
2025-10-13 10:34:46.059355 | controller | ZUUL_CHANGE_IDS=3402,c2e3cdb106c3c91ed9e4c69bd61e0ffd9bd88749
2025-10-13 10:34:46.059361 | controller | WORKSPACE=/home/zuul/workspace
2025-10-13 10:34:46.059367 | controller | XDG_SESSION_CLASS=user
2025-10-13 10:34:46.059373 | controller | SELINUX_ROLE_REQUESTED=
2025-10-13 10:34:46.059378 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-10-13 10:34:46.059385 | controller | USER=zuul
2025-10-13 10:34:46.059390 | controller | ZUUL_VOTING=True
2025-10-13 10:34:46.059395 | controller | BUILD_TIMEOUT=1800000
2025-10-13 10:34:46.059400 | controller | SELINUX_USE_CURRENT_RANGE=
2025-10-13 10:34:46.059406 | controller | SHLVL=1
2025-10-13 10:34:46.059411 | controller | ZUUL_PATCHSET=c2e3cdb106c3c91ed9e4c69bd61e0ffd9bd88749
2025-10-13 10:34:46.059416 | controller | XDG_SESSION_ID=1
2025-10-13 10:34:46.059422 | controller | ZUUL_BRANCH=main
2025-10-13 10:34:46.059427 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-10-13 10:34:46.059432 | controller | SSH_CLIENT=192.168.26.12 48836 22
2025-10-13 10:34:46.059438 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-10-13 10:34:46.059443 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-10-13 10:34:46.059449 | controller | which_declare=declare -f
2025-10-13 10:34:46.059455 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-10-13 10:34:46.059461 | controller | SELINUX_LEVEL_REQUESTED=
2025-10-13 10:34:46.059466 | controller | ZUUL_CHANGE=3402
2025-10-13 10:34:46.059471 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-10-13 10:34:46.059477 | controller | ZUUL_UUID=c8032caa3f61452c9996978080f07825
2025-10-13 10:34:46.059482 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-10-13 10:34:46.059488 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-10-13 10:34:46.059493 | controller | }
2025-10-13 10:34:46.272497 | controller | ok: Runtime: 0:00:00.005583
2025-10-13 10:34:46.278565 | 
2025-10-13 10:34:46.278641 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-10-13 10:34:46.332838 | controller | skipping: Conditional result was False
2025-10-13 10:34:46.339493 | 
2025-10-13 10:34:46.339570 | TASK [Symlink /home/zuul-worker/workspace]
2025-10-13 10:34:47.090674 | controller | skipping: Conditional result was False
2025-10-13 10:34:47.098067 | 
2025-10-13 10:34:47.098136 | TASK [Ensure legacy workspace directory]
2025-10-13 10:34:47.454575 | controller | changed
2025-10-13 10:34:47.543373 | 
2025-10-13 10:34:47.543473 | PLAY RECAP
2025-10-13 10:34:47.543524 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-13 10:34:47.543548 | 
2025-10-13 10:34:47.950832 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-13 10:34:47.951587 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-13 10:34:50.503938 | 
2025-10-13 10:34:50.504068 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2025-10-13 10:34:50.602057 | 
2025-10-13 10:34:50.602185 | TASK [Create zuul-output directory]
2025-10-13 10:34:51.731575 | controller | changed
2025-10-13 10:34:51.753413 | 
2025-10-13 10:34:51.753516 | TASK [Slurp Zuul inventory test]
2025-10-13 10:34:52.963787 | controller -> localhost | ok
2025-10-13 10:34:52.970770 | 
2025-10-13 10:34:52.970836 | TASK [Save zuul inventory]
2025-10-13 10:34:54.732705 | controller | changed
2025-10-13 10:34:54.743093 | 
2025-10-13 10:34:54.743180 | TASK [Save zuul vars without the change_message]
2025-10-13 10:34:55.775262 | controller | changed
2025-10-13 10:34:55.895419 | 
2025-10-13 10:34:55.895500 | PLAY RECAP
2025-10-13 10:34:55.895548 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-13 10:34:55.895573 | 
2025-10-13 10:34:56.248223 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-13 10:34:56.249018 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-13 10:34:58.137842 | 
2025-10-13 10:34:58.137971 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2025-10-13 10:34:58.260451 | 
2025-10-13 10:34:58.260568 | TASK [Read group_vars]
2025-10-13 10:34:58.367355 | controller | ok
2025-10-13 10:34:58.493353 | 
2025-10-13 10:34:58.493485 | TASK [cifmw_helpers : Check directory is available /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars]
2025-10-13 10:34:59.159412 | controller | ok
2025-10-13 10:34:59.170270 | 
2025-10-13 10:34:59.170341 | TASK [cifmw_helpers : List available files]
2025-10-13 10:34:59.833212 | controller | skipping: Conditional result was False
2025-10-13 10:34:59.839510 | 
2025-10-13 10:34:59.839581 | LOOP [cifmw_helpers : Read vars]
2025-10-13 10:34:59.896101 | 
2025-10-13 10:34:59.896232 | LOOP [cifmw_helpers : Call task to parse all files as fact]
2025-10-13 10:34:59.967699 | 
2025-10-13 10:34:59.967996 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2025-10-13 10:35:00.028175 | controller | ok
2025-10-13 10:35:00.126534 | 
2025-10-13 10:35:00.126653 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-13 10:35:00.268565 | controller | skipping: Conditional result was False
2025-10-13 10:35:00.274569 | 
2025-10-13 10:35:00.274658 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-13 10:35:01.100493 | controller | ok
2025-10-13 10:35:01.110896 | 
2025-10-13 10:35:01.110996 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-13 10:35:01.885541 | controller | ok
2025-10-13 10:35:01.923478 | 
2025-10-13 10:35:01.923567 | TASK [Prepare workspace]
2025-10-13 10:35:02.034722 | controller | ok
2025-10-13 10:35:02.105637 | 
2025-10-13 10:35:02.105739 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-10-13 10:35:02.836689 | controller | ok
2025-10-13 10:35:02.861882 | 
2025-10-13 10:35:02.862002 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-10-13 10:35:10.273889 | controller | Output suppressed because no_log was given
2025-10-13 10:35:10.297840 | 
2025-10-13 10:35:10.299971 | LOOP [Create zuul-output directory]
2025-10-13 10:35:10.617424 | controller | changed: "/home/zuul/ci-framework-data/logs"
2025-10-13 10:35:10.617633 | 
2025-10-13 10:35:10.796387 | controller | ok: "/home/zuul/zuul-output/logs"
2025-10-13 10:35:10.804426 | 
2025-10-13 10:35:10.804491 | TASK [Install required packages]
2025-10-13 10:36:00.914555 | controller | changed
2025-10-13 10:36:00.920560 | 
2025-10-13 10:36:00.920673 | TASK [Install venv]
2025-10-13 10:37:09.471796 | controller | changed
2025-10-13 10:37:09.496328 | 
2025-10-13 10:37:09.496384 | PLAY RECAP
2025-10-13 10:37:09.496429 | controller | ok: 8 changed: 4 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0
2025-10-13 10:37:09.496452 | 
2025-10-13 10:37:09.562326 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-13 10:37:09.563142 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-13 10:37:10.102106 | 
2025-10-13 10:37:10.102209 | PLAY [Run ci/playbooks/molecule-test.yml]
2025-10-13 10:37:10.124139 | 
2025-10-13 10:37:10.124211 | TASK [Gather required facts]
2025-10-13 10:37:10.620817 | controller | ok
2025-10-13 10:37:10.626170 | 
2025-10-13 10:37:10.626965 | TASK [Load environment var if instructed to]
2025-10-13 10:37:10.650782 | controller | skipping: Conditional result was False
2025-10-13 10:37:10.656401 | 
2025-10-13 10:37:10.656493 | TASK [Ensure group_vars dir exists]
2025-10-13 10:37:10.969286 | controller | ok
2025-10-13 10:37:10.975821 | 
2025-10-13 10:37:10.975888 | TASK [Run molecule]
2025-10-13 10:37:11.918240 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2025-10-13 10:37:11.987466 | controller | INFO     Performing prerun with role_name_check=0...
2025-10-13 10:37:37.524050 | controller | WARNING  Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 10:37:37.524574 | controller | WARNING  Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 10:37:37.525075 | controller | WARNING  Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 10:37:37.525565 | controller | WARNING  Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 10:37:37.526079 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+490278e0 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 1.0.0+490278e0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 10:37:37.526560 | controller | WARNING  Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 10:37:37.527011 | controller | WARNING  Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 10:37:37.527447 | controller | WARNING  Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 10:37:37.527885 | controller | WARNING  Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 10:37:37.528338 | controller | WARNING  Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 10:37:37.528771 | controller | WARNING  Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 10:37:37.529248 | controller | WARNING  Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 10:37:37.529699 | controller | WARNING  Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 10:37:37.530194 | controller | WARNING  Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 10:37:37.530620 | controller | WARNING  Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/29a3e1/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 10:37:37.539931 | controller | INFO     Running default > prepare
2025-10-13 10:37:37.540382 | controller | WARNING  Skipping, prepare playbook not configured.
2025-10-13 10:37:37.547920 | controller | INFO     Running default > converge
2025-10-13 10:37:38.199499 | controller |
2025-10-13 10:37:38.199594 | controller | PLAY [Converge test of controller tasks] ***************************************
2025-10-13 10:37:38.199697 | controller |
2025-10-13 10:37:38.199803 | controller | TASK [Gathering Facts] *********************************************************
2025-10-13 10:37:38.199930 | controller | Monday 13 October 2025  10:37:38 +0000 (0:00:00.010)       0:00:00.010 ********
2025-10-13 10:37:39.020516 | controller | ok: [instance]
2025-10-13 10:37:39.020574 | controller |
2025-10-13 10:37:39.020695 | controller | TASK [compliance : Ensure compliance folder exists] ****************************
2025-10-13 10:37:39.020802 | controller | Monday 13 October 2025  10:37:39 +0000 (0:00:00.821)       0:00:00.831 ********
2025-10-13 10:37:39.316504 | controller | changed: [instance]
2025-10-13 10:37:39.316578 | controller |
2025-10-13 10:37:39.316685 | controller | TASK [compliance : Install the compliance operator and plugin] *****************
2025-10-13 10:37:39.316783 | controller | Monday 13 October 2025  10:37:39 +0000 (0:00:00.295)       0:00:01.127 ********
2025-10-13 10:37:39.352408 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/install.yml for instance
2025-10-13 10:37:39.352509 | controller |
2025-10-13 10:37:39.352622 | controller | TASK [compliance : Create the compliance namespace] ****************************
2025-10-13 10:37:39.352725 | controller | Monday 13 October 2025  10:37:39 +0000 (0:00:00.036)       0:00:01.163 ********
2025-10-13 10:37:39.379767 | controller | skipping: [instance]
2025-10-13 10:37:39.379874 | controller |
2025-10-13 10:37:39.380013 | controller | TASK [compliance : Ensure OperatorGroup for the compliance-operator is present] ***
2025-10-13 10:37:39.380121 | controller | Monday 13 October 2025  10:37:39 +0000 (0:00:00.027)       0:00:01.191 ********
2025-10-13 10:37:39.406075 | controller | skipping: [instance]
2025-10-13 10:37:39.406165 | controller |
2025-10-13 10:37:39.406273 | controller | TASK [compliance : Ensure Subscription for the compliance-operator is present] ***
2025-10-13 10:37:39.406377 | controller | Monday 13 October 2025  10:37:39 +0000 (0:00:00.026)       0:00:01.217 ********
2025-10-13 10:37:39.434951 | controller | skipping: [instance]
2025-10-13 10:37:39.435045 | controller |
2025-10-13 10:37:39.435148 | controller | TASK [compliance : Wait until the compliance-operator csv is present] **********
2025-10-13 10:37:39.435262 | controller | Monday 13 October 2025  10:37:39 +0000 (0:00:00.028)       0:00:01.246 ********
2025-10-13 10:37:39.460772 | controller | skipping: [instance]
2025-10-13 10:37:39.460870 | controller |
2025-10-13 10:37:39.461033 | controller | TASK [compliance : Get full name of the compliance-operator csv] ***************
2025-10-13 10:37:39.461143 | controller | Monday 13 October 2025  10:37:39 +0000 (0:00:00.025)       0:00:01.272 ********
2025-10-13 10:37:39.487274 | controller | skipping: [instance]
2025-10-13 10:37:39.487366 | controller |
2025-10-13 10:37:39.487472 | controller | TASK [compliance : Wait for the compliance-operator csv to Succeed] ************
2025-10-13 10:37:39.487576 | controller | Monday 13 October 2025  10:37:39 +0000 (0:00:00.026)       0:00:01.298 ********
2025-10-13 10:37:39.513876 | controller | skipping: [instance]
2025-10-13 10:37:39.514016 | controller |
2025-10-13 10:37:39.514119 | controller | TASK [podman : Ensure podman is installed] *************************************
2025-10-13 10:37:39.514234 | controller | Monday 13 October 2025  10:37:39 +0000 (0:00:00.026)       0:00:01.325 ********
2025-10-13 10:37:40.280910 | controller | ok: [instance]
2025-10-13 10:37:40.281221 | controller |
2025-10-13 10:37:40.281350 | controller | TASK [podman : Enable loginctl linger for ansible_user_id] *********************
2025-10-13 10:37:40.281485 | controller | Monday 13 October 2025  10:37:40 +0000 (0:00:00.766)       0:00:02.091 ********
2025-10-13 10:37:40.659507 | controller | changed: [instance]
2025-10-13 10:37:40.659589 | controller |
2025-10-13 10:37:40.660808 | controller | TASK [podman : Ensure subordinate UID entry exists for zuul] *******************
2025-10-13 10:37:40.660978 | controller | Monday 13 October 2025  10:37:40 +0000 (0:00:00.377)       0:00:02.469 ********
2025-10-13 10:37:40.686260 | controller | skipping: [instance]
2025-10-13 10:37:40.686387 | controller |
2025-10-13 10:37:40.686517 | controller | TASK [podman : Ensure subordinate GID entry exists for zuul] *******************
2025-10-13 10:37:40.686635 | controller | Monday 13 October 2025  10:37:40 +0000 (0:00:00.028)       0:00:02.497 ********
2025-10-13 10:37:40.709494 | controller | skipping: [instance]
2025-10-13 10:37:40.709567 | controller |
2025-10-13 10:37:40.709593 | controller | TASK [podman : Run podman system migrate if subuid/subgid files were changed] ***
2025-10-13 10:37:40.709702 | controller | Monday 13 October 2025  10:37:40 +0000 (0:00:00.023)       0:00:02.520 ********
2025-10-13 10:37:40.736413 | controller | skipping: [instance]
2025-10-13 10:37:40.736456 | controller |
2025-10-13 10:37:40.736554 | controller | TASK [compliance : Log into registry] ******************************************
2025-10-13 10:37:40.736649 | controller | Monday 13 October 2025  10:37:40 +0000 (0:00:00.026)       0:00:02.547 ********
2025-10-13 10:37:40.756157 | controller | skipping: [instance]
2025-10-13 10:37:40.756227 | controller |
2025-10-13 10:37:40.756343 | controller | TASK [compliance : Copy out the compliance plugin from the oc-compliance image] ***
2025-10-13 10:37:40.756456 | controller | Monday 13 October 2025  10:37:40 +0000 (0:00:00.019)       0:00:02.567 ********
2025-10-13 10:37:40.777009 | controller | skipping: [instance]
2025-10-13 10:37:40.777062 | controller |
2025-10-13 10:37:40.777146 | controller | TASK [compliance : Install packages to process results] ************************
2025-10-13 10:37:40.777250 | controller | Monday 13 October 2025  10:37:40 +0000 (0:00:00.020)       0:00:02.588 ********
2025-10-13 10:37:46.121587 | controller | changed: [instance]
2025-10-13 10:37:46.121952 | controller |
2025-10-13 10:37:46.171977 | controller | TASK [compliance : Run compliance scans and extract results] *******************
2025-10-13 10:37:46.172002 | controller | Monday 13 October 2025  10:37:46 +0000 (0:00:05.344)       0:00:07.932 ********
2025-10-13 10:37:46.172015 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=cis)
2025-10-13 10:37:46.172040 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=e8)
2025-10-13 10:37:46.172047 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=high)
2025-10-13 10:37:46.172052 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=moderate)
2025-10-13 10:37:46.172058 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=nerc-cip)
2025-10-13 10:37:46.172064 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=pci-dss)
2025-10-13 10:37:46.172071 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=stig)
2025-10-13 10:37:46.172367 | controller |
2025-10-13 10:37:46.189711 | controller | TASK [compliance : Log start of scans] *****************************************
2025-10-13 10:37:46.189735 | controller | Monday 13 October 2025  10:37:46 +0000 (0:00:00.049)       0:00:07.982 ********
2025-10-13 10:37:46.189746 | controller | ok: [instance] =>
2025-10-13 10:37:46.215232 | controller |   msg: Starting scans for cis
2025-10-13 10:37:46.215252 | controller |
2025-10-13 10:37:46.215260 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-10-13 10:37:46.215266 | controller | Monday 13 October 2025  10:37:46 +0000 (0:00:00.018)       0:00:08.000 ********
2025-10-13 10:37:46.215276 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-cis)
2025-10-13 10:37:46.236195 | controller |
2025-10-13 10:37:46.236226 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:46.236234 | controller | Monday 13 October 2025  10:37:46 +0000 (0:00:00.025)       0:00:08.026 ********
2025-10-13 10:37:46.236252 | controller | ok: [instance]
2025-10-13 10:37:46.253325 | controller |
2025-10-13 10:37:46.253346 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:46.253353 | controller | Monday 13 October 2025  10:37:46 +0000 (0:00:00.020)       0:00:08.047 ********
2025-10-13 10:37:46.253366 | controller | skipping: [instance]
2025-10-13 10:37:46.269285 | controller |
2025-10-13 10:37:46.269304 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:46.269311 | controller | Monday 13 October 2025  10:37:46 +0000 (0:00:00.017)       0:00:08.064 ********
2025-10-13 10:37:46.269320 | controller | skipping: [instance]
2025-10-13 10:37:46.440712 | controller |
2025-10-13 10:37:46.440740 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:46.440748 | controller | Monday 13 October 2025  10:37:46 +0000 (0:00:00.016)       0:00:08.080 ********
2025-10-13 10:37:46.440758 | controller | ok: [instance]
2025-10-13 10:37:46.625997 | controller |
2025-10-13 10:37:46.626030 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:46.626038 | controller | Monday 13 October 2025  10:37:46 +0000 (0:00:00.171)       0:00:08.251 ********
2025-10-13 10:37:46.626049 | controller | changed: [instance]
2025-10-13 10:37:46.626235 | controller |
2025-10-13 10:37:46.626265 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:46.642983 | controller | Monday 13 October 2025  10:37:46 +0000 (0:00:00.185)       0:00:08.437 ********
2025-10-13 10:37:46.643013 | controller | skipping: [instance]
2025-10-13 10:37:46.643043 | controller |
2025-10-13 10:37:46.643245 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:46.918969 | controller | Monday 13 October 2025  10:37:46 +0000 (0:00:00.017)       0:00:08.454 ********
2025-10-13 10:37:46.919003 | controller | ok: [instance]
2025-10-13 10:37:46.919059 | controller |
2025-10-13 10:37:46.919075 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:46.919085 | controller | Monday 13 October 2025  10:37:46 +0000 (0:00:00.275)       0:00:08.730 ********
2025-10-13 10:37:46.932963 | controller | skipping: [instance]
2025-10-13 10:37:46.933009 | controller |
2025-10-13 10:37:46.933128 | controller | TASK [compliance : Log start of scans] *****************************************
2025-10-13 10:37:46.933246 | controller | Monday 13 October 2025  10:37:46 +0000 (0:00:00.014)       0:00:08.744 ********
2025-10-13 10:37:46.952375 | controller | ok: [instance] =>
2025-10-13 10:37:46.983696 | controller |   msg: Starting scans for e8
2025-10-13 10:37:46.983715 | controller |
2025-10-13 10:37:46.983722 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-10-13 10:37:46.983728 | controller | Monday 13 October 2025  10:37:46 +0000 (0:00:00.019)       0:00:08.763 ********
2025-10-13 10:37:46.983737 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-e8)
2025-10-13 10:37:47.005813 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-e8)
2025-10-13 10:37:47.005847 | controller |
2025-10-13 10:37:47.005854 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:47.005860 | controller | Monday 13 October 2025  10:37:46 +0000 (0:00:00.031)       0:00:08.794 ********
2025-10-13 10:37:47.005869 | controller | ok: [instance]
2025-10-13 10:37:47.021962 | controller |
2025-10-13 10:37:47.021986 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:47.021995 | controller | Monday 13 October 2025  10:37:47 +0000 (0:00:00.022)       0:00:08.817 ********
2025-10-13 10:37:47.022006 | controller | skipping: [instance]
2025-10-13 10:37:47.022031 | controller |
2025-10-13 10:37:47.022045 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:47.022102 | controller | Monday 13 October 2025  10:37:47 +0000 (0:00:00.016)       0:00:08.833 ********
2025-10-13 10:37:47.037967 | controller | skipping: [instance]
2025-10-13 10:37:47.038013 | controller |
2025-10-13 10:37:47.038024 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:47.038104 | controller | Monday 13 October 2025  10:37:47 +0000 (0:00:00.016)       0:00:08.849 ********
2025-10-13 10:37:47.211791 | controller | ok: [instance]
2025-10-13 10:37:47.399878 | controller |
2025-10-13 10:37:47.399920 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:47.399928 | controller | Monday 13 October 2025  10:37:47 +0000 (0:00:00.173)       0:00:09.022 ********
2025-10-13 10:37:47.399939 | controller | changed: [instance]
2025-10-13 10:37:47.414923 | controller |
2025-10-13 10:37:47.414948 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:47.414956 | controller | Monday 13 October 2025  10:37:47 +0000 (0:00:00.188)       0:00:09.210 ********
2025-10-13 10:37:47.414970 | controller | skipping: [instance]
2025-10-13 10:37:47.586651 | controller |
2025-10-13 10:37:47.586680 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:47.586688 | controller | Monday 13 October 2025  10:37:47 +0000 (0:00:00.015)       0:00:09.226 ********
2025-10-13 10:37:47.586698 | controller | ok: [instance]
2025-10-13 10:37:47.600741 | controller |
2025-10-13 10:37:47.600761 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:47.600768 | controller | Monday 13 October 2025  10:37:47 +0000 (0:00:00.171)       0:00:09.397 ********
2025-10-13 10:37:47.600777 | controller | skipping: [instance]
2025-10-13 10:37:47.622973 | controller |
2025-10-13 10:37:47.622998 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:47.623007 | controller | Monday 13 October 2025  10:37:47 +0000 (0:00:00.014)       0:00:09.411 ********
2025-10-13 10:37:47.623019 | controller | ok: [instance]
2025-10-13 10:37:47.623045 | controller |
2025-10-13 10:37:47.623054 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:47.623137 | controller | Monday 13 October 2025  10:37:47 +0000 (0:00:00.022)       0:00:09.434 ********
2025-10-13 10:37:47.638973 | controller | skipping: [instance]
2025-10-13 10:37:47.639080 | controller |
2025-10-13 10:37:47.639096 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:47.639106 | controller | Monday 13 October 2025  10:37:47 +0000 (0:00:00.015)       0:00:09.450 ********
2025-10-13 10:37:47.654671 | controller | skipping: [instance]
2025-10-13 10:37:47.830320 | controller |
2025-10-13 10:37:47.830348 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:47.830356 | controller | Monday 13 October 2025  10:37:47 +0000 (0:00:00.015)       0:00:09.465 ********
2025-10-13 10:37:47.830367 | controller | ok: [instance]
2025-10-13 10:37:48.014788 | controller |
2025-10-13 10:37:48.014817 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:48.014842 | controller | Monday 13 October 2025  10:37:47 +0000 (0:00:00.175)       0:00:09.641 ********
2025-10-13 10:37:48.014853 | controller | changed: [instance]
2025-10-13 10:37:48.030615 | controller |
2025-10-13 10:37:48.030636 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:48.030644 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.184)       0:00:09.825 ********
2025-10-13 10:37:48.030653 | controller | skipping: [instance]
2025-10-13 10:37:48.202518 | controller |
2025-10-13 10:37:48.202548 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:48.202556 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.016)       0:00:09.841 ********
2025-10-13 10:37:48.202566 | controller | ok: [instance]
2025-10-13 10:37:48.219579 | controller |
2025-10-13 10:37:48.219602 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:48.219609 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.171)       0:00:10.013 ********
2025-10-13 10:37:48.219619 | controller | skipping: [instance]
2025-10-13 10:37:48.238543 | controller |
2025-10-13 10:37:48.238565 | controller | TASK [compliance : Log start of scans] *****************************************
2025-10-13 10:37:48.238572 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.017)       0:00:10.030 ********
2025-10-13 10:37:48.238582 | controller | ok: [instance] =>
2025-10-13 10:37:48.276044 | controller |   msg: Starting scans for high
2025-10-13 10:37:48.276079 | controller |
2025-10-13 10:37:48.276088 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-10-13 10:37:48.276095 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.018)       0:00:10.049 ********
2025-10-13 10:37:48.276106 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-high)
2025-10-13 10:37:48.276136 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-high-node)
2025-10-13 10:37:48.276148 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-high)
2025-10-13 10:37:48.276157 | controller |
2025-10-13 10:37:48.276370 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:48.312051 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.037)       0:00:10.086 ********
2025-10-13 10:37:48.312095 | controller | ok: [instance]
2025-10-13 10:37:48.312128 | controller |
2025-10-13 10:37:48.312137 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:48.312148 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.036)       0:00:10.123 ********
2025-10-13 10:37:48.328346 | controller | skipping: [instance]
2025-10-13 10:37:48.344969 | controller |
2025-10-13 10:37:48.344991 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:48.344999 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.016)       0:00:10.139 ********
2025-10-13 10:37:48.345008 | controller | skipping: [instance]
2025-10-13 10:37:48.345030 | controller |
2025-10-13 10:37:48.345038 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:48.345158 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.016)       0:00:10.156 ********
2025-10-13 10:37:48.523028 | controller | ok: [instance]
2025-10-13 10:37:48.711850 | controller |
2025-10-13 10:37:48.711881 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:48.711889 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.177)       0:00:10.333 ********
2025-10-13 10:37:48.711913 | controller | changed: [instance]
2025-10-13 10:37:48.728012 | controller |
2025-10-13 10:37:48.728046 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:48.728056 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.188)       0:00:10.522 ********
2025-10-13 10:37:48.728068 | controller | skipping: [instance]
2025-10-13 10:37:48.728094 | controller |
2025-10-13 10:37:48.728104 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:48.728208 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.016)       0:00:10.539 ********
2025-10-13 10:37:48.906169 | controller | ok: [instance]
2025-10-13 10:37:48.920564 | controller |
2025-10-13 10:37:48.920590 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:48.920598 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.177)       0:00:10.717 ********
2025-10-13 10:37:48.920608 | controller | skipping: [instance]
2025-10-13 10:37:48.943322 | controller |
2025-10-13 10:37:48.943351 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:48.943359 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.014)       0:00:10.731 ********
2025-10-13 10:37:48.943369 | controller | ok: [instance]
2025-10-13 10:37:48.960391 | controller |
2025-10-13 10:37:48.960420 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:48.960428 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.022)       0:00:10.754 ********
2025-10-13 10:37:48.960438 | controller | skipping: [instance]
2025-10-13 10:37:48.978359 | controller |
2025-10-13 10:37:48.978389 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:48.978397 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.017)       0:00:10.771 ********
2025-10-13 10:37:48.978408 | controller | skipping: [instance]
2025-10-13 10:37:49.159973 | controller |
2025-10-13 10:37:49.160006 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:49.160014 | controller | Monday 13 October 2025  10:37:48 +0000 (0:00:00.017)       0:00:10.789 ********
2025-10-13 10:37:49.160025 | controller | ok: [instance]
2025-10-13 10:37:49.351544 | controller |
2025-10-13 10:37:49.351575 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:49.351583 | controller | Monday 13 October 2025  10:37:49 +0000 (0:00:00.181)       0:00:10.970 ********
2025-10-13 10:37:49.351593 | controller | changed: [instance]
2025-10-13 10:37:49.368713 | controller |
2025-10-13 10:37:49.368738 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:49.368746 | controller | Monday 13 October 2025  10:37:49 +0000 (0:00:00.191)       0:00:11.162 ********
2025-10-13 10:37:49.368755 | controller | skipping: [instance]
2025-10-13 10:37:49.553766 | controller |
2025-10-13 10:37:49.553796 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:49.553804 | controller | Monday 13 October 2025  10:37:49 +0000 (0:00:00.017)       0:00:11.179 ********
2025-10-13 10:37:49.553814 | controller | ok: [instance]
2025-10-13 10:37:49.567882 | controller |
2025-10-13 10:37:49.567927 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:49.567935 | controller | Monday 13 October 2025  10:37:49 +0000 (0:00:00.184)       0:00:11.364 ********
2025-10-13 10:37:49.567945 | controller | skipping: [instance]
2025-10-13 10:37:49.591001 | controller |
2025-10-13 10:37:49.591036 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:49.591046 | controller | Monday 13 October 2025  10:37:49 +0000 (0:00:00.014)       0:00:11.379 ********
2025-10-13 10:37:49.591058 | controller | ok: [instance]
2025-10-13 10:37:49.608050 | controller |
2025-10-13 10:37:49.608074 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:49.608081 | controller | Monday 13 October 2025  10:37:49 +0000 (0:00:00.023)       0:00:11.402 ********
2025-10-13 10:37:49.608090 | controller | skipping: [instance]
2025-10-13 10:37:49.624992 | controller |
2025-10-13 10:37:49.625022 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:49.625031 | controller | Monday 13 October 2025  10:37:49 +0000 (0:00:00.016)       0:00:11.419 ********
2025-10-13 10:37:49.625050 | controller | skipping: [instance]
2025-10-13 10:37:49.625078 | controller |
2025-10-13 10:37:49.625088 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:49.625200 | controller | Monday 13 October 2025  10:37:49 +0000 (0:00:00.016)       0:00:11.436 ********
2025-10-13 10:37:49.801659 | controller | ok: [instance]
2025-10-13 10:37:49.985214 | controller |
2025-10-13 10:37:49.985244 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:49.985252 | controller | Monday 13 October 2025  10:37:49 +0000 (0:00:00.176)       0:00:11.612 ********
2025-10-13 10:37:49.985262 | controller | changed: [instance]
2025-10-13 10:37:50.001679 | controller |
2025-10-13 10:37:50.001705 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:50.001713 | controller | Monday 13 October 2025  10:37:49 +0000 (0:00:00.183)       0:00:11.796 ********
2025-10-13 10:37:50.001722 | controller | skipping: [instance]
2025-10-13 10:37:50.173325 | controller |
2025-10-13 10:37:50.173355 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:50.173363 | controller | Monday 13 October 2025  10:37:49 +0000 (0:00:00.016)       0:00:11.812 ********
2025-10-13 10:37:50.173374 | controller | ok: [instance]
2025-10-13 10:37:50.189351 | controller |
2025-10-13 10:37:50.189373 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:50.189380 | controller | Monday 13 October 2025  10:37:50 +0000 (0:00:00.171)       0:00:11.984 ********
2025-10-13 10:37:50.189389 | controller | skipping: [instance]
2025-10-13 10:37:50.208421 | controller |
2025-10-13 10:37:50.208442 | controller | TASK [compliance : Log start of scans] *****************************************
2025-10-13 10:37:50.208448 | controller | Monday 13 October 2025  10:37:50 +0000 (0:00:00.016)       0:00:12.000 ********
2025-10-13 10:37:50.208466 | controller | ok: [instance] =>
2025-10-13 10:37:50.246020 | controller |   msg: Starting scans for moderate
2025-10-13 10:37:50.246052 | controller |
2025-10-13 10:37:50.246060 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-10-13 10:37:50.246066 | controller | Monday 13 October 2025  10:37:50 +0000 (0:00:00.018)       0:00:12.019 ********
2025-10-13 10:37:50.246077 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-moderate)
2025-10-13 10:37:50.246102 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-moderate-node)
2025-10-13 10:37:50.246108 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-moderate)
2025-10-13 10:37:50.246115 | controller |
2025-10-13 10:37:50.246277 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:50.269616 | controller | Monday 13 October 2025  10:37:50 +0000 (0:00:00.037)       0:00:12.057 ********
2025-10-13 10:37:50.269650 | controller | ok: [instance]
2025-10-13 10:37:50.287732 | controller |
2025-10-13 10:37:50.287755 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:50.287763 | controller | Monday 13 October 2025  10:37:50 +0000 (0:00:00.023)       0:00:12.080 ********
2025-10-13 10:37:50.287773 | controller | skipping: [instance]
2025-10-13 10:37:50.305654 | controller |
2025-10-13 10:37:50.305677 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:50.305684 | controller | Monday 13 October 2025  10:37:50 +0000 (0:00:00.018)       0:00:12.098 ********
2025-10-13 10:37:50.305693 | controller | skipping: [instance]
2025-10-13 10:37:50.486029 | controller |
2025-10-13 10:37:50.486059 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:50.486067 | controller | Monday 13 October 2025  10:37:50 +0000 (0:00:00.017)       0:00:12.116 ********
2025-10-13 10:37:50.486077 | controller | ok: [instance]
2025-10-13 10:37:50.671800 | controller |
2025-10-13 10:37:50.671829 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:50.671852 | controller | Monday 13 October 2025  10:37:50 +0000 (0:00:00.180)       0:00:12.297 ********
2025-10-13 10:37:50.671863 | controller | changed: [instance]
2025-10-13 10:37:50.688463 | controller |
2025-10-13 10:37:50.688485 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:50.688493 | controller | Monday 13 October 2025  10:37:50 +0000 (0:00:00.185)       0:00:12.482 ********
2025-10-13 10:37:50.688502 | controller | skipping: [instance]
2025-10-13 10:37:50.860961 | controller |
2025-10-13 10:37:50.860990 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:50.860998 | controller | Monday 13 October 2025  10:37:50 +0000 (0:00:00.016)       0:00:12.499 ********
2025-10-13 10:37:50.861007 | controller | ok: [instance]
2025-10-13 10:37:50.861354 | controller |
2025-10-13 10:37:50.876320 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:50.876338 | controller | Monday 13 October 2025  10:37:50 +0000 (0:00:00.172)       0:00:12.672 ********
2025-10-13 10:37:50.876348 | controller | skipping: [instance]
2025-10-13 10:37:50.899778 | controller |
2025-10-13 10:37:50.899794 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:50.899806 | controller | Monday 13 October 2025  10:37:50 +0000 (0:00:00.015)       0:00:12.687 ********
2025-10-13 10:37:50.899815 | controller | ok: [instance]
2025-10-13 10:37:50.919001 | controller |
2025-10-13 10:37:50.919024 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:50.919033 | controller | Monday 13 October 2025  10:37:50 +0000 (0:00:00.023)       0:00:12.710 ********
2025-10-13 10:37:50.919041 | controller | skipping: [instance]
2025-10-13 10:37:50.935953 | controller |
2025-10-13 10:37:50.935972 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:50.935978 | controller | Monday 13 October 2025  10:37:50 +0000 (0:00:00.019)       0:00:12.730 ********
2025-10-13 10:37:50.935996 | controller | skipping: [instance]
2025-10-13 10:37:51.113457 | controller |
2025-10-13 10:37:51.113487 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:51.113495 | controller | Monday 13 October 2025  10:37:50 +0000 (0:00:00.017)       0:00:12.747 ********
2025-10-13 10:37:51.113506 | controller | ok: [instance]
2025-10-13 10:37:51.297026 | controller |
2025-10-13 10:37:51.297056 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:51.297064 | controller | Monday 13 October 2025  10:37:51 +0000 (0:00:00.177)       0:00:12.924 ********
2025-10-13 10:37:51.297074 | controller | changed: [instance]
2025-10-13 10:37:51.297159 | controller |
2025-10-13 10:37:51.297169 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:51.297178 | controller | Monday 13 October 2025  10:37:51 +0000 (0:00:00.183)       0:00:13.107 ********
2025-10-13 10:37:51.314005 | controller | skipping: [instance]
2025-10-13 10:37:51.487682 | controller |
2025-10-13 10:37:51.487711 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:51.487719 | controller | Monday 13 October 2025  10:37:51 +0000 (0:00:00.017)       0:00:13.125 ********
2025-10-13 10:37:51.487729 | controller | ok: [instance]
2025-10-13 10:37:51.502478 | controller |
2025-10-13 10:37:51.502500 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:51.502507 | controller | Monday 13 October 2025  10:37:51 +0000 (0:00:00.173)       0:00:13.298 ********
2025-10-13 10:37:51.502517 | controller | skipping: [instance]
2025-10-13 10:37:51.527804 | controller |
2025-10-13 10:37:51.527829 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:51.527858 | controller | Monday 13 October 2025  10:37:51 +0000 (0:00:00.015)       0:00:13.313 ********
2025-10-13 10:37:51.527869 | controller | ok: [instance]
2025-10-13 10:37:51.546542 | controller |
2025-10-13 10:37:51.546566 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:51.546574 | controller | Monday 13 October 2025  10:37:51 +0000 (0:00:00.025)       0:00:13.338 ********
2025-10-13 10:37:51.546585 | controller | skipping: [instance]
2025-10-13 10:37:51.563520 | controller |
2025-10-13 10:37:51.563539 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:51.563546 | controller | Monday 13 October 2025  10:37:51 +0000 (0:00:00.018)       0:00:13.357 ********
2025-10-13 10:37:51.563555 | controller | skipping: [instance]
2025-10-13 10:37:51.744703 | controller |
2025-10-13 10:37:51.744730 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:51.744738 | controller | Monday 13 October 2025  10:37:51 +0000 (0:00:00.017)       0:00:13.374 ********
2025-10-13 10:37:51.744748 | controller | ok: [instance]
2025-10-13 10:37:51.933470 | controller |
2025-10-13 10:37:51.933500 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:51.933508 | controller | Monday 13 October 2025  10:37:51 +0000 (0:00:00.180)       0:00:13.555 ********
2025-10-13 10:37:51.933517 | controller | changed: [instance]
2025-10-13 10:37:51.951572 | controller |
2025-10-13 10:37:51.951594 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:51.951602 | controller | Monday 13 October 2025  10:37:51 +0000 (0:00:00.188)       0:00:13.744 ********
2025-10-13 10:37:51.951611 | controller | skipping: [instance]
2025-10-13 10:37:52.126715 | controller |
2025-10-13 10:37:52.126743 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:52.126751 | controller | Monday 13 October 2025  10:37:51 +0000 (0:00:00.018)       0:00:13.762 ********
2025-10-13 10:37:52.126761 | controller | ok: [instance]
2025-10-13 10:37:52.141803 | controller |
2025-10-13 10:37:52.141824 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:52.141831 | controller | Monday 13 October 2025  10:37:52 +0000 (0:00:00.174)       0:00:13.937 ********
2025-10-13 10:37:52.141858 | controller | skipping: [instance]
2025-10-13 10:37:52.160982 | controller |
2025-10-13 10:37:52.161005 | controller | TASK [compliance : Log start of scans] *****************************************
2025-10-13 10:37:52.161020 | controller | Monday 13 October 2025  10:37:52 +0000 (0:00:00.015)       0:00:13.953 ********
2025-10-13 10:37:52.161031 | controller | ok: [instance] =>
2025-10-13 10:37:52.161072 | controller |   msg: Starting scans for nerc-cip
2025-10-13 10:37:52.161086 | controller |
2025-10-13 10:37:52.161289 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-10-13 10:37:52.192975 | controller | Monday 13 October 2025  10:37:52 +0000 (0:00:00.019)       0:00:13.972 ********
2025-10-13 10:37:52.193035 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-nerc-cip)
2025-10-13 10:37:52.193410 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-nerc-cip-node)
2025-10-13 10:37:52.215482 | controller |
2025-10-13 10:37:52.215504 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:52.215511 | controller | Monday 13 October 2025  10:37:52 +0000 (0:00:00.031)       0:00:14.004 ********
2025-10-13 10:37:52.215521 | controller | ok: [instance]
2025-10-13 10:37:52.231807 | controller |
2025-10-13 10:37:52.231826 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:52.231833 | controller | Monday 13 October 2025  10:37:52 +0000 (0:00:00.022)       0:00:14.026 ********
2025-10-13 10:37:52.231860 | controller | skipping: [instance]
2025-10-13 10:37:52.248464 | controller |
2025-10-13 10:37:52.248482 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:52.248489 | controller | Monday 13 October 2025  10:37:52 +0000 (0:00:00.016)       0:00:14.043 ********
2025-10-13 10:37:52.248498 | controller | skipping: [instance]
2025-10-13 10:37:52.429183 | controller |
2025-10-13 10:37:52.429214 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:52.429222 | controller | Monday 13 October 2025  10:37:52 +0000 (0:00:00.016)       0:00:14.059 ********
2025-10-13 10:37:52.429232 | controller | ok: [instance]
2025-10-13 10:37:52.620890 | controller |
2025-10-13 10:37:52.620953 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:52.620961 | controller | Monday 13 October 2025  10:37:52 +0000 (0:00:00.180)       0:00:14.240 ********
2025-10-13 10:37:52.620971 | controller | changed: [instance]
2025-10-13 10:37:52.636965 | controller |
2025-10-13 10:37:52.636989 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:52.636999 | controller | Monday 13 October 2025  10:37:52 +0000 (0:00:00.191)       0:00:14.431 ********
2025-10-13 10:37:52.637010 | controller | skipping: [instance]
2025-10-13 10:37:52.637037 | controller |
2025-10-13 10:37:52.637047 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:52.637114 | controller | Monday 13 October 2025  10:37:52 +0000 (0:00:00.016)       0:00:14.448 ********
2025-10-13 10:37:52.813086 | controller | ok: [instance]
2025-10-13 10:37:52.827632 | controller |
2025-10-13 10:37:52.827651 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:52.827659 | controller | Monday 13 October 2025  10:37:52 +0000 (0:00:00.175)       0:00:14.623 ********
2025-10-13 10:37:52.827668 | controller | skipping: [instance]
2025-10-13 10:37:52.850393 | controller |
2025-10-13 10:37:52.850414 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:52.850420 | controller | Monday 13 October 2025  10:37:52 +0000 (0:00:00.014)       0:00:14.638 ********
2025-10-13 10:37:52.850429 | controller | ok: [instance]
2025-10-13 10:37:52.867556 | controller |
2025-10-13 10:37:52.867577 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:52.867584 | controller | Monday 13 October 2025  10:37:52 +0000 (0:00:00.022)       0:00:14.661 ********
2025-10-13 10:37:52.867593 | controller | skipping: [instance]
2025-10-13 10:37:52.883947 | controller |
2025-10-13 10:37:52.883967 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:52.883976 | controller | Monday 13 October 2025  10:37:52 +0000 (0:00:00.017)       0:00:14.678 ********
2025-10-13 10:37:52.883986 | controller | skipping: [instance]
2025-10-13 10:37:52.884360 | controller |
2025-10-13 10:37:53.073443 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:53.073472 | controller | Monday 13 October 2025  10:37:52 +0000 (0:00:00.016)       0:00:14.695 ********
2025-10-13 10:37:53.073484 | controller | ok: [instance]
2025-10-13 10:37:53.258691 | controller |
2025-10-13 10:37:53.258719 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:53.258726 | controller | Monday 13 October 2025  10:37:53 +0000 (0:00:00.188)       0:00:14.884 ********
2025-10-13 10:37:53.258737 | controller | changed: [instance]
2025-10-13 10:37:53.274968 | controller |
2025-10-13 10:37:53.275011 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:53.275027 | controller | Monday 13 October 2025  10:37:53 +0000 (0:00:00.185)       0:00:15.069 ********
2025-10-13 10:37:53.275041 | controller | skipping: [instance]
2025-10-13 10:37:53.275082 | controller |
2025-10-13 10:37:53.275101 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:53.275111 | controller | Monday 13 October 2025  10:37:53 +0000 (0:00:00.016)       0:00:15.086 ********
2025-10-13 10:37:53.447051 | controller | ok: [instance]
2025-10-13 10:37:53.460414 | controller |
2025-10-13 10:37:53.460433 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:53.460441 | controller | Monday 13 October 2025  10:37:53 +0000 (0:00:00.171)       0:00:15.257 ********
2025-10-13 10:37:53.460450 | controller | skipping: [instance]
2025-10-13 10:37:53.477855 | controller |
2025-10-13 10:37:53.477873 | controller | TASK [compliance : Log start of scans] *****************************************
2025-10-13 10:37:53.477880 | controller | Monday 13 October 2025  10:37:53 +0000 (0:00:00.013)       0:00:15.271 ********
2025-10-13 10:37:53.477888 | controller | ok: [instance] =>
2025-10-13 10:37:53.509989 | controller |   msg: Starting scans for pci-dss
2025-10-13 10:37:53.510011 | controller |
2025-10-13 10:37:53.510020 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-10-13 10:37:53.510027 | controller | Monday 13 October 2025  10:37:53 +0000 (0:00:00.017)       0:00:15.289 ********
2025-10-13 10:37:53.510038 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-pci-dss)
2025-10-13 10:37:53.510076 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-pci-dss-node)
2025-10-13 10:37:53.510457 | controller |
2025-10-13 10:37:53.532973 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:53.533005 | controller | Monday 13 October 2025  10:37:53 +0000 (0:00:00.032)       0:00:15.321 ********
2025-10-13 10:37:53.533016 | controller | ok: [instance]
2025-10-13 10:37:53.533041 | controller |
2025-10-13 10:37:53.533050 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:53.533123 | controller | Monday 13 October 2025  10:37:53 +0000 (0:00:00.022)       0:00:15.344 ********
2025-10-13 10:37:53.549417 | controller | skipping: [instance]
2025-10-13 10:37:53.565872 | controller |
2025-10-13 10:37:53.565890 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:53.565918 | controller | Monday 13 October 2025  10:37:53 +0000 (0:00:00.016)       0:00:15.360 ********
2025-10-13 10:37:53.565928 | controller | skipping: [instance]
2025-10-13 10:37:53.745827 | controller |
2025-10-13 10:37:53.745875 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:53.745883 | controller | Monday 13 October 2025  10:37:53 +0000 (0:00:00.016)       0:00:15.377 ********
2025-10-13 10:37:53.745893 | controller | ok: [instance]
2025-10-13 10:37:53.930057 | controller |
2025-10-13 10:37:53.930085 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:53.930093 | controller | Monday 13 October 2025  10:37:53 +0000 (0:00:00.179)       0:00:15.556 ********
2025-10-13 10:37:53.930103 | controller | changed: [instance]
2025-10-13 10:37:53.946782 | controller |
2025-10-13 10:37:53.946804 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:53.946819 | controller | Monday 13 October 2025  10:37:53 +0000 (0:00:00.184)       0:00:15.740 ********
2025-10-13 10:37:53.946829 | controller | skipping: [instance]
2025-10-13 10:37:54.125590 | controller |
2025-10-13 10:37:54.125618 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:54.125626 | controller | Monday 13 October 2025  10:37:53 +0000 (0:00:00.017)       0:00:15.758 ********
2025-10-13 10:37:54.125636 | controller | ok: [instance]
2025-10-13 10:37:54.140951 | controller |
2025-10-13 10:37:54.140973 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:54.140981 | controller | Monday 13 October 2025  10:37:54 +0000 (0:00:00.178)       0:00:15.936 ********
2025-10-13 10:37:54.140991 | controller | skipping: [instance]
2025-10-13 10:37:54.164772 | controller |
2025-10-13 10:37:54.164797 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:54.164806 | controller | Monday 13 October 2025  10:37:54 +0000 (0:00:00.015)       0:00:15.952 ********
2025-10-13 10:37:54.164817 | controller | ok: [instance]
2025-10-13 10:37:54.180002 | controller |
2025-10-13 10:37:54.180022 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:54.180029 | controller | Monday 13 October 2025  10:37:54 +0000 (0:00:00.023)       0:00:15.975 ********
2025-10-13 10:37:54.180038 | controller | skipping: [instance]
2025-10-13 10:37:54.194716 | controller |
2025-10-13 10:37:54.194737 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:54.194744 | controller | Monday 13 October 2025  10:37:54 +0000 (0:00:00.015)       0:00:15.991 ********
2025-10-13 10:37:54.194760 | controller | skipping: [instance]
2025-10-13 10:37:54.378008 | controller |
2025-10-13 10:37:54.378039 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:54.378047 | controller | Monday 13 October 2025  10:37:54 +0000 (0:00:00.014)       0:00:16.005 ********
2025-10-13 10:37:54.378057 | controller | ok: [instance]
2025-10-13 10:37:54.378081 | controller |
2025-10-13 10:37:54.378310 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:54.559859 | controller | Monday 13 October 2025  10:37:54 +0000 (0:00:00.183)       0:00:16.189 ********
2025-10-13 10:37:54.559909 | controller | changed: [instance]
2025-10-13 10:37:54.574973 | controller |
2025-10-13 10:37:54.575007 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:54.575015 | controller | Monday 13 October 2025  10:37:54 +0000 (0:00:00.181)       0:00:16.370 ********
2025-10-13 10:37:54.575025 | controller | skipping: [instance]
2025-10-13 10:37:54.575048 | controller |
2025-10-13 10:37:54.575056 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:54.575172 | controller | Monday 13 October 2025  10:37:54 +0000 (0:00:00.015)       0:00:16.386 ********
2025-10-13 10:37:54.742972 | controller | ok: [instance]
2025-10-13 10:37:54.743017 | controller |
2025-10-13 10:37:54.743025 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:54.743034 | controller | Monday 13 October 2025  10:37:54 +0000 (0:00:00.167)       0:00:16.554 ********
2025-10-13 10:37:54.757661 | controller | skipping: [instance]
2025-10-13 10:37:54.789975 | controller |
2025-10-13 10:37:54.790015 | controller | TASK [compliance : Log start of scans] *****************************************
2025-10-13 10:37:54.790025 | controller | Monday 13 October 2025  10:37:54 +0000 (0:00:00.014)       0:00:16.568 ********
2025-10-13 10:37:54.790039 | controller | ok: [instance] =>
2025-10-13 10:37:54.826613 | controller |   msg: Starting scans for stig
2025-10-13 10:37:54.826642 | controller |
2025-10-13 10:37:54.826650 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-10-13 10:37:54.826656 | controller | Monday 13 October 2025  10:37:54 +0000 (0:00:00.032)       0:00:16.600 ********
2025-10-13 10:37:54.826665 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-stig)
2025-10-13 10:37:54.848007 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-stig-node)
2025-10-13 10:37:54.848037 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-stig)
2025-10-13 10:37:54.848046 | controller |
2025-10-13 10:37:54.848054 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:54.848061 | controller | Monday 13 October 2025  10:37:54 +0000 (0:00:00.036)       0:00:16.637 ********
2025-10-13 10:37:54.848072 | controller | ok: [instance]
2025-10-13 10:37:54.862911 | controller |
2025-10-13 10:37:54.862931 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:54.862939 | controller | Monday 13 October 2025  10:37:54 +0000 (0:00:00.021)       0:00:16.659 ********
2025-10-13 10:37:54.862950 | controller | skipping: [instance]
2025-10-13 10:37:54.878085 | controller |
2025-10-13 10:37:54.878103 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:54.878111 | controller | Monday 13 October 2025  10:37:54 +0000 (0:00:00.014)       0:00:16.674 ********
2025-10-13 10:37:54.878121 | controller | skipping: [instance]
2025-10-13 10:37:55.054967 | controller |
2025-10-13 10:37:55.054997 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:55.055004 | controller | Monday 13 October 2025  10:37:54 +0000 (0:00:00.015)       0:00:16.689 ********
2025-10-13 10:37:55.055014 | controller | ok: [instance]
2025-10-13 10:37:55.055039 | controller |
2025-10-13 10:37:55.055256 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:55.239662 | controller | Monday 13 October 2025  10:37:55 +0000 (0:00:00.176)       0:00:16.866 ********
2025-10-13 10:37:55.239697 | controller | changed: [instance]
2025-10-13 10:37:55.254730 | controller |
2025-10-13 10:37:55.254750 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:55.254758 | controller | Monday 13 October 2025  10:37:55 +0000 (0:00:00.184)       0:00:17.050 ********
2025-10-13 10:37:55.254766 | controller | skipping: [instance]
2025-10-13 10:37:55.422568 | controller |
2025-10-13 10:37:55.422597 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:55.422605 | controller | Monday 13 October 2025  10:37:55 +0000 (0:00:00.015)       0:00:17.066 ********
2025-10-13 10:37:55.422615 | controller | ok: [instance]
2025-10-13 10:37:55.435940 | controller |
2025-10-13 10:37:55.435967 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:55.435975 | controller | Monday 13 October 2025  10:37:55 +0000 (0:00:00.167)       0:00:17.233 ********
2025-10-13 10:37:55.435985 | controller | skipping: [instance]
2025-10-13 10:37:55.457410 | controller |
2025-10-13 10:37:55.457434 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:55.457446 | controller | Monday 13 October 2025  10:37:55 +0000 (0:00:00.013)       0:00:17.247 ********
2025-10-13 10:37:55.457456 | controller | ok: [instance]
2025-10-13 10:37:55.471982 | controller |
2025-10-13 10:37:55.472008 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:55.472017 | controller | Monday 13 October 2025  10:37:55 +0000 (0:00:00.021)       0:00:17.268 ********
2025-10-13 10:37:55.472029 | controller | skipping: [instance]
2025-10-13 10:37:55.472055 | controller |
2025-10-13 10:37:55.472065 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:55.472183 | controller | Monday 13 October 2025  10:37:55 +0000 (0:00:00.014)       0:00:17.283 ********
2025-10-13 10:37:55.486481 | controller | skipping: [instance]
2025-10-13 10:37:55.655710 | controller |
2025-10-13 10:37:55.655738 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:55.655746 | controller | Monday 13 October 2025  10:37:55 +0000 (0:00:00.014)       0:00:17.297 ********
2025-10-13 10:37:55.655757 | controller | ok: [instance]
2025-10-13 10:37:55.833769 | controller |
2025-10-13 10:37:55.833797 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:55.833805 | controller | Monday 13 October 2025  10:37:55 +0000 (0:00:00.168)       0:00:17.466 ********
2025-10-13 10:37:55.833815 | controller | changed: [instance]
2025-10-13 10:37:55.848556 | controller |
2025-10-13 10:37:55.848582 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:55.848598 | controller | Monday 13 October 2025  10:37:55 +0000 (0:00:00.178)       0:00:17.644 ********
2025-10-13 10:37:55.848609 | controller | skipping: [instance]
2025-10-13 10:37:56.017286 | controller |
2025-10-13 10:37:56.017315 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:56.017323 | controller | Monday 13 October 2025  10:37:55 +0000 (0:00:00.014)       0:00:17.659 ********
2025-10-13 10:37:56.017332 | controller | ok: [instance]
2025-10-13 10:37:56.030293 | controller |
2025-10-13 10:37:56.030319 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:56.030328 | controller | Monday 13 October 2025  10:37:56 +0000 (0:00:00.168)       0:00:17.828 ********
2025-10-13 10:37:56.030339 | controller | skipping: [instance]
2025-10-13 10:37:56.051332 | controller |
2025-10-13 10:37:56.051356 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:37:56.051364 | controller | Monday 13 October 2025  10:37:56 +0000 (0:00:00.013)       0:00:17.841 ********
2025-10-13 10:37:56.051376 | controller | ok: [instance]
2025-10-13 10:37:56.066082 | controller |
2025-10-13 10:37:56.066104 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:37:56.066112 | controller | Monday 13 October 2025  10:37:56 +0000 (0:00:00.021)       0:00:17.862 ********
2025-10-13 10:37:56.066124 | controller | skipping: [instance]
2025-10-13 10:37:56.080390 | controller |
2025-10-13 10:37:56.080412 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:37:56.080420 | controller | Monday 13 October 2025  10:37:56 +0000 (0:00:00.014)       0:00:17.877 ********
2025-10-13 10:37:56.080430 | controller | skipping: [instance]
2025-10-13 10:37:56.248530 | controller |
2025-10-13 10:37:56.248559 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:37:56.248566 | controller | Monday 13 October 2025  10:37:56 +0000 (0:00:00.014)       0:00:17.891 ********
2025-10-13 10:37:56.248577 | controller | ok: [instance]
2025-10-13 10:37:56.427547 | controller |
2025-10-13 10:37:56.427577 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:37:56.427585 | controller | Monday 13 October 2025  10:37:56 +0000 (0:00:00.167)       0:00:18.059 ********
2025-10-13 10:37:56.427594 | controller | changed: [instance]
2025-10-13 10:37:56.442275 | controller |
2025-10-13 10:37:56.442297 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:37:56.442304 | controller | Monday 13 October 2025  10:37:56 +0000 (0:00:00.178)       0:00:18.238 ********
2025-10-13 10:37:56.442314 | controller | skipping: [instance]
2025-10-13 10:37:56.608014 | controller |
2025-10-13 10:37:56.608045 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:37:56.608052 | controller | Monday 13 October 2025  10:37:56 +0000 (0:00:00.014)       0:00:18.253 ********
2025-10-13 10:37:56.608062 | controller | ok: [instance]
2025-10-13 10:37:56.621001 | controller |
2025-10-13 10:37:56.621022 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:37:56.621031 | controller | Monday 13 October 2025  10:37:56 +0000 (0:00:00.165)       0:00:18.419 ********
2025-10-13 10:37:56.621047 | controller | skipping: [instance]
2025-10-13 10:37:56.657765 | controller |
2025-10-13 10:37:56.657787 | controller | TASK [compliance : Delete all resources created by the role] *******************
2025-10-13 10:37:56.657794 | controller | Monday 13 October 2025  10:37:56 +0000 (0:00:00.013)       0:00:18.432 ********
2025-10-13 10:37:56.657803 | controller | skipping: [instance]
2025-10-13 10:37:58.243755 | controller |
2025-10-13 10:37:58.243786 | controller | PLAY [Converge test of compute tasks] ******************************************
2025-10-13 10:37:58.243794 | controller |
2025-10-13 10:37:58.243799 | controller | TASK [Gathering Facts] *********************************************************
2025-10-13 10:37:58.243805 | controller | Monday 13 October 2025  10:37:56 +0000 (0:00:00.036)       0:00:18.468 ********
2025-10-13 10:37:58.243814 | controller | ok: [instance]
2025-10-13 10:37:58.454291 | controller |
2025-10-13 10:37:58.454320 | controller | TASK [compliance : Ensure compliance folder exists] ****************************
2025-10-13 10:37:58.454328 | controller | Monday 13 October 2025  10:37:58 +0000 (0:00:01.585)       0:00:20.054 ********
2025-10-13 10:37:58.454345 | controller | ok: [instance]
2025-10-13 10:37:58.483063 | controller |
2025-10-13 10:37:58.483099 | controller | TASK [compliance : Install the compliance operator and plugin] *****************
2025-10-13 10:37:58.483109 | controller | Monday 13 October 2025  10:37:58 +0000 (0:00:00.210)       0:00:20.265 ********
2025-10-13 10:37:58.483121 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/install.yml for instance
2025-10-13 10:37:58.483151 | controller |
2025-10-13 10:37:58.483161 | controller | TASK [compliance : Create the compliance namespace] ****************************
2025-10-13 10:37:58.483285 | controller | Monday 13 October 2025  10:37:58 +0000 (0:00:00.028)       0:00:20.294 ********
2025-10-13 10:37:58.499842 | controller | skipping: [instance]
2025-10-13 10:37:58.516682 | controller |
2025-10-13 10:37:58.516716 | controller | TASK [compliance : Ensure OperatorGroup for the compliance-operator is present] ***
2025-10-13 10:37:58.516723 | controller | Monday 13 October 2025  10:37:58 +0000 (0:00:00.016)       0:00:20.310 ********
2025-10-13 10:37:58.516734 | controller | skipping: [instance]
2025-10-13 10:37:58.533996 | controller |
2025-10-13 10:37:58.534025 | controller | TASK [compliance : Ensure Subscription for the compliance-operator is present] ***
2025-10-13 10:37:58.534035 | controller | Monday 13 October 2025  10:37:58 +0000 (0:00:00.016)       0:00:20.327 ********
2025-10-13 10:37:58.534047 | controller | skipping: [instance]
2025-10-13 10:37:58.550996 | controller |
2025-10-13 10:37:58.551018 | controller | TASK [compliance : Wait until the compliance-operator csv is present] **********
2025-10-13 10:37:58.551027 | controller | Monday 13 October 2025  10:37:58 +0000 (0:00:00.017)       0:00:20.345 ********
2025-10-13 10:37:58.551038 | controller | skipping: [instance]
2025-10-13 10:37:58.567482 | controller |
2025-10-13 10:37:58.567515 | controller | TASK [compliance : Get full name of the compliance-operator csv] ***************
2025-10-13 10:37:58.567523 | controller | Monday 13 October 2025  10:37:58 +0000 (0:00:00.016)       0:00:20.361 ********
2025-10-13 10:37:58.567533 | controller | skipping: [instance]
2025-10-13 10:37:58.583994 | controller |
2025-10-13 10:37:58.584028 | controller | TASK [compliance : Wait for the compliance-operator csv to Succeed] ************
2025-10-13 10:37:58.584036 | controller | Monday 13 October 2025  10:37:58 +0000 (0:00:00.016)       0:00:20.378 ********
2025-10-13 10:37:58.584046 | controller | skipping: [instance]
2025-10-13 10:37:58.584120 | controller |
2025-10-13 10:37:58.584144 | controller | TASK [podman : Ensure podman is installed] *************************************
2025-10-13 10:37:58.584155 | controller | Monday 13 October 2025  10:37:58 +0000 (0:00:00.016)       0:00:20.395 ********
2025-10-13 10:37:59.233593 | controller | ok: [instance]
2025-10-13 10:37:59.442348 | controller |
2025-10-13 10:37:59.442377 | controller | TASK [podman : Enable loginctl linger for ansible_user_id] *********************
2025-10-13 10:37:59.442384 | controller | Monday 13 October 2025  10:37:59 +0000 (0:00:00.649)       0:00:21.044 ********
2025-10-13 10:37:59.442394 | controller | changed: [instance]
2025-10-13 10:37:59.464712 | controller |
2025-10-13 10:37:59.464729 | controller | TASK [podman : Ensure subordinate UID entry exists for zuul] *******************
2025-10-13 10:37:59.464736 | controller | Monday 13 October 2025  10:37:59 +0000 (0:00:00.208)       0:00:21.253 ********
2025-10-13 10:37:59.464744 | controller | skipping: [instance]
2025-10-13 10:37:59.484257 | controller |
2025-10-13 10:37:59.484273 | controller | TASK [podman : Ensure subordinate GID entry exists for zuul] *******************
2025-10-13 10:37:59.484280 | controller | Monday 13 October 2025  10:37:59 +0000 (0:00:00.022)       0:00:21.275 ********
2025-10-13 10:37:59.484288 | controller | skipping: [instance]
2025-10-13 10:37:59.508534 | controller |
2025-10-13 10:37:59.508552 | controller | TASK [podman : Run podman system migrate if subuid/subgid files were changed] ***
2025-10-13 10:37:59.508560 | controller | Monday 13 October 2025  10:37:59 +0000 (0:00:00.019)       0:00:21.295 ********
2025-10-13 10:37:59.508576 | controller | skipping: [instance]
2025-10-13 10:37:59.525481 | controller |
2025-10-13 10:37:59.525501 | controller | TASK [compliance : Log into registry] ******************************************
2025-10-13 10:37:59.525509 | controller | Monday 13 October 2025  10:37:59 +0000 (0:00:00.024)       0:00:21.319 ********
2025-10-13 10:37:59.525519 | controller | skipping: [instance]
2025-10-13 10:37:59.542590 | controller |
2025-10-13 10:37:59.542606 | controller | TASK [compliance : Copy out the compliance plugin from the oc-compliance image] ***
2025-10-13 10:37:59.542612 | controller | Monday 13 October 2025  10:37:59 +0000 (0:00:00.016)       0:00:21.336 ********
2025-10-13 10:37:59.542620 | controller | skipping: [instance]
2025-10-13 10:37:59.542756 | controller |
2025-10-13 10:37:59.542937 | controller | TASK [compliance : Install packages to process results] ************************
2025-10-13 10:37:59.543095 | controller | Monday 13 October 2025  10:37:59 +0000 (0:00:00.017)       0:00:21.354 ********
2025-10-13 10:38:00.205758 | controller | ok: [instance]
2025-10-13 10:38:00.249032 | controller |
2025-10-13 10:38:00.249072 | controller | TASK [compliance : Run compliance scans and extract results] *******************
2025-10-13 10:38:00.249082 | controller | Monday 13 October 2025  10:38:00 +0000 (0:00:00.662)       0:00:22.016 ********
2025-10-13 10:38:00.249095 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=cis)
2025-10-13 10:38:00.249126 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=e8)
2025-10-13 10:38:00.249134 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=high)
2025-10-13 10:38:00.249141 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=moderate)
2025-10-13 10:38:00.249148 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=nerc-cip)
2025-10-13 10:38:00.249156 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=pci-dss)
2025-10-13 10:38:00.249462 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_suite_scan.yml for instance => (item=stig)
2025-10-13 10:38:00.249494 | controller |
2025-10-13 10:38:00.267933 | controller | TASK [compliance : Log start of scans] *****************************************
2025-10-13 10:38:00.267953 | controller | Monday 13 October 2025  10:38:00 +0000 (0:00:00.043)       0:00:22.059 ********
2025-10-13 10:38:00.267963 | controller | ok: [instance] =>
2025-10-13 10:38:00.295434 | controller |   msg: Starting scans for cis
2025-10-13 10:38:00.295455 | controller |
2025-10-13 10:38:00.295463 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-10-13 10:38:00.295470 | controller | Monday 13 October 2025  10:38:00 +0000 (0:00:00.019)       0:00:22.079 ********
2025-10-13 10:38:00.295480 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-cis)
2025-10-13 10:38:00.318536 | controller |
2025-10-13 10:38:00.318553 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:00.318560 | controller | Monday 13 October 2025  10:38:00 +0000 (0:00:00.027)       0:00:22.106 ********
2025-10-13 10:38:00.318569 | controller | ok: [instance]
2025-10-13 10:38:00.335552 | controller |
2025-10-13 10:38:00.335585 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:00.335594 | controller | Monday 13 October 2025  10:38:00 +0000 (0:00:00.023)       0:00:22.129 ********
2025-10-13 10:38:00.335604 | controller | skipping: [instance]
2025-10-13 10:38:00.352985 | controller |
2025-10-13 10:38:00.353014 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:00.353022 | controller | Monday 13 October 2025  10:38:00 +0000 (0:00:00.016)       0:00:22.146 ********
2025-10-13 10:38:00.353032 | controller | skipping: [instance]
2025-10-13 10:38:00.353177 | controller |
2025-10-13 10:38:00.353190 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:00.353206 | controller | Monday 13 October 2025  10:38:00 +0000 (0:00:00.017)       0:00:22.163 ********
2025-10-13 10:38:00.531938 | controller | changed: [instance]
2025-10-13 10:38:00.720126 | controller |
2025-10-13 10:38:00.720184 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:00.720223 | controller | Monday 13 October 2025  10:38:00 +0000 (0:00:00.178)       0:00:22.342 ********
2025-10-13 10:38:00.720234 | controller | changed: [instance]
2025-10-13 10:38:00.738507 | controller |
2025-10-13 10:38:00.738528 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:00.738535 | controller | Monday 13 October 2025  10:38:00 +0000 (0:00:00.188)       0:00:22.530 ********
2025-10-13 10:38:00.738545 | controller | skipping: [instance]
2025-10-13 10:38:00.912324 | controller |
2025-10-13 10:38:00.912354 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:00.912362 | controller | Monday 13 October 2025  10:38:00 +0000 (0:00:00.018)       0:00:22.549 ********
2025-10-13 10:38:00.912371 | controller | ok: [instance]
2025-10-13 10:38:00.926924 | controller |
2025-10-13 10:38:00.926947 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:00.926954 | controller | Monday 13 October 2025  10:38:00 +0000 (0:00:00.173)       0:00:22.723 ********
2025-10-13 10:38:00.926963 | controller | skipping: [instance]
2025-10-13 10:38:00.945951 | controller |
2025-10-13 10:38:00.945976 | controller | TASK [compliance : Log start of scans] *****************************************
2025-10-13 10:38:00.945984 | controller | Monday 13 October 2025  10:38:00 +0000 (0:00:00.014)       0:00:22.738 ********
2025-10-13 10:38:00.945994 | controller | ok: [instance] =>
2025-10-13 10:38:00.946357 | controller |   msg: Starting scans for e8
2025-10-13 10:38:00.946374 | controller |
2025-10-13 10:38:00.978544 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-10-13 10:38:00.978576 | controller | Monday 13 October 2025  10:38:00 +0000 (0:00:00.019)       0:00:22.757 ********
2025-10-13 10:38:00.978587 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-e8)
2025-10-13 10:38:01.001633 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-e8)
2025-10-13 10:38:01.001669 | controller |
2025-10-13 10:38:01.001678 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:01.001686 | controller | Monday 13 October 2025  10:38:00 +0000 (0:00:00.032)       0:00:22.789 ********
2025-10-13 10:38:01.001697 | controller | ok: [instance]
2025-10-13 10:38:01.018126 | controller |
2025-10-13 10:38:01.018153 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:01.018161 | controller | Monday 13 October 2025  10:38:00 +0000 (0:00:00.023)       0:00:22.812 ********
2025-10-13 10:38:01.018170 | controller | skipping: [instance]
2025-10-13 10:38:01.018318 | controller |
2025-10-13 10:38:01.018466 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:01.018609 | controller | Monday 13 October 2025  10:38:01 +0000 (0:00:00.016)       0:00:22.829 ********
2025-10-13 10:38:01.034694 | controller | skipping: [instance]
2025-10-13 10:38:01.034920 | controller |
2025-10-13 10:38:01.035092 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:01.035234 | controller | Monday 13 October 2025  10:38:01 +0000 (0:00:00.016)       0:00:22.846 ********
2025-10-13 10:38:01.214588 | controller | changed: [instance]
2025-10-13 10:38:01.402471 | controller |
2025-10-13 10:38:01.402502 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:01.402510 | controller | Monday 13 October 2025  10:38:01 +0000 (0:00:00.179)       0:00:23.025 ********
2025-10-13 10:38:01.402521 | controller | changed: [instance]
2025-10-13 10:38:01.419487 | controller |
2025-10-13 10:38:01.419515 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:01.419524 | controller | Monday 13 October 2025  10:38:01 +0000 (0:00:00.187)       0:00:23.213 ********
2025-10-13 10:38:01.419535 | controller | skipping: [instance]
2025-10-13 10:38:01.594583 | controller |
2025-10-13 10:38:01.594615 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:01.594623 | controller | Monday 13 October 2025  10:38:01 +0000 (0:00:00.017)       0:00:23.230 ********
2025-10-13 10:38:01.594638 | controller | ok: [instance]
2025-10-13 10:38:01.608975 | controller |
2025-10-13 10:38:01.609002 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:01.609011 | controller | Monday 13 October 2025  10:38:01 +0000 (0:00:00.175)       0:00:23.405 ********
2025-10-13 10:38:01.609023 | controller | skipping: [instance]
2025-10-13 10:38:01.631411 | controller |
2025-10-13 10:38:01.631430 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:01.631437 | controller | Monday 13 October 2025  10:38:01 +0000 (0:00:00.014)       0:00:23.420 ********
2025-10-13 10:38:01.631445 | controller | ok: [instance]
2025-10-13 10:38:01.646985 | controller |
2025-10-13 10:38:01.647002 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:01.647009 | controller | Monday 13 October 2025  10:38:01 +0000 (0:00:00.022)       0:00:23.442 ********
2025-10-13 10:38:01.647018 | controller | skipping: [instance]
2025-10-13 10:38:01.662324 | controller |
2025-10-13 10:38:01.662341 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:01.662348 | controller | Monday 13 October 2025  10:38:01 +0000 (0:00:00.015)       0:00:23.458 ********
2025-10-13 10:38:01.662357 | controller | skipping: [instance]
2025-10-13 10:38:01.838274 | controller |
2025-10-13 10:38:01.838304 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:01.838312 | controller | Monday 13 October 2025  10:38:01 +0000 (0:00:00.015)       0:00:23.473 ********
2025-10-13 10:38:01.838322 | controller | changed: [instance]
2025-10-13 10:38:02.023557 | controller |
2025-10-13 10:38:02.023588 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:02.023596 | controller | Monday 13 October 2025  10:38:01 +0000 (0:00:00.175)       0:00:23.649 ********
2025-10-13 10:38:02.023606 | controller | changed: [instance]
2025-10-13 10:38:02.041007 | controller |
2025-10-13 10:38:02.041040 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:02.041050 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.185)       0:00:23.834 ********
2025-10-13 10:38:02.041062 | controller | skipping: [instance]
2025-10-13 10:38:02.041093 | controller |
2025-10-13 10:38:02.041388 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:02.216992 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.017)       0:00:23.852 ********
2025-10-13 10:38:02.217031 | controller | ok: [instance]
2025-10-13 10:38:02.217058 | controller |
2025-10-13 10:38:02.217285 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:02.230957 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.175)       0:00:24.028 ********
2025-10-13 10:38:02.230988 | controller | skipping: [instance]
2025-10-13 10:38:02.231312 | controller |
2025-10-13 10:38:02.248955 | controller | TASK [compliance : Log start of scans] *****************************************
2025-10-13 10:38:02.249012 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.014)       0:00:24.042 ********
2025-10-13 10:38:02.249025 | controller | ok: [instance] =>
2025-10-13 10:38:02.287028 | controller |   msg: Starting scans for high
2025-10-13 10:38:02.287064 | controller |
2025-10-13 10:38:02.287072 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-10-13 10:38:02.287079 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.017)       0:00:24.060 ********
2025-10-13 10:38:02.287089 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-high)
2025-10-13 10:38:02.309541 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-high-node)
2025-10-13 10:38:02.309572 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-high)
2025-10-13 10:38:02.309580 | controller |
2025-10-13 10:38:02.309586 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:02.309592 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.037)       0:00:24.097 ********
2025-10-13 10:38:02.309607 | controller | ok: [instance]
2025-10-13 10:38:02.326610 | controller |
2025-10-13 10:38:02.326633 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:02.326641 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.022)       0:00:24.120 ********
2025-10-13 10:38:02.326650 | controller | skipping: [instance]
2025-10-13 10:38:02.343760 | controller |
2025-10-13 10:38:02.343784 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:02.343792 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.017)       0:00:24.137 ********
2025-10-13 10:38:02.343802 | controller | skipping: [instance]
2025-10-13 10:38:02.521467 | controller |
2025-10-13 10:38:02.521502 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:02.521510 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.017)       0:00:24.155 ********
2025-10-13 10:38:02.521520 | controller | changed: [instance]
2025-10-13 10:38:02.706703 | controller |
2025-10-13 10:38:02.706734 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:02.706742 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.177)       0:00:24.332 ********
2025-10-13 10:38:02.706752 | controller | changed: [instance]
2025-10-13 10:38:02.723130 | controller |
2025-10-13 10:38:02.723151 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:02.723159 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.185)       0:00:24.517 ********
2025-10-13 10:38:02.723171 | controller | skipping: [instance]
2025-10-13 10:38:02.898949 | controller |
2025-10-13 10:38:02.898983 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:02.898991 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.016)       0:00:24.534 ********
2025-10-13 10:38:02.899001 | controller | ok: [instance]
2025-10-13 10:38:02.913351 | controller |
2025-10-13 10:38:02.913367 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:02.913374 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.175)       0:00:24.709 ********
2025-10-13 10:38:02.913383 | controller | skipping: [instance]
2025-10-13 10:38:02.935752 | controller |
2025-10-13 10:38:02.935768 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:02.935774 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.014)       0:00:24.724 ********
2025-10-13 10:38:02.935783 | controller | ok: [instance]
2025-10-13 10:38:02.950483 | controller |
2025-10-13 10:38:02.950502 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:02.950510 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.022)       0:00:24.747 ********
2025-10-13 10:38:02.950521 | controller | skipping: [instance]
2025-10-13 10:38:02.965069 | controller |
2025-10-13 10:38:02.965087 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:02.965096 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.014)       0:00:24.761 ********
2025-10-13 10:38:02.965106 | controller | skipping: [instance]
2025-10-13 10:38:03.143177 | controller |
2025-10-13 10:38:03.143206 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:03.143214 | controller | Monday 13 October 2025  10:38:02 +0000 (0:00:00.014)       0:00:24.776 ********
2025-10-13 10:38:03.143224 | controller | changed: [instance]
2025-10-13 10:38:03.339094 | controller |
2025-10-13 10:38:03.339123 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:03.339137 | controller | Monday 13 October 2025  10:38:03 +0000 (0:00:00.177)       0:00:24.954 ********
2025-10-13 10:38:03.339148 | controller | changed: [instance]
2025-10-13 10:38:03.354956 | controller |
2025-10-13 10:38:03.354978 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:03.354985 | controller | Monday 13 October 2025  10:38:03 +0000 (0:00:00.195)       0:00:25.149 ********
2025-10-13 10:38:03.354994 | controller | skipping: [instance]
2025-10-13 10:38:03.527954 | controller |
2025-10-13 10:38:03.527986 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:03.528000 | controller | Monday 13 October 2025  10:38:03 +0000 (0:00:00.016)       0:00:25.166 ********
2025-10-13 10:38:03.528010 | controller | ok: [instance]
2025-10-13 10:38:03.541472 | controller |
2025-10-13 10:38:03.541492 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:03.541500 | controller | Monday 13 October 2025  10:38:03 +0000 (0:00:00.172)       0:00:25.338 ********
2025-10-13 10:38:03.541511 | controller | skipping: [instance]
2025-10-13 10:38:03.563777 | controller |
2025-10-13 10:38:03.563798 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:03.563806 | controller | Monday 13 October 2025  10:38:03 +0000 (0:00:00.013)       0:00:25.352 ********
2025-10-13 10:38:03.563815 | controller | ok: [instance]
2025-10-13 10:38:03.580508 | controller |
2025-10-13 10:38:03.580527 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:03.580535 | controller | Monday 13 October 2025  10:38:03 +0000 (0:00:00.022)       0:00:25.374 ********
2025-10-13 10:38:03.580544 | controller | skipping: [instance]
2025-10-13 10:38:03.597006 | controller |
2025-10-13 10:38:03.597041 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:03.597051 | controller | Monday 13 October 2025  10:38:03 +0000 (0:00:00.016)       0:00:25.391 ********
2025-10-13 10:38:03.597070 | controller | skipping: [instance]
2025-10-13 10:38:03.597092 | controller |
2025-10-13 10:38:03.597101 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:03.597223 | controller | Monday 13 October 2025  10:38:03 +0000 (0:00:00.016)       0:00:25.408 ********
2025-10-13 10:38:03.773777 | controller | changed: [instance]
2025-10-13 10:38:03.974802 | controller |
2025-10-13 10:38:03.974832 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:03.974841 | controller | Monday 13 October 2025  10:38:03 +0000 (0:00:00.176)       0:00:25.584 ********
2025-10-13 10:38:03.974851 | controller | changed: [instance]
2025-10-13 10:38:03.991506 | controller |
2025-10-13 10:38:03.991533 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:03.991541 | controller | Monday 13 October 2025  10:38:03 +0000 (0:00:00.201)       0:00:25.785 ********
2025-10-13 10:38:03.991550 | controller | skipping: [instance]
2025-10-13 10:38:04.164636 | controller |
2025-10-13 10:38:04.164666 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:04.164674 | controller | Monday 13 October 2025  10:38:03 +0000 (0:00:00.016)       0:00:25.802 ********
2025-10-13 10:38:04.164684 | controller | ok: [instance]
2025-10-13 10:38:04.178990 | controller |
2025-10-13 10:38:04.179021 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:04.179029 | controller | Monday 13 October 2025  10:38:04 +0000 (0:00:00.172)       0:00:25.975 ********
2025-10-13 10:38:04.179040 | controller | skipping: [instance]
2025-10-13 10:38:04.197697 | controller |
2025-10-13 10:38:04.197717 | controller | TASK [compliance : Log start of scans] *****************************************
2025-10-13 10:38:04.197724 | controller | Monday 13 October 2025  10:38:04 +0000 (0:00:00.014)       0:00:25.990 ********
2025-10-13 10:38:04.197733 | controller | ok: [instance] =>
2025-10-13 10:38:04.234974 | controller |   msg: Starting scans for moderate
2025-10-13 10:38:04.235012 | controller |
2025-10-13 10:38:04.235022 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-10-13 10:38:04.235029 | controller | Monday 13 October 2025  10:38:04 +0000 (0:00:00.018)       0:00:26.008 ********
2025-10-13 10:38:04.235041 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-moderate)
2025-10-13 10:38:04.235070 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-moderate-node)
2025-10-13 10:38:04.235078 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-moderate)
2025-10-13 10:38:04.235086 | controller |
2025-10-13 10:38:04.235256 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:04.258350 | controller | Monday 13 October 2025  10:38:04 +0000 (0:00:00.037)       0:00:26.046 ********
2025-10-13 10:38:04.258371 | controller | ok: [instance]
2025-10-13 10:38:04.275024 | controller |
2025-10-13 10:38:04.275046 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:04.275055 | controller | Monday 13 October 2025  10:38:04 +0000 (0:00:00.023)       0:00:26.069 ********
2025-10-13 10:38:04.275066 | controller | skipping: [instance]
2025-10-13 10:38:04.292151 | controller |
2025-10-13 10:38:04.292168 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:04.292182 | controller | Monday 13 October 2025  10:38:04 +0000 (0:00:00.016)       0:00:26.086 ********
2025-10-13 10:38:04.292191 | controller | skipping: [instance]
2025-10-13 10:38:04.467755 | controller |
2025-10-13 10:38:04.467785 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:04.467793 | controller | Monday 13 October 2025  10:38:04 +0000 (0:00:00.017)       0:00:26.103 ********
2025-10-13 10:38:04.467802 | controller | changed: [instance]
2025-10-13 10:38:04.652574 | controller |
2025-10-13 10:38:04.652606 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:04.652614 | controller | Monday 13 October 2025  10:38:04 +0000 (0:00:00.175)       0:00:26.278 ********
2025-10-13 10:38:04.652624 | controller | changed: [instance]
2025-10-13 10:38:04.668938 | controller |
2025-10-13 10:38:04.668961 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:04.668968 | controller | Monday 13 October 2025  10:38:04 +0000 (0:00:00.184)       0:00:26.463 ********
2025-10-13 10:38:04.668978 | controller | skipping: [instance]
2025-10-13 10:38:04.841360 | controller |
2025-10-13 10:38:04.841389 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:04.841397 | controller | Monday 13 October 2025  10:38:04 +0000 (0:00:00.016)       0:00:26.480 ********
2025-10-13 10:38:04.841408 | controller | ok: [instance]
2025-10-13 10:38:04.855838 | controller |
2025-10-13 10:38:04.855857 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:04.855864 | controller | Monday 13 October 2025  10:38:04 +0000 (0:00:00.172)       0:00:26.652 ********
2025-10-13 10:38:04.855872 | controller | skipping: [instance]
2025-10-13 10:38:04.878500 | controller |
2025-10-13 10:38:04.878519 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:04.878526 | controller | Monday 13 October 2025  10:38:04 +0000 (0:00:00.014)       0:00:26.667 ********
2025-10-13 10:38:04.878535 | controller | ok: [instance]
2025-10-13 10:38:04.895870 | controller |
2025-10-13 10:38:04.895938 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:04.895946 | controller | Monday 13 October 2025  10:38:04 +0000 (0:00:00.022)       0:00:26.689 ********
2025-10-13 10:38:04.895955 | controller | skipping: [instance]
2025-10-13 10:38:04.913858 | controller |
2025-10-13 10:38:04.913891 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:04.913916 | controller | Monday 13 October 2025  10:38:04 +0000 (0:00:00.017)       0:00:26.706 ********
2025-10-13 10:38:04.913926 | controller | skipping: [instance]
2025-10-13 10:38:05.108624 | controller |
2025-10-13 10:38:05.108652 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:05.108660 | controller | Monday 13 October 2025  10:38:04 +0000 (0:00:00.018)       0:00:26.725 ********
2025-10-13 10:38:05.108669 | controller | changed: [instance]
2025-10-13 10:38:05.305984 | controller |
2025-10-13 10:38:05.306014 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:05.306022 | controller | Monday 13 October 2025  10:38:05 +0000 (0:00:00.194)       0:00:26.919 ********
2025-10-13 10:38:05.306032 | controller | changed: [instance]
2025-10-13 10:38:05.325916 | controller |
2025-10-13 10:38:05.325951 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:05.325959 | controller | Monday 13 October 2025  10:38:05 +0000 (0:00:00.197)       0:00:27.116 ********
2025-10-13 10:38:05.325969 | controller | skipping: [instance]
2025-10-13 10:38:05.515003 | controller |
2025-10-13 10:38:05.515033 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:05.515041 | controller | Monday 13 October 2025  10:38:05 +0000 (0:00:00.019)       0:00:27.136 ********
2025-10-13 10:38:05.515051 | controller | ok: [instance]
2025-10-13 10:38:05.515071 | controller |
2025-10-13 10:38:05.515078 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:05.515086 | controller | Monday 13 October 2025  10:38:05 +0000 (0:00:00.189)       0:00:27.325 ********
2025-10-13 10:38:05.530326 | controller | skipping: [instance]
2025-10-13 10:38:05.554892 | controller |
2025-10-13 10:38:05.554928 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:05.554936 | controller | Monday 13 October 2025  10:38:05 +0000 (0:00:00.015)       0:00:27.341 ********
2025-10-13 10:38:05.554945 | controller | ok: [instance]
2025-10-13 10:38:05.572805 | controller |
2025-10-13 10:38:05.572829 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:05.572837 | controller | Monday 13 October 2025  10:38:05 +0000 (0:00:00.024)       0:00:27.365 ********
2025-10-13 10:38:05.572853 | controller | skipping: [instance]
2025-10-13 10:38:05.589987 | controller |
2025-10-13 10:38:05.590008 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:05.590016 | controller | Monday 13 October 2025  10:38:05 +0000 (0:00:00.017)       0:00:27.383 ********
2025-10-13 10:38:05.590025 | controller | skipping: [instance]
2025-10-13 10:38:05.590305 | controller |
2025-10-13 10:38:05.770868 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:05.770955 | controller | Monday 13 October 2025  10:38:05 +0000 (0:00:00.017)       0:00:27.401 ********
2025-10-13 10:38:05.770968 | controller | changed: [instance]
2025-10-13 10:38:05.949743 | controller |
2025-10-13 10:38:05.949772 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:05.949780 | controller | Monday 13 October 2025  10:38:05 +0000 (0:00:00.180)       0:00:27.581 ********
2025-10-13 10:38:05.949790 | controller | changed: [instance]
2025-10-13 10:38:05.965953 | controller |
2025-10-13 10:38:05.965976 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:05.965984 | controller | Monday 13 October 2025  10:38:05 +0000 (0:00:00.178)       0:00:27.760 ********
2025-10-13 10:38:05.965993 | controller | skipping: [instance]
2025-10-13 10:38:05.966244 | controller |
2025-10-13 10:38:05.966259 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:06.136587 | controller | Monday 13 October 2025  10:38:05 +0000 (0:00:00.016)       0:00:27.777 ********
2025-10-13 10:38:06.136619 | controller | ok: [instance]
2025-10-13 10:38:06.151468 | controller |
2025-10-13 10:38:06.151492 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:06.151500 | controller | Monday 13 October 2025  10:38:06 +0000 (0:00:00.170)       0:00:27.947 ********
2025-10-13 10:38:06.151511 | controller | skipping: [instance]
2025-10-13 10:38:06.170602 | controller |
2025-10-13 10:38:06.170618 | controller | TASK [compliance : Log start of scans] *****************************************
2025-10-13 10:38:06.170625 | controller | Monday 13 October 2025  10:38:06 +0000 (0:00:00.015)       0:00:27.962 ********
2025-10-13 10:38:06.170634 | controller | ok: [instance] =>
2025-10-13 10:38:06.202031 | controller |   msg: Starting scans for nerc-cip
2025-10-13 10:38:06.202067 | controller |
2025-10-13 10:38:06.202076 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-10-13 10:38:06.202084 | controller | Monday 13 October 2025  10:38:06 +0000 (0:00:00.019)       0:00:27.981 ********
2025-10-13 10:38:06.202095 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-nerc-cip)
2025-10-13 10:38:06.202124 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-nerc-cip-node)
2025-10-13 10:38:06.202134 | controller |
2025-10-13 10:38:06.202379 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:06.225480 | controller | Monday 13 October 2025  10:38:06 +0000 (0:00:00.031)       0:00:28.013 ********
2025-10-13 10:38:06.225505 | controller | ok: [instance]
2025-10-13 10:38:06.241963 | controller |
2025-10-13 10:38:06.241980 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:06.241987 | controller | Monday 13 October 2025  10:38:06 +0000 (0:00:00.023)       0:00:28.036 ********
2025-10-13 10:38:06.241995 | controller | skipping: [instance]
2025-10-13 10:38:06.261294 | controller |
2025-10-13 10:38:06.261311 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:06.261317 | controller | Monday 13 October 2025  10:38:06 +0000 (0:00:00.016)       0:00:28.053 ********
2025-10-13 10:38:06.261326 | controller | skipping: [instance]
2025-10-13 10:38:06.438660 | controller |
2025-10-13 10:38:06.438689 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:06.438697 | controller | Monday 13 October 2025  10:38:06 +0000 (0:00:00.019)       0:00:28.072 ********
2025-10-13 10:38:06.438706 | controller | changed: [instance]
2025-10-13 10:38:06.619715 | controller |
2025-10-13 10:38:06.619744 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:06.619752 | controller | Monday 13 October 2025  10:38:06 +0000 (0:00:00.177)       0:00:28.249 ********
2025-10-13 10:38:06.619761 | controller | changed: [instance]
2025-10-13 10:38:06.635735 | controller |
2025-10-13 10:38:06.635763 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:06.635771 | controller | Monday 13 October 2025  10:38:06 +0000 (0:00:00.181)       0:00:28.430 ********
2025-10-13 10:38:06.635781 | controller | skipping: [instance]
2025-10-13 10:38:06.800848 | controller |
2025-10-13 10:38:06.800875 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:06.800914 | controller | Monday 13 October 2025  10:38:06 +0000 (0:00:00.016)       0:00:28.446 ********
2025-10-13 10:38:06.800929 | controller | ok: [instance]
2025-10-13 10:38:06.814019 | controller |
2025-10-13 10:38:06.814042 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:06.814049 | controller | Monday 13 October 2025  10:38:06 +0000 (0:00:00.164)       0:00:28.611 ********
2025-10-13 10:38:06.814059 | controller | skipping: [instance]
2025-10-13 10:38:06.835480 | controller |
2025-10-13 10:38:06.835505 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:06.835514 | controller | Monday 13 October 2025  10:38:06 +0000 (0:00:00.013)       0:00:28.625 ********
2025-10-13 10:38:06.835525 | controller | ok: [instance]
2025-10-13 10:38:06.849967 | controller |
2025-10-13 10:38:06.849991 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:06.849998 | controller | Monday 13 October 2025  10:38:06 +0000 (0:00:00.021)       0:00:28.646 ********
2025-10-13 10:38:06.850008 | controller | skipping: [instance]
2025-10-13 10:38:06.850029 | controller |
2025-10-13 10:38:06.850037 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:06.850113 | controller | Monday 13 October 2025  10:38:06 +0000 (0:00:00.014)       0:00:28.661 ********
2025-10-13 10:38:06.865033 | controller | skipping: [instance]
2025-10-13 10:38:07.035426 | controller |
2025-10-13 10:38:07.035454 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:07.035462 | controller | Monday 13 October 2025  10:38:06 +0000 (0:00:00.014)       0:00:28.676 ********
2025-10-13 10:38:07.035472 | controller | changed: [instance]
2025-10-13 10:38:07.216534 | controller |
2025-10-13 10:38:07.216562 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:07.216570 | controller | Monday 13 October 2025  10:38:07 +0000 (0:00:00.170)       0:00:28.846 ********
2025-10-13 10:38:07.216580 | controller | changed: [instance]
2025-10-13 10:38:07.231956 | controller |
2025-10-13 10:38:07.231985 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:07.231994 | controller | Monday 13 October 2025  10:38:07 +0000 (0:00:00.181)       0:00:29.027 ********
2025-10-13 10:38:07.232004 | controller | skipping: [instance]
2025-10-13 10:38:07.232144 | controller |
2025-10-13 10:38:07.232162 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:07.397615 | controller | Monday 13 October 2025  10:38:07 +0000 (0:00:00.015)       0:00:29.043 ********
2025-10-13 10:38:07.397647 | controller | ok: [instance]
2025-10-13 10:38:07.410594 | controller |
2025-10-13 10:38:07.410620 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:07.410629 | controller | Monday 13 October 2025  10:38:07 +0000 (0:00:00.165)       0:00:29.208 ********
2025-10-13 10:38:07.410639 | controller | skipping: [instance]
2025-10-13 10:38:07.427803 | controller |
2025-10-13 10:38:07.427828 | controller | TASK [compliance : Log start of scans] *****************************************
2025-10-13 10:38:07.427837 | controller | Monday 13 October 2025  10:38:07 +0000 (0:00:00.013)       0:00:29.221 ********
2025-10-13 10:38:07.427847 | controller | ok: [instance] =>
2025-10-13 10:38:07.458009 | controller |   msg: Starting scans for pci-dss
2025-10-13 10:38:07.458036 | controller |
2025-10-13 10:38:07.458045 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-10-13 10:38:07.458053 | controller | Monday 13 October 2025  10:38:07 +0000 (0:00:00.017)       0:00:29.238 ********
2025-10-13 10:38:07.458064 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-pci-dss)
2025-10-13 10:38:07.458097 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-pci-dss-node)
2025-10-13 10:38:07.458115 | controller |
2025-10-13 10:38:07.458123 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:07.458133 | controller | Monday 13 October 2025  10:38:07 +0000 (0:00:00.030)       0:00:29.269 ********
2025-10-13 10:38:07.479681 | controller | ok: [instance]
2025-10-13 10:38:07.494511 | controller |
2025-10-13 10:38:07.494533 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:07.494541 | controller | Monday 13 October 2025  10:38:07 +0000 (0:00:00.021)       0:00:29.290 ********
2025-10-13 10:38:07.494550 | controller | skipping: [instance]
2025-10-13 10:38:07.509067 | controller |
2025-10-13 10:38:07.509089 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:07.509096 | controller | Monday 13 October 2025  10:38:07 +0000 (0:00:00.015)       0:00:29.305 ********
2025-10-13 10:38:07.509104 | controller | skipping: [instance]
2025-10-13 10:38:07.683148 | controller |
2025-10-13 10:38:07.683176 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:07.683184 | controller | Monday 13 October 2025  10:38:07 +0000 (0:00:00.014)       0:00:29.320 ********
2025-10-13 10:38:07.683193 | controller | changed: [instance]
2025-10-13 10:38:07.874825 | controller |
2025-10-13 10:38:07.874853 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:07.874867 | controller | Monday 13 October 2025  10:38:07 +0000 (0:00:00.173)       0:00:29.494 ********
2025-10-13 10:38:07.874877 | controller | changed: [instance]
2025-10-13 10:38:07.890299 | controller |
2025-10-13 10:38:07.890324 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:07.890331 | controller | Monday 13 October 2025  10:38:07 +0000 (0:00:00.191)       0:00:29.685 ********
2025-10-13 10:38:07.890341 | controller | skipping: [instance]
2025-10-13 10:38:08.057811 | controller |
2025-10-13 10:38:08.057841 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:08.057849 | controller | Monday 13 October 2025  10:38:07 +0000 (0:00:00.015)       0:00:29.701 ********
2025-10-13 10:38:08.057859 | controller | ok: [instance]
2025-10-13 10:38:08.070836 | controller |
2025-10-13 10:38:08.070862 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:08.070871 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.167)       0:00:29.868 ********
2025-10-13 10:38:08.070882 | controller | skipping: [instance]
2025-10-13 10:38:08.091545 | controller |
2025-10-13 10:38:08.091566 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:08.091573 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.013)       0:00:29.881 ********
2025-10-13 10:38:08.091587 | controller | ok: [instance]
2025-10-13 10:38:08.106527 | controller |
2025-10-13 10:38:08.106549 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:08.106556 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.020)       0:00:29.902 ********
2025-10-13 10:38:08.106565 | controller | skipping: [instance]
2025-10-13 10:38:08.120978 | controller |
2025-10-13 10:38:08.121002 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:08.121011 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.015)       0:00:29.917 ********
2025-10-13 10:38:08.121022 | controller | skipping: [instance]
2025-10-13 10:38:08.121050 | controller |
2025-10-13 10:38:08.121277 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:08.289987 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.014)       0:00:29.932 ********
2025-10-13 10:38:08.290019 | controller | changed: [instance]
2025-10-13 10:38:08.290391 | controller |
2025-10-13 10:38:08.474947 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:08.474983 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.168)       0:00:30.101 ********
2025-10-13 10:38:08.474995 | controller | changed: [instance]
2025-10-13 10:38:08.490392 | controller |
2025-10-13 10:38:08.490418 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:08.490426 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.184)       0:00:30.285 ********
2025-10-13 10:38:08.490436 | controller | skipping: [instance]
2025-10-13 10:38:08.657125 | controller |
2025-10-13 10:38:08.657153 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:08.657161 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.015)       0:00:30.301 ********
2025-10-13 10:38:08.657171 | controller | ok: [instance]
2025-10-13 10:38:08.670706 | controller |
2025-10-13 10:38:08.670728 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:08.670735 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.166)       0:00:30.468 ********
2025-10-13 10:38:08.670745 | controller | skipping: [instance]
2025-10-13 10:38:08.687983 | controller |
2025-10-13 10:38:08.688013 | controller | TASK [compliance : Log start of scans] *****************************************
2025-10-13 10:38:08.688022 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.013)       0:00:30.481 ********
2025-10-13 10:38:08.688035 | controller | ok: [instance] =>
2025-10-13 10:38:08.688060 | controller |   msg: Starting scans for stig
2025-10-13 10:38:08.688076 | controller |
2025-10-13 10:38:08.688101 | controller | TASK [compliance : Run scans and extract results] ******************************
2025-10-13 10:38:08.688224 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.017)       0:00:30.499 ********
2025-10-13 10:38:08.724828 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-stig)
2025-10-13 10:38:08.764457 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=ocp4-stig-node)
2025-10-13 10:38:08.764489 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/compliance/tasks/run_operator_scan.yml for instance => (item=rhcos4-stig)
2025-10-13 10:38:08.764499 | controller |
2025-10-13 10:38:08.764506 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:08.764514 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.036)       0:00:30.535 ********
2025-10-13 10:38:08.764525 | controller | ok: [instance]
2025-10-13 10:38:08.780278 | controller |
2025-10-13 10:38:08.780305 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:08.780312 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.039)       0:00:30.575 ********
2025-10-13 10:38:08.780322 | controller | skipping: [instance]
2025-10-13 10:38:08.795744 | controller |
2025-10-13 10:38:08.795774 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:08.795782 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.015)       0:00:30.591 ********
2025-10-13 10:38:08.795795 | controller | skipping: [instance]
2025-10-13 10:38:08.971974 | controller |
2025-10-13 10:38:08.972003 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:08.972011 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.015)       0:00:30.606 ********
2025-10-13 10:38:08.972021 | controller | changed: [instance]
2025-10-13 10:38:09.156517 | controller |
2025-10-13 10:38:09.156546 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:09.156554 | controller | Monday 13 October 2025  10:38:08 +0000 (0:00:00.176)       0:00:30.782 ********
2025-10-13 10:38:09.156564 | controller | changed: [instance]
2025-10-13 10:38:09.171976 | controller |
2025-10-13 10:38:09.171998 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:09.172006 | controller | Monday 13 October 2025  10:38:09 +0000 (0:00:00.184)       0:00:30.967 ********
2025-10-13 10:38:09.172015 | controller | skipping: [instance]
2025-10-13 10:38:09.346379 | controller |
2025-10-13 10:38:09.346408 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:09.346416 | controller | Monday 13 October 2025  10:38:09 +0000 (0:00:00.015)       0:00:30.983 ********
2025-10-13 10:38:09.346426 | controller | ok: [instance]
2025-10-13 10:38:09.361293 | controller |
2025-10-13 10:38:09.361320 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:09.361329 | controller | Monday 13 October 2025  10:38:09 +0000 (0:00:00.174)       0:00:31.157 ********
2025-10-13 10:38:09.361340 | controller | skipping: [instance]
2025-10-13 10:38:09.384393 | controller |
2025-10-13 10:38:09.384417 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:09.384424 | controller | Monday 13 October 2025  10:38:09 +0000 (0:00:00.014)       0:00:31.172 ********
2025-10-13 10:38:09.384433 | controller | ok: [instance]
2025-10-13 10:38:09.400948 | controller |
2025-10-13 10:38:09.400970 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:09.400977 | controller | Monday 13 October 2025  10:38:09 +0000 (0:00:00.023)       0:00:31.195 ********
2025-10-13 10:38:09.400986 | controller | skipping: [instance]
2025-10-13 10:38:09.417738 | controller |
2025-10-13 10:38:09.417758 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:09.417764 | controller | Monday 13 October 2025  10:38:09 +0000 (0:00:00.016)       0:00:31.212 ********
2025-10-13 10:38:09.417774 | controller | skipping: [instance]
2025-10-13 10:38:09.596012 | controller |
2025-10-13 10:38:09.596045 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:09.596054 | controller | Monday 13 October 2025  10:38:09 +0000 (0:00:00.016)       0:00:31.228 ********
2025-10-13 10:38:09.596065 | controller | changed: [instance]
2025-10-13 10:38:09.783439 | controller |
2025-10-13 10:38:09.783469 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:09.783476 | controller | Monday 13 October 2025  10:38:09 +0000 (0:00:00.177)       0:00:31.406 ********
2025-10-13 10:38:09.783493 | controller | changed: [instance]
2025-10-13 10:38:09.783513 | controller |
2025-10-13 10:38:09.783759 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:09.800344 | controller | Monday 13 October 2025  10:38:09 +0000 (0:00:00.187)       0:00:31.594 ********
2025-10-13 10:38:09.800371 | controller | skipping: [instance]
2025-10-13 10:38:09.971499 | controller |
2025-10-13 10:38:09.971527 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:09.971535 | controller | Monday 13 October 2025  10:38:09 +0000 (0:00:00.016)       0:00:31.611 ********
2025-10-13 10:38:09.971545 | controller | ok: [instance]
2025-10-13 10:38:09.985887 | controller |
2025-10-13 10:38:09.985938 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:09.985946 | controller | Monday 13 October 2025  10:38:09 +0000 (0:00:00.170)       0:00:31.782 ********
2025-10-13 10:38:09.985957 | controller | skipping: [instance]
2025-10-13 10:38:10.009141 | controller |
2025-10-13 10:38:10.009165 | controller | TASK [compliance : Set output directory] ***************************************
2025-10-13 10:38:10.009177 | controller | Monday 13 October 2025  10:38:09 +0000 (0:00:00.014)       0:00:31.797 ********
2025-10-13 10:38:10.009186 | controller | ok: [instance]
2025-10-13 10:38:10.025415 | controller |
2025-10-13 10:38:10.025433 | controller | TASK [compliance : Create scan binding] ****************************************
2025-10-13 10:38:10.025444 | controller | Monday 13 October 2025  10:38:10 +0000 (0:00:00.023)       0:00:31.820 ********
2025-10-13 10:38:10.025453 | controller | skipping: [instance]
2025-10-13 10:38:10.041874 | controller |
2025-10-13 10:38:10.041927 | controller | TASK [compliance : Wait for the scan to complete] ******************************
2025-10-13 10:38:10.041937 | controller | Monday 13 October 2025  10:38:10 +0000 (0:00:00.016)       0:00:31.836 ********
2025-10-13 10:38:10.041946 | controller | skipping: [instance]
2025-10-13 10:38:10.218657 | controller |
2025-10-13 10:38:10.218685 | controller | TASK [compliance : Delete directory for scan results if it exists] *************
2025-10-13 10:38:10.218693 | controller | Monday 13 October 2025  10:38:10 +0000 (0:00:00.016)       0:00:31.853 ********
2025-10-13 10:38:10.218703 | controller | changed: [instance]
2025-10-13 10:38:10.403718 | controller |
2025-10-13 10:38:10.403747 | controller | TASK [compliance : Create directory for scan results] **************************
2025-10-13 10:38:10.403755 | controller | Monday 13 October 2025  10:38:10 +0000 (0:00:00.176)       0:00:32.029 ********
2025-10-13 10:38:10.403764 | controller | changed: [instance]
2025-10-13 10:38:10.420320 | controller |
2025-10-13 10:38:10.420345 | controller | TASK [compliance : Retrieve scan results] **************************************
2025-10-13 10:38:10.420353 | controller | Monday 13 October 2025  10:38:10 +0000 (0:00:00.185)       0:00:32.214 ********
2025-10-13 10:38:10.420363 | controller | skipping: [instance]
2025-10-13 10:38:10.588874 | controller |
2025-10-13 10:38:10.588939 | controller | TASK [compliance : Find all the compressed scan results] ***********************
2025-10-13 10:38:10.588948 | controller | Monday 13 October 2025  10:38:10 +0000 (0:00:00.016)       0:00:32.231 ********
2025-10-13 10:38:10.588958 | controller | ok: [instance]
2025-10-13 10:38:10.603502 | controller |
2025-10-13 10:38:10.603521 | controller | TASK [compliance : Process scan result files] **********************************
2025-10-13 10:38:10.603528 | controller | Monday 13 October 2025  10:38:10 +0000 (0:00:00.168)       0:00:32.399 ********
2025-10-13 10:38:10.603537 | controller | skipping: [instance]
2025-10-13 10:38:10.635968 | controller |
2025-10-13 10:38:10.635988 | controller | TASK [compliance : Delete all resources created by the role] *******************
2025-10-13 10:38:10.635995 | controller | Monday 13 October 2025  10:38:10 +0000 (0:00:00.014)       0:00:32.414 ********
2025-10-13 10:38:10.636004 | controller | skipping: [instance]
2025-10-13 10:38:10.636033 | controller |
2025-10-13 10:38:10.636260 | controller | PLAY RECAP *********************************************************************
2025-10-13 10:38:10.637954 | controller | instance                   : ok=200  changed=52   unreachable=0    failed=0    skipped=152  rescued=0    ignored=0
2025-10-13 10:38:10.637976 | controller |
2025-10-13 10:38:10.638471 | controller | Monday 13 October 2025  10:38:10 +0000 (0:00:00.032)       0:00:32.447 ********
2025-10-13 10:38:10.638484 | controller | ===============================================================================
2025-10-13 10:38:10.638490 | controller | compliance : Install packages to process results ------------------------ 5.34s
2025-10-13 10:38:10.638496 | controller | Gathering Facts --------------------------------------------------------- 1.59s
2025-10-13 10:38:10.638501 | controller | Gathering Facts --------------------------------------------------------- 0.82s
2025-10-13 10:38:10.638506 | controller | podman : Ensure podman is installed ------------------------------------- 0.77s
2025-10-13 10:38:10.638511 | controller | compliance : Install packages to process results ------------------------ 0.66s
2025-10-13 10:38:10.638517 | controller | podman : Ensure podman is installed ------------------------------------- 0.65s
2025-10-13 10:38:10.638522 | controller | podman : Enable loginctl linger for ansible_user_id --------------------- 0.38s
2025-10-13 10:38:10.638527 | controller | compliance : Ensure compliance folder exists ---------------------------- 0.30s
2025-10-13 10:38:10.638532 | controller | compliance : Find all the compressed scan results ----------------------- 0.28s
2025-10-13 10:38:10.638537 | controller | compliance : Ensure compliance folder exists ---------------------------- 0.21s
2025-10-13 10:38:10.638547 | controller | podman : Enable loginctl linger for ansible_user_id --------------------- 0.21s
2025-10-13 10:38:10.638552 | controller | compliance : Create directory for scan results -------------------------- 0.20s
2025-10-13 10:38:10.638558 | controller | compliance : Create directory for scan results -------------------------- 0.20s
2025-10-13 10:38:10.638566 | controller | compliance : Create directory for scan results -------------------------- 0.20s
2025-10-13 10:38:10.638572 | controller | compliance : Delete directory for scan results if it exists ------------- 0.19s
2025-10-13 10:38:10.638579 | controller | compliance : Create directory for scan results -------------------------- 0.19s
2025-10-13 10:38:10.698568 | controller | compliance : Create directory for scan results -------------------------- 0.19s
2025-10-13 10:38:10.698594 | controller | compliance : Create directory for scan results -------------------------- 0.19s
2025-10-13 10:38:10.698602 | controller | compliance : Find all the compressed scan results ----------------------- 0.19s
2025-10-13 10:38:10.698608 | controller | compliance : Delete directory for scan results if it exists ------------- 0.19s
2025-10-13 10:38:10.698617 | controller | INFO     Running default > cleanup
2025-10-13 10:38:10.699118 | controller | WARNING  Skipping, cleanup playbook not configured.
2025-10-13 10:38:10.699681 | controller | INFO     Writing /tmp/report.html report.
2025-10-13 10:38:11.072822 | controller | changed
2025-10-13 10:38:11.098412 | 
2025-10-13 10:38:11.098494 | PLAY RECAP
2025-10-13 10:38:11.098536 | controller | ok: 3 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-10-13 10:38:11.098560 | 
2025-10-13 10:38:11.175336 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-13 10:38:11.176244 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-13 10:38:11.728298 | 
2025-10-13 10:38:11.728393 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-10-13 10:38:11.748834 | 
2025-10-13 10:38:11.748927 | TASK [Filter out host if needed]
2025-10-13 10:38:11.757574 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-10-13 10:38:11.762192 | 
2025-10-13 10:38:11.762258 | TASK [Ensure file is present]
2025-10-13 10:38:12.065046 | controller | ok
2025-10-13 10:38:12.071697 | 
2025-10-13 10:38:12.071773 | TASK [Manage molecule report file]
2025-10-13 10:38:12.597939 | controller | changed
2025-10-13 10:38:12.603684 | 
2025-10-13 10:38:12.603748 | TASK [Check if we get ci-framework-data basedir]
2025-10-13 10:38:12.795304 | controller | ok
2025-10-13 10:38:12.801529 | 
2025-10-13 10:38:12.801635 | TASK [Create ci-framework-data log directory for zuul]
2025-10-13 10:38:13.133944 | controller | changed
2025-10-13 10:38:13.139407 | 
2025-10-13 10:38:13.139472 | TASK [Copy ci-framework interesting files]
2025-10-13 10:38:13.666998 | controller | changed
2025-10-13 10:38:13.672232 | 
2025-10-13 10:38:13.672313 | TASK [Get SELinux listing]
2025-10-13 10:38:14.199495 | controller | changed
2025-10-13 10:38:14.206024 | 
2025-10-13 10:38:14.206095 | TASK [Generate log index]
2025-10-13 10:38:14.833549 | controller | changed
2025-10-13 10:38:14.839437 | 
2025-10-13 10:38:14.839502 | TASK [Get some env related data]
2025-10-13 10:38:15.378931 | controller | /home/zuul/.local/bin/ansible
2025-10-13 10:38:16.369544 | controller | changed
2025-10-13 10:38:16.374751 | 
2025-10-13 10:38:16.374811 | TASK [Generate list of logs to collect in home directory]
2025-10-13 10:38:16.666266 | controller | ok: All paths examined
2025-10-13 10:38:16.671349 | 
2025-10-13 10:38:16.671413 | LOOP [Copy logs from home directory]
2025-10-13 10:38:16.979319 | controller | changed:
2025-10-13 10:38:16.979430 | controller | {
2025-10-13 10:38:16.979458 | controller |   "atime": 1760351809.3675497,
2025-10-13 10:38:16.979478 | controller |   "ctime": 1760351829.0476892,
2025-10-13 10:38:16.979495 | controller |   "dev": 64513,
2025-10-13 10:38:16.979512 | controller |   "gid": 1000,
2025-10-13 10:38:16.979528 | controller |   "gr_name": "zuul",
2025-10-13 10:38:16.979543 | controller |   "inode": 4482197,
2025-10-13 10:38:16.979559 | controller |   "isblk": false,
2025-10-13 10:38:16.979574 | controller |   "ischr": false,
2025-10-13 10:38:16.979602 | controller |   "isdir": false,
2025-10-13 10:38:16.979621 | controller |   "isfifo": false,
2025-10-13 10:38:16.979638 | controller |   "isgid": false,
2025-10-13 10:38:16.979653 | controller |   "islnk": false,
2025-10-13 10:38:16.979667 | controller |   "isreg": true,
2025-10-13 10:38:16.979686 | controller |   "issock": false,
2025-10-13 10:38:16.979701 | controller |   "isuid": false,
2025-10-13 10:38:16.979715 | controller |   "mode": "0644",
2025-10-13 10:38:16.979729 | controller |   "mtime": 1760351829.0476892,
2025-10-13 10:38:16.979744 | controller |   "nlink": 1,
2025-10-13 10:38:16.979760 | controller |   "path": "/home/zuul/ansible.log",
2025-10-13 10:38:16.979775 | controller |   "pw_name": "zuul",
2025-10-13 10:38:16.979791 | controller |   "rgrp": true,
2025-10-13 10:38:16.979806 | controller |   "roth": true,
2025-10-13 10:38:16.979820 | controller |   "rusr": true,
2025-10-13 10:38:16.979834 | controller |   "size": 6749,
2025-10-13 10:38:16.979848 | controller |   "uid": 1000,
2025-10-13 10:38:16.979862 | controller |   "wgrp": false,
2025-10-13 10:38:16.979875 | controller |   "woth": false,
2025-10-13 10:38:16.979889 | controller |   "wusr": true,
2025-10-13 10:38:16.979921 | controller |   "xgrp": false,
2025-10-13 10:38:16.979946 | controller |   "xoth": false,
2025-10-13 10:38:16.979964 | controller |   "xusr": false
2025-10-13 10:38:16.979980 | controller | }
2025-10-13 10:38:16.993713 | 
2025-10-13 10:38:16.993817 | TASK [Copy crio stats log file]
2025-10-13 10:38:17.007535 | controller | skipping: Conditional result was False
2025-10-13 10:38:17.013214 | 
2025-10-13 10:38:17.013279 | TASK [Get SELinux related data]
2025-10-13 10:38:17.213247 | controller | <no matches>
2025-10-13 10:38:17.539395 | controller | ERROR
2025-10-13 10:38:17.539584 | controller | {
2025-10-13 10:38:17.539645 | controller |   "delta": "0:00:00.008715",
2025-10-13 10:38:17.539674 | controller |   "end": "2025-10-13 10:38:17.214197",
2025-10-13 10:38:17.539698 | controller |   "msg": "non-zero return code",
2025-10-13 10:38:17.539719 | controller |   "rc": 1,
2025-10-13 10:38:17.539742 | controller |   "start": "2025-10-13 10:38:17.205482"
2025-10-13 10:38:17.539762 | controller | }
2025-10-13 10:38:17.539792 | controller | ERROR: Ignoring Errors
2025-10-13 10:38:17.545486 | 
2025-10-13 10:38:17.545551 | TASK [Create system configuration directory]
2025-10-13 10:38:17.728318 | controller | changed
2025-10-13 10:38:17.733147 | 
2025-10-13 10:38:17.733211 | TASK [Get some of the system configurations]
2025-10-13 10:38:18.261177 | controller | changed
2025-10-13 10:38:18.266361 | 
2025-10-13 10:38:18.266425 | TASK [Copy generated documentation if available]
2025-10-13 10:38:18.279819 | controller | skipping: Conditional result was False
2025-10-13 10:38:18.285663 | 
2025-10-13 10:38:18.285733 | TASK [Copy generated AsciiDoc documentation if available]
2025-10-13 10:38:18.299805 | controller | skipping: Conditional result was False
2025-10-13 10:38:18.305953 | 
2025-10-13 10:38:18.306029 | TASK [Compress logs bigger than 2MB]
2025-10-13 10:38:18.831030 | controller | changed
2025-10-13 10:38:18.836684 | 
2025-10-13 10:38:18.836751 | TASK [Copy files from workspace on node]
2025-10-13 10:38:18.854585 | controller | ok
2025-10-13 10:38:18.876744 | 
2025-10-13 10:38:18.876812 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-13 10:38:18.900134 | controller | skipping: Conditional result was False
2025-10-13 10:38:18.905351 | 
2025-10-13 10:38:18.905415 | TASK [fetch-output : Set log path for single node]
2025-10-13 10:38:18.934309 | controller | ok
2025-10-13 10:38:18.939039 | 
2025-10-13 10:38:18.939100 | LOOP [fetch-output : Ensure local output dirs]
2025-10-13 10:38:19.156444 | controller -> localhost | ok: "/var/lib/zuul/builds/c8032caa3f61452c9996978080f07825/work/logs"
2025-10-13 10:38:19.156681 | controller -> localhost | changed: All items complete
2025-10-13 10:38:19.156712 | 
2025-10-13 10:38:19.349585 | controller -> localhost | changed: "/var/lib/zuul/builds/c8032caa3f61452c9996978080f07825/work/artifacts"
2025-10-13 10:38:19.528111 | controller -> localhost | changed: "/var/lib/zuul/builds/c8032caa3f61452c9996978080f07825/work/docs"
2025-10-13 10:38:19.537077 | 
2025-10-13 10:38:19.537169 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-13 10:38:20.089729 | controller | changed:
2025-10-13 10:38:20.089988 | controller | .d..t...... ./
2025-10-13 10:38:20.090093 | controller | >f+++++++++ README.html
2025-10-13 10:38:20.090124 | controller | >f+++++++++ ansible-execution.log
2025-10-13 10:38:20.090148 | controller | >f+++++++++ ansible.log
2025-10-13 10:38:20.090168 | controller | >f+++++++++ dmesg.log
2025-10-13 10:38:20.090187 | controller | >f+++++++++ installed-pkgs.log
2025-10-13 10:38:20.090206 | controller | >f+++++++++ python.log
2025-10-13 10:38:20.090229 | controller | >f+++++++++ registries.conf
2025-10-13 10:38:20.090250 | controller | >f+++++++++ report.html
2025-10-13 10:38:20.090269 | controller | >f+++++++++ selinux-denials.log
2025-10-13 10:38:20.090289 | controller | >f+++++++++ selinux-listing.log
2025-10-13 10:38:20.090308 | controller | cd+++++++++ ci-framework-data/
2025-10-13 10:38:20.090616 | controller | cd+++++++++ ci-framework-data/artifacts/
2025-10-13 10:38:20.090646 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2025-10-13 10:38:20.090668 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2025-10-13 10:38:20.090687 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2025-10-13 10:38:20.090704 | controller | cd+++++++++ ci-framework-data/logs/
2025-10-13 10:38:20.090788 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2025-10-13 10:38:20.090815 | controller | cd+++++++++ ci-framework-data/tests/
2025-10-13 10:38:20.090835 | controller | cd+++++++++ ci-framework-data/tests/compliance/
2025-10-13 10:38:20.090854 | controller | cd+++++++++ ci-framework-data/tests/compliance/cis/
2025-10-13 10:38:20.090873 | controller | cd+++++++++ ci-framework-data/tests/compliance/cis/ocp4-cis/
2025-10-13 10:38:20.090890 | controller | cd+++++++++ ci-framework-data/tests/compliance/e8/
2025-10-13 10:38:20.090920 | controller | cd+++++++++ ci-framework-data/tests/compliance/e8/ocp4-e8/
2025-10-13 10:38:20.090945 | controller | cd+++++++++ ci-framework-data/tests/compliance/e8/rhcos4-e8/
2025-10-13 10:38:20.090964 | controller | cd+++++++++ ci-framework-data/tests/compliance/high/
2025-10-13 10:38:20.090982 | controller | cd+++++++++ ci-framework-data/tests/compliance/high/ocp4-high-node/
2025-10-13 10:38:20.090999 | controller | cd+++++++++ ci-framework-data/tests/compliance/high/ocp4-high/
2025-10-13 10:38:20.091016 | controller | cd+++++++++ ci-framework-data/tests/compliance/high/rhcos4-high/
2025-10-13 10:38:20.091032 | controller | cd+++++++++ ci-framework-data/tests/compliance/moderate/
2025-10-13 10:38:20.091048 | controller | cd+++++++++ ci-framework-data/tests/compliance/moderate/ocp4-moderate-node/
2025-10-13 10:38:20.091064 | controller | cd+++++++++ ci-framework-data/tests/compliance/moderate/ocp4-moderate/
2025-10-13 10:38:20.091079 | controller | cd+++++++++ ci-framework-data/tests/compliance/moderate/rhcos4-moderate/
2025-10-13 10:38:20.091128 | controller | cd+++++++++ ci-framework-data/tests/compliance/nerc-cip/
2025-10-13 10:38:20.091149 | controller | cd+++++++++ ci-framework-data/tests/compliance/nerc-cip/ocp4-nerc-cip-node/
2025-10-13 10:38:20.091168 | controller | cd+++++++++ ci-framework-data/tests/compliance/nerc-cip/ocp4-nerc-cip/
2025-10-13 10:38:20.091209 | controller | cd+++++++++ ci-framework-data/tests/compliance/pci-dss/
2025-10-13 10:38:20.091229 | controller | cd+++++++++ ci-framework-data/tests/compliance/pci-dss/ocp4-pci-dss-node/
2025-10-13 10:38:20.091247 | controller | cd+++++++++ ci-framework-data/tests/compliance/pci-dss/ocp4-pci-dss/
2025-10-13 10:38:20.091285 | controller | cd+++++++++ ci-framework-data/tests/compliance/stig/
2025-10-13 10:38:20.091306 | controller | cd+++++++++ ci-framework-data/tests/compliance/stig/ocp4-stig-node/
2025-10-13 10:38:20.091323 | controller | cd+++++++++ ci-framework-data/tests/compliance/stig/ocp4-stig/
2025-10-13 10:38:20.091359 | controller | cd+++++++++ ci-framework-data/tests/compliance/stig/rhcos4-stig/
2025-10-13 10:38:20.091381 | controller | cd+++++++++ registries.conf.d/
2025-10-13 10:38:20.091405 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-10-13 10:38:20.091444 | controller | cd+++++++++ system-config/
2025-10-13 10:38:20.091465 | controller | cd+++++++++ system-config/libvirt/
2025-10-13 10:38:20.091483 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2025-10-13 10:38:20.091519 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2025-10-13 10:38:20.463408 | controller | changed: .d..t...... ./
2025-10-13 10:38:20.851090 | controller | changed: .d..t...... ./
2025-10-13 10:38:20.863523 | 
2025-10-13 10:38:20.863603 | TASK [Return artifact to Zuul]
2025-10-13 10:38:20.892429 | controller | ok
2025-10-13 10:38:20.911783 | 
2025-10-13 10:38:20.911864 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-10-13 10:38:20.911977 | 
2025-10-13 10:38:20.912011 | PLAY RECAP
2025-10-13 10:38:20.912049 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2025-10-13 10:38:20.912071 | 
2025-10-13 10:38:20.990617 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-13 10:38:20.991815 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-13 10:38:21.551375 | 
2025-10-13 10:38:21.551470 | PLAY [all]
2025-10-13 10:38:21.570062 | 
2025-10-13 10:38:21.570138 | TASK [include_role : fetch-output]
2025-10-13 10:38:21.608627 | controller | ok
2025-10-13 10:38:21.625521 | 
2025-10-13 10:38:21.625616 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-13 10:38:21.668797 | controller | skipping: Conditional result was False
2025-10-13 10:38:21.674175 | 
2025-10-13 10:38:21.674243 | TASK [fetch-output : Set log path for single node]
2025-10-13 10:38:21.702091 | controller | ok
2025-10-13 10:38:21.707491 | 
2025-10-13 10:38:21.707563 | LOOP [fetch-output : Ensure local output dirs]
2025-10-13 10:38:22.065781 | controller -> localhost | ok: "/var/lib/zuul/builds/c8032caa3f61452c9996978080f07825/work/logs"
2025-10-13 10:38:22.261008 | controller -> localhost | ok: "/var/lib/zuul/builds/c8032caa3f61452c9996978080f07825/work/artifacts"
2025-10-13 10:38:22.450850 | controller -> localhost | ok: "/var/lib/zuul/builds/c8032caa3f61452c9996978080f07825/work/docs"
2025-10-13 10:38:22.461326 | 
2025-10-13 10:38:22.461394 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-13 10:38:23.004407 | controller | ok
2025-10-13 10:38:23.005324 | controller | ok: All items complete
2025-10-13 10:38:23.005367 | 
2025-10-13 10:38:23.393405 | controller | ok
2025-10-13 10:38:23.764458 | controller | ok
2025-10-13 10:38:23.776682 | 
2025-10-13 10:38:23.776784 | TASK [include_role : fetch-output-openshift]
2025-10-13 10:38:23.791889 | controller | skipping: Conditional result was False
2025-10-13 10:38:23.798140 | 
2025-10-13 10:38:23.798235 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-10-13 10:38:24.148673 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.005972
2025-10-13 10:38:24.361958 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007644
2025-10-13 10:38:24.396951 | 
2025-10-13 10:38:24.397031 | PLAY [all]
2025-10-13 10:38:24.411100 | 
2025-10-13 10:38:24.411165 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-10-13 10:38:24.817121 | controller | changed
2025-10-13 10:38:24.847974 | 
2025-10-13 10:38:24.848138 | PLAY RECAP
2025-10-13 10:38:24.848257 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-10-13 10:38:24.848353 | 
2025-10-13 10:38:24.943799 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-13 10:38:24.944554 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-10-13 10:38:25.612116 | 
2025-10-13 10:38:25.612236 | PLAY [localhost]
2025-10-13 10:38:25.631999 | 
2025-10-13 10:38:25.632146 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-10-13 10:38:25.991881 | localhost | changed
2025-10-13 10:38:25.996958 | 
2025-10-13 10:38:25.997055 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-10-13 10:38:26.025706 | localhost | ok
2025-10-13 10:38:26.034017 | 
2025-10-13 10:38:26.034102 | TASK [add-fileserver : Create SSH private key tempfile]
2025-10-13 10:38:26.350655 | localhost | changed
2025-10-13 10:38:26.356989 | 
2025-10-13 10:38:26.357066 | TASK [add-fileserver : Create SSH private key from secret]
2025-10-13 10:38:26.968710 | localhost | changed
2025-10-13 10:38:26.973861 | 
2025-10-13 10:38:26.974046 | TASK [add-fileserver : Add fileserver ssh key]
2025-10-13 10:38:27.336244 | localhost | Identity added: /var/lib/zuul/builds/c8032caa3f61452c9996978080f07825/work/tmp/ansible._ghidzv9 (/var/lib/zuul/builds/c8032caa3f61452c9996978080f07825/work/tmp/ansible._ghidzv9)
2025-10-13 10:38:27.336413 | localhost | ok: Runtime: 0:00:00.006722
2025-10-13 10:38:27.340774 | 
2025-10-13 10:38:27.340843 | TASK [add-fileserver : Remove SSH private key from disk]
2025-10-13 10:38:27.612439 | localhost | ok: Runtime: 0:00:00.032431
2025-10-13 10:38:27.617108 | 
2025-10-13 10:38:27.617177 | TASK [add-fileserver : Add fileserver to inventory]
2025-10-13 10:38:27.676283 | localhost | changed
2025-10-13 10:38:27.680428 | 
2025-10-13 10:38:27.680495 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-10-13 10:38:28.022162 | localhost | changed
2025-10-13 10:38:28.041862 | 
2025-10-13 10:38:28.041944 | PLAY [localhost]
2025-10-13 10:38:28.054716 | 
2025-10-13 10:38:28.054780 | TASK [Generate bulk log download script]
2025-10-13 10:38:28.079578 | localhost | ok
2025-10-13 10:38:28.091633 | 
2025-10-13 10:38:28.091703 | TASK [local-log-download : Check API endpoint is defined]
2025-10-13 10:38:28.119376 | localhost | ok: All assertions passed
2025-10-13 10:38:28.124036 | 
2025-10-13 10:38:28.124102 | TASK [local-log-download : Create download script]
2025-10-13 10:38:28.514461 | localhost -> localhost | changed
2025-10-13 10:38:28.523376 | 
2025-10-13 10:38:28.523452 | TASK [Register quick-download link]
2025-10-13 10:38:28.541244 | localhost | ok
2025-10-13 10:38:28.576845 | 
2025-10-13 10:38:28.576959 | PLAY [logserver.rdoproject.org]
2025-10-13 10:38:28.587039 | 
2025-10-13 10:38:28.587112 | TASK [Set zuul-log-path fact]
2025-10-13 10:38:28.602852 | logserver.rdoproject.org | ok
2025-10-13 10:38:28.612744 | 
2025-10-13 10:38:28.612819 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-13 10:38:28.639158 | logserver.rdoproject.org | ok
2025-10-13 10:38:28.644495 | 
2025-10-13 10:38:28.644566 | TASK [upload-logs : Create log directories]
2025-10-13 10:38:30.659076 | logserver.rdoproject.org | changed
2025-10-13 10:38:30.662239 | 
2025-10-13 10:38:30.662309 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-10-13 10:38:30.901312 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.006473
2025-10-13 10:38:30.906693 | 
2025-10-13 10:38:30.906781 | TASK [upload-logs : Upload logs to log server]
2025-10-13 10:38:32.467409 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-10-13 10:38:32.470622 | 
2025-10-13 10:38:32.470693 | LOOP [upload-logs : Compress console log and json output]
2025-10-13 10:38:32.525419 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-13 10:38:32.529216 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-13 10:38:32.539342 | 
2025-10-13 10:38:32.539451 | LOOP [upload-logs : Upload compressed console log and json output]
2025-10-13 10:38:32.574098 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-13 10:38:32.574344 | 
2025-10-13 10:38:32.577570 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-13 10:38:32.587242 | 
2025-10-13 10:38:32.587354 | LOOP [upload-logs : Upload console log and json output]