2025-12-03 09:35:05.612773 | Job console starting...
2025-12-03 09:35:05.823205 | Updating repositories
2025-12-03 09:35:06.570230 | Preparing job workspace
2025-12-03 09:35:13.688994 | Running Ansible setup...
2025-12-03 09:35:16.446496 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-12-03 09:35:16.909729 | 
2025-12-03 09:35:16.909823 | PLAY [localhost]
2025-12-03 09:35:16.917448 | 
2025-12-03 09:35:16.917513 | TASK [Gathering Facts]
2025-12-03 09:35:17.691836 | localhost | ok
2025-12-03 09:35:17.709388 | 
2025-12-03 09:35:17.709492 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-12-03 09:35:18.018865 | localhost -> localhost | changed
2025-12-03 09:35:18.024212 | 
2025-12-03 09:35:18.024306 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-12-03 09:35:18.715562 | localhost -> localhost | changed
2025-12-03 09:35:18.723669 | 
2025-12-03 09:35:18.723750 | TASK [Setup log path fact]
2025-12-03 09:35:18.741237 | localhost | ok
2025-12-03 09:35:18.752124 | 
2025-12-03 09:35:18.752193 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-12-03 09:35:18.768987 | localhost | ok
2025-12-03 09:35:18.776049 | 
2025-12-03 09:35:18.776130 | TASK [emit-job-header : Print job information]
2025-12-03 09:35:18.805439 | # Job Information
2025-12-03 09:35:18.805552 | Ansible Version: 2.15.12
2025-12-03 09:35:18.805582 | Job: edpm-ansible-molecule-edpm_telemetry_power_monitoring
2025-12-03 09:35:18.805606 | Pipeline: github-check
2025-12-03 09:35:18.805626 | Executor: ibm-bm4-ze.softwarefactory-project.io
2025-12-03 09:35:18.805645 | Triggered by: https://github.com/openstack-k8s-operators/edpm-ansible/pull/1054
2025-12-03 09:35:18.805664 | Log URL (when completed): https://logserver.rdoproject.org/936/rdoproject.org/936f6f7a069a41a88bb83b559735a66c/
2025-12-03 09:35:18.805682 | Event ID: 333fdd80-d02b-11f0-9b11-dfc4c98a2652
2025-12-03 09:35:18.809150 | 
2025-12-03 09:35:18.809215 | LOOP [emit-job-header : Print node information]
2025-12-03 09:35:18.893377 | localhost | ok:
2025-12-03 09:35:18.893557 | localhost | # Node Information
2025-12-03 09:35:18.893597 | localhost | Inventory Hostname: controller
2025-12-03 09:35:18.893630 | localhost | Hostname: np0005543491
2025-12-03 09:35:18.893657 | localhost | Username: zuul
2025-12-03 09:35:18.893682 | localhost | Distro: CentOS 9
2025-12-03 09:35:18.893705 | localhost | Provider: ibm-bm4-nodepool
2025-12-03 09:35:18.893727 | localhost | Region: regionOne
2025-12-03 09:35:18.893748 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2025-12-03 09:35:18.893771 | localhost | Product Name: OpenStack Compute
2025-12-03 09:35:18.893794 | localhost | Interface IP: 192.168.26.190
2025-12-03 09:35:18.934862 | 
2025-12-03 09:35:18.934934 | PLAY [all]
2025-12-03 09:35:18.940720 | 
2025-12-03 09:35:18.940782 | TASK [Gather network facts]
2025-12-03 09:35:19.302618 | controller | ok
2025-12-03 09:35:19.315693 | 
2025-12-03 09:35:19.315925 | TASK [include_role : start-zuul-console]
2025-12-03 09:35:19.333378 | controller | ok
2025-12-03 09:35:19.344841 | 
2025-12-03 09:35:19.344945 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-12-03 09:35:19.636003 | controller | ok
2025-12-03 09:35:19.644336 | 
2025-12-03 09:35:19.644425 | TASK [include_role : add-build-sshkey]
2025-12-03 09:35:19.662201 | controller | ok
2025-12-03 09:35:19.681063 | 
2025-12-03 09:35:19.681142 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-12-03 09:35:19.877773 | controller -> localhost | ok
2025-12-03 09:35:19.883587 | 
2025-12-03 09:35:19.883677 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-12-03 09:35:19.900780 | controller | ok
2025-12-03 09:35:19.913940 | controller | included: /var/lib/zuul/builds/936f6f7a069a41a88bb83b559735a66c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-12-03 09:35:19.919387 | 
2025-12-03 09:35:19.919455 | TASK [add-build-sshkey : Create Temp SSH key]
2025-12-03 09:35:20.367607 | controller -> localhost | Generating public/private rsa key pair.
2025-12-03 09:35:20.367814 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/936f6f7a069a41a88bb83b559735a66c/work/936f6f7a069a41a88bb83b559735a66c_id_rsa.
2025-12-03 09:35:20.367853 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/936f6f7a069a41a88bb83b559735a66c/work/936f6f7a069a41a88bb83b559735a66c_id_rsa.pub.
2025-12-03 09:35:20.367879 | controller -> localhost | The key fingerprint is:
2025-12-03 09:35:20.367902 | controller -> localhost | SHA256:FYLll/Iw+j/JVZOjrrGUOtYfublGpuQ3v3wkFhiYnpQ zuul-build-sshkey
2025-12-03 09:35:20.367950 | controller -> localhost | The key's randomart image is:
2025-12-03 09:35:20.367975 | controller -> localhost | +---[RSA 3072]----+
2025-12-03 09:35:20.367995 | controller -> localhost | |       oo .+     |
2025-12-03 09:35:20.368014 | controller -> localhost | |      .. .Eo.    |
2025-12-03 09:35:20.368032 | controller -> localhost | |        =o+. o . |
2025-12-03 09:35:20.368052 | controller -> localhost | |       . Bo . *  |
2025-12-03 09:35:20.368071 | controller -> localhost | |      . S .  o + |
2025-12-03 09:35:20.368090 | controller -> localhost | |       .  ..=.o .|
2025-12-03 09:35:20.368110 | controller -> localhost | |        .=+Bo. o |
2025-12-03 09:35:20.368132 | controller -> localhost | |        o+Bo==  .|
2025-12-03 09:35:20.368151 | controller -> localhost | |       ...+*=++o |
2025-12-03 09:35:20.368169 | controller -> localhost | +----[SHA256]-----+
2025-12-03 09:35:20.368218 | controller -> localhost | ok: Runtime: 0:00:00.103463
2025-12-03 09:35:20.374340 | 
2025-12-03 09:35:20.374411 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-12-03 09:35:20.392754 | controller | ok
2025-12-03 09:35:20.401807 | controller | included: /var/lib/zuul/builds/936f6f7a069a41a88bb83b559735a66c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-12-03 09:35:20.409242 | 
2025-12-03 09:35:20.409321 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-12-03 09:35:20.422695 | controller | skipping: Conditional result was False
2025-12-03 09:35:20.427464 | 
2025-12-03 09:35:20.427533 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-12-03 09:35:20.799572 | controller | changed
2025-12-03 09:35:20.805221 | 
2025-12-03 09:35:20.805296 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-12-03 09:35:20.996303 | controller | ok
2025-12-03 09:35:21.001253 | 
2025-12-03 09:35:21.001354 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-12-03 09:35:21.559900 | controller | changed
2025-12-03 09:35:21.564474 | 
2025-12-03 09:35:21.564552 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-12-03 09:35:22.113590 | controller | changed
2025-12-03 09:35:22.118440 | 
2025-12-03 09:35:22.118506 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-12-03 09:35:22.134219 | controller | skipping: Conditional result was False
2025-12-03 09:35:22.139551 | 
2025-12-03 09:35:22.139620 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-12-03 09:35:22.439249 | controller -> localhost | changed
2025-12-03 09:35:22.448346 | 
2025-12-03 09:35:22.448425 | TASK [add-build-sshkey : Add back temp key]
2025-12-03 09:35:22.676014 | controller -> localhost | Identity added: /var/lib/zuul/builds/936f6f7a069a41a88bb83b559735a66c/work/936f6f7a069a41a88bb83b559735a66c_id_rsa (zuul-build-sshkey)
2025-12-03 09:35:22.676196 | controller -> localhost | ok: Runtime: 0:00:00.007934
2025-12-03 09:35:22.681859 | 
2025-12-03 09:35:22.681951 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-12-03 09:35:22.962685 | controller | ok
2025-12-03 09:35:22.966957 | 
2025-12-03 09:35:22.967021 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-12-03 09:35:22.990990 | controller | skipping: Conditional result was False
2025-12-03 09:35:22.999347 | 
2025-12-03 09:35:22.999419 | TASK [include_role : validate-host]
2025-12-03 09:35:23.016657 | controller | ok
2025-12-03 09:35:23.035580 | 
2025-12-03 09:35:23.035650 | TASK [validate-host : Define zuul_info_dir fact]
2025-12-03 09:35:23.063359 | controller | ok
2025-12-03 09:35:23.067565 | 
2025-12-03 09:35:23.067625 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-12-03 09:35:23.262733 | controller -> localhost | ok
2025-12-03 09:35:23.268345 | 
2025-12-03 09:35:23.268415 | TASK [validate-host : Collect information about the host]
2025-12-03 09:35:23.887326 | controller | ok
2025-12-03 09:35:23.895079 | 
2025-12-03 09:35:23.895147 | TASK [validate-host : Sanitize hostname]
2025-12-03 09:35:23.959818 | controller | ok
2025-12-03 09:35:23.965637 | 
2025-12-03 09:35:23.965708 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-12-03 09:35:24.355129 | controller -> localhost | changed
2025-12-03 09:35:24.359878 | 
2025-12-03 09:35:24.359977 | TASK [validate-host : Collect information about zuul worker]
2025-12-03 09:35:24.693128 | controller | ok
2025-12-03 09:35:24.697628 | 
2025-12-03 09:35:24.697700 | TASK [validate-host : Write out all zuul information for each host]
2025-12-03 09:35:25.088037 | controller -> localhost | changed
2025-12-03 09:35:25.099796 | 
2025-12-03 09:35:25.099902 | TASK [include_role : prepare-workspace-openshift]
2025-12-03 09:35:25.114285 | controller | skipping: Conditional result was False
2025-12-03 09:35:25.119504 | 
2025-12-03 09:35:25.119576 | TASK [include_role : remove-zuul-sshkey]
2025-12-03 09:35:25.133560 | controller | skipping: Conditional result was False
2025-12-03 09:35:25.140358 | 
2025-12-03 09:35:25.140438 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-12-03 09:35:25.339138 | controller | ok: "logs"
2025-12-03 09:35:25.339359 | controller | ok: All items complete
2025-12-03 09:35:25.339391 | 
2025-12-03 09:35:25.504630 | controller | ok: "artifacts"
2025-12-03 09:35:25.672208 | controller | ok: "docs"
2025-12-03 09:35:25.687703 | 
2025-12-03 09:35:25.687771 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-12-03 09:35:25.891492 | controller | changed: "logs"
2025-12-03 09:35:26.075037 | controller | changed: "artifacts"
2025-12-03 09:35:26.242250 | controller | changed: "docs"
2025-12-03 09:35:26.262069 | 
2025-12-03 09:35:26.262118 | PLAY RECAP
2025-12-03 09:35:26.262159 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-12-03 09:35:26.262185 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-12-03 09:35:26.262203 | 
2025-12-03 09:35:26.335101 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-12-03 09:35:26.335836 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-12-03 09:35:26.863465 | 
2025-12-03 09:35:26.863570 | PLAY [all]
2025-12-03 09:35:26.882887 | 
2025-12-03 09:35:26.882998 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-12-03 09:35:26.933070 | controller | ok
2025-12-03 09:35:26.937805 | 
2025-12-03 09:35:26.937884 | TASK [mirror-info-fork : Create /etc/ci]
2025-12-03 09:35:27.260823 | controller | changed
2025-12-03 09:35:27.266262 | 
2025-12-03 09:35:27.266347 | TASK [mirror-info-fork : Install ci_mirror script]
2025-12-03 09:35:28.056220 | controller | changed
2025-12-03 09:35:28.065533 | 
2025-12-03 09:35:28.065611 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-12-03 09:35:28.409991 | controller | changed:
2025-12-03 09:35:28.410158 | controller | {
2025-12-03 09:35:28.410187 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-12-03 09:35:28.410215 | controller | }
2025-12-03 09:35:28.615616 | controller | changed:
2025-12-03 09:35:28.615669 | controller | {
2025-12-03 09:35:28.615696 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-12-03 09:35:28.615716 | controller | }
2025-12-03 09:35:28.821130 | controller | changed:
2025-12-03 09:35:28.821181 | controller | {
2025-12-03 09:35:28.821205 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2025-12-03 09:35:28.821225 | controller | }
2025-12-03 09:35:29.023276 | controller | changed:
2025-12-03 09:35:29.023363 | controller | {
2025-12-03 09:35:29.023388 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-12-03 09:35:29.023407 | controller | }
2025-12-03 09:35:29.222731 | controller | changed:
2025-12-03 09:35:29.222812 | controller | {
2025-12-03 09:35:29.222836 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-12-03 09:35:29.222856 | controller | }
2025-12-03 09:35:29.429972 | controller | changed:
2025-12-03 09:35:29.430058 | controller | {
2025-12-03 09:35:29.430087 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-12-03 09:35:29.430110 | controller | }
2025-12-03 09:35:29.638832 | controller | changed:
2025-12-03 09:35:29.638887 | controller | {
2025-12-03 09:35:29.638930 | 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-12-03 09:35:29.638961 | controller | }
2025-12-03 09:35:29.874845 | controller | changed:
2025-12-03 09:35:29.874992 | controller | {
2025-12-03 09:35:29.875031 | 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-12-03 09:35:29.875054 | controller | }
2025-12-03 09:35:30.095566 | controller | changed:
2025-12-03 09:35:30.095623 | controller | {
2025-12-03 09:35:30.095650 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-12-03 09:35:30.095670 | controller | }
2025-12-03 09:35:30.310101 | controller | changed:
2025-12-03 09:35:30.310150 | controller | {
2025-12-03 09:35:30.310173 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-12-03 09:35:30.310190 | controller | }
2025-12-03 09:35:30.516396 | controller | changed:
2025-12-03 09:35:30.516446 | controller | {
2025-12-03 09:35:30.516472 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-12-03 09:35:30.516492 | controller | }
2025-12-03 09:35:30.741313 | controller | changed:
2025-12-03 09:35:30.741398 | controller | {
2025-12-03 09:35:30.741425 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-12-03 09:35:30.741446 | controller | }
2025-12-03 09:35:30.936367 | controller | changed:
2025-12-03 09:35:30.936442 | controller | {
2025-12-03 09:35:30.936468 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-12-03 09:35:30.936488 | controller | }
2025-12-03 09:35:31.132569 | controller | changed:
2025-12-03 09:35:31.132691 | controller | {
2025-12-03 09:35:31.132720 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-12-03 09:35:31.132742 | controller | }
2025-12-03 09:35:31.335341 | controller | changed:
2025-12-03 09:35:31.335433 | controller | {
2025-12-03 09:35:31.335458 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-12-03 09:35:31.335478 | controller | }
2025-12-03 09:35:31.533111 | controller | changed:
2025-12-03 09:35:31.533288 | controller | {
2025-12-03 09:35:31.533325 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-12-03 09:35:31.533349 | controller | }
2025-12-03 09:35:31.725887 | controller | changed:
2025-12-03 09:35:31.726055 | controller | {
2025-12-03 09:35:31.726093 | 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-12-03 09:35:31.726119 | controller | }
2025-12-03 09:35:31.923886 | controller | changed:
2025-12-03 09:35:31.924005 | controller | {
2025-12-03 09:35:31.924033 | 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-12-03 09:35:31.924063 | controller | }
2025-12-03 09:35:32.115666 | controller | changed:
2025-12-03 09:35:32.115741 | controller | {
2025-12-03 09:35:32.115768 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-12-03 09:35:32.115790 | controller | }
2025-12-03 09:35:32.310976 | controller | changed:
2025-12-03 09:35:32.311070 | controller | {
2025-12-03 09:35:32.311094 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-12-03 09:35:32.311112 | controller | }
2025-12-03 09:35:32.510599 | controller | changed:
2025-12-03 09:35:32.510683 | controller | {
2025-12-03 09:35:32.510720 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-12-03 09:35:32.510740 | controller | }
2025-12-03 09:35:32.705968 | controller | changed:
2025-12-03 09:35:32.706041 | controller | {
2025-12-03 09:35:32.706068 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-12-03 09:35:32.706087 | controller | }
2025-12-03 09:35:32.918416 | controller | changed:
2025-12-03 09:35:32.918519 | controller | {
2025-12-03 09:35:32.918546 | 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-12-03 09:35:32.918568 | controller | }
2025-12-03 09:35:33.128370 | controller | changed:
2025-12-03 09:35:33.128451 | controller | {
2025-12-03 09:35:33.128482 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-12-03 09:35:33.128508 | controller | }
2025-12-03 09:35:33.337634 | controller | changed:
2025-12-03 09:35:33.337720 | controller | {
2025-12-03 09:35:33.337745 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-12-03 09:35:33.337764 | controller | }
2025-12-03 09:35:33.543794 | controller | changed:
2025-12-03 09:35:33.543892 | controller | {
2025-12-03 09:35:33.543943 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-12-03 09:35:33.543977 | controller | }
2025-12-03 09:35:33.565471 | 
2025-12-03 09:35:33.565562 | TASK [Set timezone to UTC]
2025-12-03 09:35:33.960567 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-12-03 09:35:33.964922 | 
2025-12-03 09:35:33.964987 | TASK [Create nodepool directory]
2025-12-03 09:35:34.172684 | controller | changed
2025-12-03 09:35:34.177964 | 
2025-12-03 09:35:34.178036 | TASK [Create nodepool sub_nodes file]
2025-12-03 09:35:34.709799 | controller | changed
2025-12-03 09:35:34.714777 | 
2025-12-03 09:35:34.714866 | TASK [Create nodepool sub_nodes_private file]
2025-12-03 09:35:35.207756 | controller | changed
2025-12-03 09:35:35.219389 | 
2025-12-03 09:35:35.219455 | LOOP [Populate nodepool sub_nodes file]
2025-12-03 09:35:35.248105 | 
2025-12-03 09:35:35.248228 | LOOP [Populate nodepool sub_nodes_private file]
2025-12-03 09:35:35.276109 | 
2025-12-03 09:35:35.276225 | TASK [Create nodepool primary file]
2025-12-03 09:35:35.299098 | controller | skipping: Conditional result was False
2025-12-03 09:35:35.304123 | 
2025-12-03 09:35:35.304187 | TASK [Create nodepool node_private for this node]
2025-12-03 09:35:35.847784 | controller | changed
2025-12-03 09:35:35.853116 | 
2025-12-03 09:35:35.853184 | LOOP [Copy ssh keys to nodepool directory]
2025-12-03 09:35:36.178900 | controller | ok: Item: id_rsa Runtime: 0:00:00.006472
2025-12-03 09:35:36.179086 | 
2025-12-03 09:35:36.358405 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.005888
2025-12-03 09:35:36.369833 | 
2025-12-03 09:35:36.369901 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-12-03 09:35:36.895580 | controller | changed
2025-12-03 09:35:36.900368 | 
2025-12-03 09:35:36.900435 | TASK [Validate sudoers config after edits]
2025-12-03 09:35:37.115258 | controller | /etc/sudoers: parsed OK
2025-12-03 09:35:37.115327 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-12-03 09:35:37.115337 | controller | /etc/sudoers.d/zuul: parsed OK
2025-12-03 09:35:37.115344 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-12-03 09:35:37.426733 | controller | ok: Runtime: 0:00:00.005357
2025-12-03 09:35:37.431840 | 
2025-12-03 09:35:37.431937 | TASK [Show the environment passed in to job shell scripts]
2025-12-03 09:35:37.630976 | controller | SHELL=/bin/bash
2025-12-03 09:35:37.631035 | controller | ZUUL_PROJECT=openstack-k8s-operators/edpm-ansible
2025-12-03 09:35:37.631046 | controller | ZUUL_SHORT_PROJECT_NAME=edpm-ansible
2025-12-03 09:35:37.631117 | controller | ZUUL_CHANGES=openstack-k8s-operators/edpm-ansible:main:refs/changes/54/1054/bed46a567601e7e420bff43cd0a0891343a80eee
2025-12-03 09:35:37.631131 | controller | PWD=/home/zuul
2025-12-03 09:35:37.631137 | controller | ZUUL_PIPELINE=github-check
2025-12-03 09:35:37.631143 | controller | LOGNAME=zuul
2025-12-03 09:35:37.631149 | controller | XDG_SESSION_TYPE=tty
2025-12-03 09:35:37.631155 | controller | _=/usr/bin/env
2025-12-03 09:35:37.631160 | controller | MOTD_SHOWN=pam
2025-12-03 09:35:37.631165 | controller | HOME=/home/zuul
2025-12-03 09:35:37.631171 | controller | LANG=en_US.UTF-8
2025-12-03 09:35:37.631176 | controller | SSH_CONNECTION=192.168.26.12 47302 192.168.26.190 22
2025-12-03 09:35:37.631182 | 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-12-03 09:35:37.631191 | controller | ZUUL_CHANGE_IDS=1054,bed46a567601e7e420bff43cd0a0891343a80eee
2025-12-03 09:35:37.631197 | controller | WORKSPACE=/home/zuul/workspace
2025-12-03 09:35:37.631203 | controller | XDG_SESSION_CLASS=user
2025-12-03 09:35:37.631209 | controller | SELINUX_ROLE_REQUESTED=
2025-12-03 09:35:37.631215 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-12-03 09:35:37.631220 | controller | USER=zuul
2025-12-03 09:35:37.631226 | controller | ZUUL_VOTING=True
2025-12-03 09:35:37.631232 | controller | BUILD_TIMEOUT=1800000
2025-12-03 09:35:37.631237 | controller | SELINUX_USE_CURRENT_RANGE=
2025-12-03 09:35:37.631243 | controller | SHLVL=1
2025-12-03 09:35:37.631248 | controller | ZUUL_PATCHSET=bed46a567601e7e420bff43cd0a0891343a80eee
2025-12-03 09:35:37.631254 | controller | XDG_SESSION_ID=1
2025-12-03 09:35:37.631259 | controller | ZUUL_BRANCH=main
2025-12-03 09:35:37.631265 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-12-03 09:35:37.631271 | controller | SSH_CLIENT=192.168.26.12 47302 22
2025-12-03 09:35:37.631277 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-12-03 09:35:37.631282 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-12-03 09:35:37.631288 | controller | which_declare=declare -f
2025-12-03 09:35:37.631295 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-12-03 09:35:37.631302 | controller | SELINUX_LEVEL_REQUESTED=
2025-12-03 09:35:37.631309 | controller | ZUUL_CHANGE=1054
2025-12-03 09:35:37.631315 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-12-03 09:35:37.631320 | controller | ZUUL_UUID=936f6f7a069a41a88bb83b559735a66c
2025-12-03 09:35:37.631325 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-12-03 09:35:37.631331 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-12-03 09:35:37.631337 | controller | }
2025-12-03 09:35:37.955289 | controller | ok: Runtime: 0:00:00.005881
2025-12-03 09:35:37.960478 | 
2025-12-03 09:35:37.960545 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-12-03 09:35:37.974070 | controller | skipping: Conditional result was False
2025-12-03 09:35:37.979245 | 
2025-12-03 09:35:37.979314 | TASK [Symlink /home/zuul-worker/workspace]
2025-12-03 09:35:38.503893 | controller | skipping: Conditional result was False
2025-12-03 09:35:38.509491 | 
2025-12-03 09:35:38.509556 | TASK [Ensure legacy workspace directory]
2025-12-03 09:35:38.709799 | controller | changed
2025-12-03 09:35:38.726620 | 
2025-12-03 09:35:38.726672 | PLAY RECAP
2025-12-03 09:35:38.726719 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-12-03 09:35:38.726742 | 
2025-12-03 09:35:38.795534 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-12-03 09:35:38.796298 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-12-03 09:35:39.294998 | 
2025-12-03 09:35:39.295091 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2025-12-03 09:35:39.314950 | 
2025-12-03 09:35:39.315019 | TASK [Create zuul-output directory]
2025-12-03 09:35:39.627687 | controller | changed
2025-12-03 09:35:39.632634 | 
2025-12-03 09:35:39.632710 | TASK [Slurp Zuul inventory test]
2025-12-03 09:35:39.928522 | controller -> localhost | ok
2025-12-03 09:35:39.934433 | 
2025-12-03 09:35:39.934502 | TASK [Save zuul inventory]
2025-12-03 09:35:40.701874 | controller | changed
2025-12-03 09:35:40.706817 | 
2025-12-03 09:35:40.706882 | TASK [Save zuul vars without the change_message]
2025-12-03 09:35:41.295032 | controller | changed
2025-12-03 09:35:41.312284 | 
2025-12-03 09:35:41.312337 | PLAY RECAP
2025-12-03 09:35:41.312380 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-12-03 09:35:41.312403 | 
2025-12-03 09:35:41.387340 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-12-03 09:35:41.388336 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-12-03 09:35:41.918737 | 
2025-12-03 09:35:41.918853 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2025-12-03 09:35:41.939839 | 
2025-12-03 09:35:41.939945 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2025-12-03 09:35:41.967877 | controller | ok
2025-12-03 09:35:41.984326 | 
2025-12-03 09:35:41.984414 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-12-03 09:35:42.007841 | controller | skipping: Conditional result was False
2025-12-03 09:35:42.013286 | 
2025-12-03 09:35:42.013358 | TASK [mirror-info-fork : Create /etc/ci]
2025-12-03 09:35:42.324082 | controller | ok
2025-12-03 09:35:42.329511 | 
2025-12-03 09:35:42.329584 | TASK [mirror-info-fork : Install ci_mirror script]
2025-12-03 09:35:42.955161 | controller | ok
2025-12-03 09:35:42.965259 | 
2025-12-03 09:35:42.965345 | TASK [Prepare workspace]
2025-12-03 09:35:42.983251 | controller | ok
2025-12-03 09:35:43.000043 | 
2025-12-03 09:35:43.000111 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-12-03 09:35:43.311682 | controller | ok
2025-12-03 09:35:43.318307 | 
2025-12-03 09:35:43.318387 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-12-03 09:35:45.696650 | controller | Output suppressed because no_log was given
2025-12-03 09:35:45.705575 | 
2025-12-03 09:35:45.705639 | LOOP [Create zuul-output directory]
2025-12-03 09:35:45.893183 | controller | changed: "/home/zuul/ci-framework-data/logs"
2025-12-03 09:35:46.048799 | controller | ok: "/home/zuul/zuul-output/logs"
2025-12-03 09:35:46.060139 | 
2025-12-03 09:35:46.060212 | TASK [Install required packages]
2025-12-03 09:36:51.899690 | controller | changed
2025-12-03 09:36:51.904919 | 
2025-12-03 09:36:51.904981 | TASK [Install venv]
2025-12-03 09:37:53.209493 | controller | changed
2025-12-03 09:37:53.233722 | 
2025-12-03 09:37:53.233785 | PLAY RECAP
2025-12-03 09:37:53.233828 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-12-03 09:37:53.233852 | 
2025-12-03 09:37:53.301484 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-12-03 09:37:53.302529 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-12-03 09:37:53.812582 | 
2025-12-03 09:37:53.812680 | PLAY [Run ci/playbooks/molecule-test.yml]
2025-12-03 09:37:53.832739 | 
2025-12-03 09:37:53.832815 | TASK [Gather required facts]
2025-12-03 09:37:54.316881 | controller | ok
2025-12-03 09:37:54.321576 | 
2025-12-03 09:37:54.321645 | TASK [Load environment var if instructed to]
2025-12-03 09:37:54.345091 | controller | skipping: Conditional result was False
2025-12-03 09:37:54.349821 | 
2025-12-03 09:37:54.349881 | TASK [Ensure group_vars dir exists]
2025-12-03 09:37:54.641103 | controller | changed
2025-12-03 09:37:54.646551 | 
2025-12-03 09:37:54.646609 | TASK [Print related variables]
2025-12-03 09:37:54.674479 | controller | ok:
2025-12-03 09:37:54.674593 | controller | mol_config_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config_edpm_ansible.yml
2025-12-03 09:37:54.674623 | controller | roles_dir: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/roles/edpm_telemetry_power_monitoring
2025-12-03 09:37:54.679030 | 
2025-12-03 09:37:54.679087 | TASK [Run molecule]
2025-12-03 09:37:55.667440 | controller | INFO     Performing prerun with role_name_check=0...
2025-12-03 09:37:56.526753 | controller | INFO     Running default > dependency
2025-12-03 09:37:56.527109 | controller | WARNING  Skipping, missing the requirements file.
2025-12-03 09:37:57.079500 | controller | [WARNING]: The specified collections path '/home/zuul/.cache/molecule/edpm_tele
2025-12-03 09:37:57.079586 | controller | metry_power_monitoring/default/collections' is not part of the configured
2025-12-03 09:37:57.079618 | controller | Ansible collections paths '/home/zuul/.cache/ansible-compat/9c8f65/collections:
2025-12-03 09:37:57.079626 | controller | /home/zuul/.ansible/collections:/usr/share/ansible/collections'. The installed
2025-12-03 09:37:57.079633 | controller | collection will not be picked up in an Ansible run, unless within a playbook-
2025-12-03 09:37:57.079726 | controller | adjacent collections directory.
2025-12-03 09:38:18.153783 | controller | Starting galaxy collection install process
2025-12-03 09:38:18.153867 | controller | Process install dependency map
2025-12-03 09:38:18.153995 | controller | Starting collection install process
2025-12-03 09:38:18.154013 | controller | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-crypto-3.0.5.tar.gz to /home/zuul/.ansible/tmp/ansible-local-29255gvkeqju6/tmpduu2a9er/community-crypto-3.0.5-izymv6cc
2025-12-03 09:38:18.154205 | controller | Installing 'community.crypto:3.0.5' to '/home/zuul/.cache/molecule/edpm_telemetry_power_monitoring/default/collections/ansible_collections/community/crypto'
2025-12-03 09:38:18.154323 | controller | community.crypto:3.0.5 was installed successfully
2025-12-03 09:38:18.154445 | controller | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-general-12.1.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-29255gvkeqju6/tmpduu2a9er/community-general-12.1.0-xcc2154p
2025-12-03 09:38:18.154548 | controller | Installing 'community.general:12.1.0' to '/home/zuul/.cache/molecule/edpm_telemetry_power_monitoring/default/collections/ansible_collections/community/general'
2025-12-03 09:38:18.154646 | controller | community.general:12.1.0 was installed successfully
2025-12-03 09:38:18.195221 | controller | INFO     Dependency completed successfully.
2025-12-03 09:38:18.204297 | controller | INFO     Running default > destroy
2025-12-03 09:38:18.204630 | controller | WARNING  Skipping, instances are delegated.
2025-12-03 09:38:18.212724 | controller | INFO     Running default > create
2025-12-03 09:38:18.213679 | controller | WARNING  Skipping, instances are delegated.
2025-12-03 09:38:18.221739 | controller | INFO     Running default > prepare
2025-12-03 09:38:18.702047 | controller |
2025-12-03 09:38:18.722920 | controller | PLAY [Prepare test_deps] *******************************************************
2025-12-03 09:38:18.722940 | controller |
2025-12-03 09:38:18.722948 | controller | TASK [../../../../molecule/common/test_deps : Validating arguments against arg spec 'main' - The main entry point for the test_deps role.] ***
2025-12-03 09:38:18.722955 | controller | Wednesday 03 December 2025  09:38:18 +0000 (0:00:00.015)       0:00:00.015 ****
2025-12-03 09:38:18.722963 | controller | ok: [compute-1]
2025-12-03 09:38:18.723000 | controller |
2025-12-03 09:38:18.723145 | controller | TASK [../../../../molecule/common/test_deps : Gather facts if they don't exist] ***
2025-12-03 09:38:18.723255 | controller | Wednesday 03 December 2025  09:38:18 +0000 (0:00:00.024)       0:00:00.040 ****
2025-12-03 09:38:19.261002 | controller | ok: [compute-1]
2025-12-03 09:38:19.261059 | controller |
2025-12-03 09:38:19.261201 | controller | TASK [../../../../molecule/common/test_deps : Gather variables for each operating system] ***
2025-12-03 09:38:19.261299 | controller | Wednesday 03 December 2025  09:38:19 +0000 (0:00:00.537)       0:00:00.578 ****
2025-12-03 09:38:19.307126 | controller | ok: [compute-1] => (item=/home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/common/test_deps/vars/centos-9.yml)
2025-12-03 09:38:19.307233 | controller |
2025-12-03 09:38:19.307344 | controller | TASK [../../../../molecule/common/test_deps : Detect mirrors file] *************
2025-12-03 09:38:19.307454 | controller | Wednesday 03 December 2025  09:38:19 +0000 (0:00:00.046)       0:00:00.624 ****
2025-12-03 09:38:19.613629 | controller | ok: [compute-1]
2025-12-03 09:38:19.613695 | controller |
2025-12-03 09:38:19.613812 | controller | TASK [../../../../molecule/common/test_deps : Disable ubi host subscription-manager integration] ***
2025-12-03 09:38:19.613912 | controller | Wednesday 03 December 2025  09:38:19 +0000 (0:00:00.306)       0:00:00.930 ****
2025-12-03 09:38:19.957717 | controller | ok: [compute-1]
2025-12-03 09:38:19.957787 | controller |
2025-12-03 09:38:19.957892 | controller | TASK [../../../../molecule/common/test_deps : Remove ubi 9 repos] **************
2025-12-03 09:38:19.957993 | controller | Wednesday 03 December 2025  09:38:19 +0000 (0:00:00.343)       0:00:01.274 ****
2025-12-03 09:38:20.182749 | controller | ok: [compute-1]
2025-12-03 09:38:20.182839 | controller |
2025-12-03 09:38:20.182949 | controller | TASK [../../../../molecule/common/test_deps : Fetch latest repo version] *******
2025-12-03 09:38:20.183057 | controller | Wednesday 03 December 2025  09:38:20 +0000 (0:00:00.225)       0:00:01.499 ****
2025-12-03 09:38:20.754965 | controller | ok: [compute-1]
2025-12-03 09:38:20.755110 | controller |
2025-12-03 09:38:20.755125 | controller | TASK [../../../../molecule/common/test_deps : Create default repo file] ********
2025-12-03 09:38:20.755201 | controller | Wednesday 03 December 2025  09:38:20 +0000 (0:00:00.572)       0:00:02.072 ****
2025-12-03 09:38:21.270682 | controller | changed: [compute-1]
2025-12-03 09:38:30.716682 | controller |
2025-12-03 09:38:30.716728 | controller | TASK [../../../../molecule/common/test_deps : Install repo-setup pre-requirements] ***
2025-12-03 09:38:30.716737 | controller | Wednesday 03 December 2025  09:38:21 +0000 (0:00:00.515)       0:00:02.587 ****
2025-12-03 09:38:30.716749 | controller | ok: [compute-1]
2025-12-03 09:38:30.717162 | controller |
2025-12-03 09:38:31.804049 | controller | TASK [../../../../molecule/common/test_deps : Get repo-setup repository] *******
2025-12-03 09:38:31.804105 | controller | Wednesday 03 December 2025  09:38:30 +0000 (0:00:09.445)       0:00:12.032 ****
2025-12-03 09:38:31.804122 | controller | changed: [compute-1]
2025-12-03 09:38:35.078336 | controller |
2025-12-03 09:38:35.078371 | controller | TASK [../../../../molecule/common/test_deps : Install repo-setup] **************
2025-12-03 09:38:35.078383 | controller | Wednesday 03 December 2025  09:38:31 +0000 (0:00:01.088)       0:00:13.120 ****
2025-12-03 09:38:35.078395 | controller | changed: [compute-1]
2025-12-03 09:38:35.867030 | controller |
2025-12-03 09:38:35.867065 | controller | TASK [../../../../molecule/common/test_deps : Create repos] ********************
2025-12-03 09:38:35.867090 | controller | Wednesday 03 December 2025  09:38:35 +0000 (0:00:03.274)       0:00:16.395 ****
2025-12-03 09:38:35.867104 | controller | changed: [compute-1]
2025-12-03 09:38:36.088169 | controller |
2025-12-03 09:38:36.088205 | controller | TASK [../../../../molecule/common/test_deps : Look for redhat-release rpm] *****
2025-12-03 09:38:36.088214 | controller | Wednesday 03 December 2025  09:38:35 +0000 (0:00:00.788)       0:00:17.183 ****
2025-12-03 09:38:36.088225 | controller | fatal: [compute-1]: FAILED! => changed=true
2025-12-03 09:38:36.088246 | controller |   cmd: |-
2025-12-03 09:38:36.088252 | controller |     rpm -qe redhat-release
2025-12-03 09:38:36.088257 | controller |   delta: '0:00:00.011807'
2025-12-03 09:38:36.088262 | controller |   end: '2025-12-03 09:38:36.059897'
2025-12-03 09:38:36.088268 | controller |   msg: non-zero return code
2025-12-03 09:38:36.088277 | controller |   rc: 1
2025-12-03 09:38:36.088284 | controller |   start: '2025-12-03 09:38:36.048090'
2025-12-03 09:38:36.088313 | controller |   stderr: ''
2025-12-03 09:38:36.088573 | controller |   stderr_lines: <omitted>
2025-12-03 09:38:36.092971 | controller |   stdout: package redhat-release is not installed
2025-12-03 09:38:36.092990 | controller |   stdout_lines: <omitted>
2025-12-03 09:38:36.093002 | controller | ...ignoring
2025-12-03 09:38:36.121629 | controller |
2025-12-03 09:38:36.121650 | controller | TASK [../../../../molecule/common/test_deps : Workaround of redhat-release binary on ubi9] ***
2025-12-03 09:38:36.121660 | controller | Wednesday 03 December 2025  09:38:36 +0000 (0:00:00.226)       0:00:17.410 ****
2025-12-03 09:38:36.121671 | controller | skipping: [compute-1]
2025-12-03 09:39:47.873240 | controller |
2025-12-03 09:39:47.873276 | controller | TASK [../../../../molecule/common/test_deps : Install edpm packages] ***********
2025-12-03 09:39:47.873284 | controller | Wednesday 03 December 2025  09:38:36 +0000 (0:00:00.028)       0:00:17.438 ****
2025-12-03 09:39:47.873294 | controller | changed: [compute-1]
2025-12-03 09:39:49.320849 | controller |
2025-12-03 09:39:49.320877 | controller | TASK [../../../../molecule/common/test_deps : Install selinux python libs] *****
2025-12-03 09:39:49.320885 | controller | Wednesday 03 December 2025  09:39:47 +0000 (0:01:11.750)       0:01:29.189 ****
2025-12-03 09:39:49.320900 | controller | ok: [compute-1]
2025-12-03 09:39:50.717934 | controller |
2025-12-03 09:39:50.717962 | controller | TASK [../../../../molecule/common/test_deps : Install python yaml libs] ********
2025-12-03 09:39:50.717970 | controller | Wednesday 03 December 2025  09:39:49 +0000 (0:00:01.448)       0:01:30.637 ****
2025-12-03 09:39:50.717979 | controller | ok: [compute-1]
2025-12-03 09:39:52.133723 | controller |
2025-12-03 09:39:52.133757 | controller | TASK [../../../../molecule/common/test_deps : Install extra packages] **********
2025-12-03 09:39:52.133766 | controller | Wednesday 03 December 2025  09:39:50 +0000 (0:00:01.397)       0:01:32.034 ****
2025-12-03 09:39:52.133777 | controller | ok: [compute-1]
2025-12-03 09:39:52.328613 | controller |
2025-12-03 09:39:52.328643 | controller | TASK [../../../../molecule/common/test_deps : Check for /etc/ansible/facts.d/bootc.fact] ***
2025-12-03 09:39:52.328651 | controller | Wednesday 03 December 2025  09:39:52 +0000 (0:00:01.415)       0:01:33.450 ****
2025-12-03 09:39:52.328662 | controller | ok: [compute-1]
2025-12-03 09:39:52.515149 | controller |
2025-12-03 09:39:52.515191 | controller | TASK [../../../../molecule/common/test_deps : Create /etc/ansible/facts.d] *****
2025-12-03 09:39:52.515200 | controller | Wednesday 03 December 2025  09:39:52 +0000 (0:00:00.194)       0:01:33.644 ****
2025-12-03 09:39:52.515211 | controller | changed: [compute-1]
2025-12-03 09:39:52.515235 | controller |
2025-12-03 09:39:52.515241 | controller | TASK [../../../../molecule/common/test_deps : Create /etc/ansible/facts.d/bootc.fact] ***
2025-12-03 09:39:52.515248 | controller | Wednesday 03 December 2025  09:39:52 +0000 (0:00:00.187)       0:01:33.832 ****
2025-12-03 09:39:52.904052 | controller | changed: [compute-1]
2025-12-03 09:39:52.919812 | controller |
2025-12-03 09:39:52.919837 | controller | PLAY [Prepare] *****************************************************************
2025-12-03 09:39:52.919845 | controller |
2025-12-03 09:39:52.919851 | controller | TASK [osp.edpm.env_data : Validating arguments against arg spec 'main' - The main entry point for the osp.edpm.env_data role.] ***
2025-12-03 09:39:52.919859 | controller | Wednesday 03 December 2025  09:39:52 +0000 (0:00:00.388)       0:01:34.220 ****
2025-12-03 09:39:52.919869 | controller | ok: [compute-1]
2025-12-03 09:39:53.624220 | controller |
2025-12-03 09:39:53.624259 | controller | TASK [osp.edpm.env_data : Gather all installed packages] ***********************
2025-12-03 09:39:53.624269 | controller | Wednesday 03 December 2025  09:39:52 +0000 (0:00:00.015)       0:01:34.236 ****
2025-12-03 09:39:53.624282 | controller | ok: [compute-1]
2025-12-03 09:39:53.624315 | controller |
2025-12-03 09:39:53.624540 | controller | TASK [osp.edpm.env_data : Gather repository list] ******************************
2025-12-03 09:39:53.988336 | controller | Wednesday 03 December 2025  09:39:53 +0000 (0:00:00.704)       0:01:34.941 ****
2025-12-03 09:39:53.988373 | controller | ok: [compute-1]
2025-12-03 09:39:54.029207 | controller |
2025-12-03 09:39:54.029260 | controller | TASK [osp.edpm.env_data : Output installed packages] ***************************
2025-12-03 09:39:54.029275 | controller | Wednesday 03 December 2025  09:39:53 +0000 (0:00:00.363)       0:01:35.305 ****
2025-12-03 09:39:54.029294 | controller | ok: [compute-1] =>
2025-12-03 09:39:54.029346 | controller |   msg:
2025-12-03 09:39:54.029358 | controller |   - tzdata
2025-12-03 09:39:54.029368 | controller |   - fonts-filesystem
2025-12-03 09:39:54.029379 | controller |   - adobe-source-code-pro-fonts
2025-12-03 09:39:54.029389 | controller |   - dejavu-sans-fonts
2025-12-03 09:39:54.029399 | controller |   - langpacks-core-font-en
2025-12-03 09:39:54.029408 | controller |   - abattis-cantarell-fonts
2025-12-03 09:39:54.029418 | controller |   - geolite2-country
2025-12-03 09:39:54.029428 | controller |   - geolite2-city
2025-12-03 09:39:54.029438 | controller |   - gawk-all-langpacks
2025-12-03 09:39:54.029452 | controller |   - quota-nls
2025-12-03 09:39:54.029486 | controller |   - python3-setuptools-wheel
2025-12-03 09:39:54.029500 | controller |   - publicsuffix-list-dafsa
2025-12-03 09:39:54.029534 | controller |   - pcre2-syntax
2025-12-03 09:39:54.030173 | controller |   - ncurses-base
2025-12-03 09:39:54.032150 | controller |   - libssh-config
2025-12-03 09:39:54.032190 | controller |   - libreport-filesystem
2025-12-03 09:39:54.032199 | controller |   - dnf-data
2025-12-03 09:39:54.032205 | controller |   - kbd-misc
2025-12-03 09:39:54.032211 | controller |   - kbd-legacy
2025-12-03 09:39:54.032221 | controller |   - hwdata
2025-12-03 09:39:54.032326 | controller |   - dhcp-common
2025-12-03 09:39:54.032336 | controller |   - coreutils-common
2025-12-03 09:39:54.032341 | controller |   - centos-gpg-keys
2025-12-03 09:39:54.032354 | controller |   - centos-stream-repos
2025-12-03 09:39:54.032359 | controller |   - centos-stream-release
2025-12-03 09:39:54.032365 | controller |   - setup
2025-12-03 09:39:54.032371 | controller |   - filesystem
2025-12-03 09:39:54.032376 | controller |   - basesystem
2025-12-03 09:39:54.032382 | controller |   - ncurses-libs
2025-12-03 09:39:54.032387 | controller |   - bash
2025-12-03 09:39:54.032393 | controller |   - libgcc
2025-12-03 09:39:54.032398 | controller |   - glibc-gconv-extra
2025-12-03 09:39:54.032404 | controller |   - glibc-langpack-en
2025-12-03 09:39:54.032409 | controller |   - glibc-common
2025-12-03 09:39:54.032415 | controller |   - glibc
2025-12-03 09:39:54.032420 | controller |   - zlib
2025-12-03 09:39:54.032425 | controller |   - popt
2025-12-03 09:39:54.032431 | controller |   - xz-libs
2025-12-03 09:39:54.032436 | controller |   - libcap
2025-12-03 09:39:54.032444 | controller |   - libzstd
2025-12-03 09:39:54.032539 | controller |   - libstdc++
2025-12-03 09:39:54.032550 | controller |   - libuuid
2025-12-03 09:39:54.032648 | controller |   - libxcrypt
2025-12-03 09:39:54.032757 | controller |   - bzip2-libs
2025-12-03 09:39:54.032857 | controller |   - libcom_err
2025-12-03 09:39:54.032964 | controller |   - sqlite-libs
2025-12-03 09:39:54.033070 | controller |   - libxml2
2025-12-03 09:39:54.033201 | controller |   - libcap-ng
2025-12-03 09:39:54.033316 | controller |   - audit-libs
2025-12-03 09:39:54.033421 | controller |   - libmnl
2025-12-03 09:39:54.033527 | controller |   - libtalloc
2025-12-03 09:39:54.033635 | controller |   - elfutils-libelf
2025-12-03 09:39:54.033733 | controller |   - readline
2025-12-03 09:39:54.033840 | controller |   - crypto-policies
2025-12-03 09:39:54.033940 | controller |   - alternatives
2025-12-03 09:39:54.034040 | controller |   - keyutils-libs
2025-12-03 09:39:54.034171 | controller |   - libffi
2025-12-03 09:39:54.034282 | controller |   - libunistring
2025-12-03 09:39:54.034382 | controller |   - lua-libs
2025-12-03 09:39:54.034479 | controller |   - expat
2025-12-03 09:39:54.034577 | controller |   - libgpg-error
2025-12-03 09:39:54.034675 | controller |   - libnl3
2025-12-03 09:39:54.034773 | controller |   - libsepol
2025-12-03 09:39:54.034869 | controller |   - libtdb
2025-12-03 09:39:54.034967 | controller |   - lz4-libs
2025-12-03 09:39:54.035064 | controller |   - libidn2
2025-12-03 09:39:54.035188 | controller |   - libtevent
2025-12-03 09:39:54.035293 | controller |   - gmp
2025-12-03 09:39:54.035390 | controller |   - jansson
2025-12-03 09:39:54.035488 | controller |   - json-c
2025-12-03 09:39:54.035584 | controller |   - libattr
2025-12-03 09:39:54.035679 | controller |   - libacl
2025-12-03 09:39:54.035992 | controller |   - libsmartcols
2025-12-03 09:39:54.036110 | controller |   - libtasn1
2025-12-03 09:39:54.036234 | controller |   - p11-kit
2025-12-03 09:39:54.036330 | controller |   - pcre2
2025-12-03 09:39:54.036428 | controller |   - libselinux
2025-12-03 09:39:54.036519 | controller |   - sed
2025-12-03 09:39:54.036618 | controller |   - findutils
2025-12-03 09:39:54.036715 | controller |   - libsemanage
2025-12-03 09:39:54.036811 | controller |   - shadow-utils
2025-12-03 09:39:54.036908 | controller |   - libgcrypt
2025-12-03 09:39:54.037004 | controller |   - file-libs
2025-12-03 09:39:54.037120 | controller |   - file
2025-12-03 09:39:54.037229 | controller |   - gdbm-libs
2025-12-03 09:39:54.037326 | controller |   - libedit
2025-12-03 09:39:54.037422 | controller |   - libref_array
2025-12-03 09:39:54.037519 | controller |   - libverto
2025-12-03 09:39:54.037614 | controller |   - psmisc
2025-12-03 09:39:54.037712 | controller |   - libselinux-utils
2025-12-03 09:39:54.037808 | controller |   - p11-kit-trust
2025-12-03 09:39:54.037905 | controller |   - libassuan
2025-12-03 09:39:54.038004 | controller |   - keyutils
2025-12-03 09:39:54.038128 | controller |   - libbpf
2025-12-03 09:39:54.038251 | controller |   - iproute
2025-12-03 09:39:54.038360 | controller |   - e2fsprogs-libs
2025-12-03 09:39:54.038477 | controller |   - libicu
2025-12-03 09:39:54.038581 | controller |   - libproxy
2025-12-03 09:39:54.038685 | controller |   - fuse-libs
2025-12-03 09:39:54.038791 | controller |   - libbasicobjects
2025-12-03 09:39:54.038895 | controller |   - libcollection
2025-12-03 09:39:54.038998 | controller |   - libdhash
2025-12-03 09:39:54.039119 | controller |   - libgomp
2025-12-03 09:39:54.039244 | controller |   - libpath_utils
2025-12-03 09:39:54.039350 | controller |   - libini_config
2025-12-03 09:39:54.039455 | controller |   - libseccomp
2025-12-03 09:39:54.039560 | controller |   - libsigsegv
2025-12-03 09:39:54.039662 | controller |   - libsss_idmap
2025-12-03 09:39:54.039765 | controller |   - libyaml
2025-12-03 09:39:54.039870 | controller |   - lzo
2025-12-03 09:39:54.039980 | controller |   - numactl-libs
2025-12-03 09:39:54.040104 | controller |   - pcre
2025-12-03 09:39:54.040237 | controller |   - grep
2025-12-03 09:39:54.040345 | controller |   - openssl-fips-provider
2025-12-03 09:39:54.040449 | controller |   - openssl-libs
2025-12-03 09:39:54.040553 | controller |   - coreutils
2025-12-03 09:39:54.040657 | controller |   - ca-certificates
2025-12-03 09:39:54.040761 | controller |   - systemd-libs
2025-12-03 09:39:54.040865 | controller |   - libblkid
2025-12-03 09:39:54.040968 | controller |   - dbus-libs
2025-12-03 09:39:54.041072 | controller |   - libmount
2025-12-03 09:39:54.041206 | controller |   - kmod
2025-12-03 09:39:54.041315 | controller |   - util-linux-core
2025-12-03 09:39:54.041420 | controller |   - libfdisk
2025-12-03 09:39:54.041525 | controller |   - gzip
2025-12-03 09:39:54.041630 | controller |   - openssl
2025-12-03 09:39:54.041734 | controller |   - kmod-libs
2025-12-03 09:39:54.041848 | controller |   - libevent
2025-12-03 09:39:54.041952 | controller |   - cracklib
2025-12-03 09:39:54.042059 | controller |   - procps-ng
2025-12-03 09:39:54.042193 | controller |   - which
2025-12-03 09:39:54.042308 | controller |   - cracklib-dicts
2025-12-03 09:39:54.042413 | controller |   - avahi-libs
2025-12-03 09:39:54.042518 | controller |   - dbus-tools
2025-12-03 09:39:54.042622 | controller |   - centos-logos
2025-12-03 09:39:54.042725 | controller |   - libarchive
2025-12-03 09:39:54.042829 | controller |   - libsss_certmap
2025-12-03 09:39:54.042932 | controller |   - sscg
2025-12-03 09:39:54.043036 | controller |   - xz
2025-12-03 09:39:54.043170 | controller |   - squashfs-tools
2025-12-03 09:39:54.043286 | controller |   - libutempter
2025-12-03 09:39:54.043389 | controller |   - acl
2025-12-03 09:39:54.043493 | controller |   - gettext-libs
2025-12-03 09:39:54.043596 | controller |   - gettext
2025-12-03 09:39:54.043700 | controller |   - attr
2025-12-03 09:39:54.043804 | controller |   - mpfr
2025-12-03 09:39:54.043906 | controller |   - gawk
2025-12-03 09:39:54.044010 | controller |   - krb5-libs
2025-12-03 09:39:54.044131 | controller |   - libtirpc
2025-12-03 09:39:54.044253 | controller |   - quota
2025-12-03 09:39:54.044364 | controller |   - cyrus-sasl-lib
2025-12-03 09:39:54.044468 | controller |   - libssh
2025-12-03 09:39:54.044572 | controller |   - libpsl
2025-12-03 09:39:54.044670 | controller |   - libibverbs
2025-12-03 09:39:54.044765 | controller |   - libpcap
2025-12-03 09:39:54.044859 | controller |   - libnl3-cli
2025-12-03 09:39:54.044953 | controller |   - libteam
2025-12-03 09:39:54.045047 | controller |   - libksba
2025-12-03 09:39:54.045170 | controller |   - libcomps
2025-12-03 09:39:54.045275 | controller |   - ethtool
2025-12-03 09:39:54.045371 | controller |   - libss
2025-12-03 09:39:54.045467 | controller |   - e2fsprogs
2025-12-03 09:39:54.045564 | controller |   - libxcrypt-compat
2025-12-03 09:39:54.045660 | controller |   - python3-pip-wheel
2025-12-03 09:39:54.045756 | controller |   - python-unversioned-command
2025-12-03 09:39:54.045851 | controller |   - python3
2025-12-03 09:39:54.045946 | controller |   - python3-libs
2025-12-03 09:39:54.046040 | controller |   - python3-setuptools
2025-12-03 09:39:54.046154 | controller |   - python3-six
2025-12-03 09:39:54.046267 | controller |   - python3-libselinux
2025-12-03 09:39:54.046365 | controller |   - python3-pyyaml
2025-12-03 09:39:54.046461 | controller |   - python3-distro
2025-12-03 09:39:54.046557 | controller |   - python3-idna
2025-12-03 09:39:54.046653 | controller |   - python3-systemd
2025-12-03 09:39:54.046749 | controller |   - python3-audit
2025-12-03 09:39:54.046847 | controller |   - python3-libsemanage
2025-12-03 09:39:54.046943 | controller |   - python3-dateutil
2025-12-03 09:39:54.047038 | controller |   - python3-configobj
2025-12-03 09:39:54.047150 | controller |   - python3-setools
2025-12-03 09:39:54.047266 | controller |   - python3-libcomps
2025-12-03 09:39:54.047370 | controller |   - cockpit-bridge
2025-12-03 09:39:54.047478 | controller |   - python3-chardet
2025-12-03 09:39:54.047584 | controller |   - python3-libxml2
2025-12-03 09:39:54.047688 | controller |   - python3-ptyprocess
2025-12-03 09:39:54.047793 | controller |   - python3-pexpect
2025-12-03 09:39:54.047895 | controller |   - python3-pysocks
2025-12-03 09:39:54.047998 | controller |   - python3-urllib3
2025-12-03 09:39:54.048122 | controller |   - python3-requests
2025-12-03 09:39:54.048245 | controller |   - python3-attrs
2025-12-03 09:39:54.048348 | controller |   - python3-file-magic
2025-12-03 09:39:54.048457 | controller |   - sos
2025-12-03 09:39:54.048564 | controller |   - python3-jsonpointer
2025-12-03 09:39:54.048669 | controller |   - python3-jsonpatch
2025-12-03 09:39:54.048774 | controller |   - python3-markupsafe
2025-12-03 09:39:54.048882 | controller |   - python3-netifaces
2025-12-03 09:39:54.048987 | controller |   - python3-oauthlib
2025-12-03 09:39:54.049108 | controller |   - python3-prettytable
2025-12-03 09:39:54.049242 | controller |   - python3-pyrsistent
2025-12-03 09:39:54.049351 | controller |   - python3-jsonschema
2025-12-03 09:39:54.049456 | controller |   - python3-pyserial
2025-12-03 09:39:54.049560 | controller |   - python3-pytz
2025-12-03 09:39:54.049664 | controller |   - python3-babel
2025-12-03 09:39:54.049769 | controller |   - python3-jinja2
2025-12-03 09:39:54.049877 | controller |   - gdisk
2025-12-03 09:39:54.049981 | controller |   - groff-base
2025-12-03 09:39:54.050097 | controller |   - snappy
2025-12-03 09:39:54.050224 | controller |   - pigz
2025-12-03 09:39:54.050328 | controller |   - c-ares
2025-12-03 09:39:54.050431 | controller |   - cpio
2025-12-03 09:39:54.050535 | controller |   - diffutils
2025-12-03 09:39:54.050640 | controller |   - hostname
2025-12-03 09:39:54.050746 | controller |   - inih
2025-12-03 09:39:54.050856 | controller |   - kernel-tools-libs
2025-12-03 09:39:54.050959 | controller |   - less
2025-12-03 09:39:54.051064 | controller |   - libbrotli
2025-12-03 09:39:54.051196 | controller |   - libcbor
2025-12-03 09:39:54.051306 | controller |   - libdaemon
2025-12-03 09:39:54.051409 | controller |   - teamd
2025-12-03 09:39:54.051511 | controller |   - libdb
2025-12-03 09:39:54.051614 | controller |   - libeconf
2025-12-03 09:39:54.051717 | controller |   - libpwquality
2025-12-03 09:39:54.051821 | controller |   - pam
2025-12-03 09:39:54.051934 | controller |   - util-linux
2025-12-03 09:39:54.052037 | controller |   - grub2-common
2025-12-03 09:39:54.052171 | controller |   - openssh
2025-12-03 09:39:54.052285 | controller |   - grub2-pc-modules
2025-12-03 09:39:54.052390 | controller |   - kbd
2025-12-03 09:39:54.052494 | controller |   - libev
2025-12-03 09:39:54.052597 | controller |   - libverto-libev
2025-12-03 09:39:54.052699 | controller |   - libndp
2025-12-03 09:39:54.052812 | controller |   - libnfnetlink
2025-12-03 09:39:54.052919 | controller |   - libnetfilter_conntrack
2025-12-03 09:39:54.053024 | controller |   - iptables-libs
2025-12-03 09:39:54.053146 | controller |   - libnghttp2
2025-12-03 09:39:54.053270 | controller |   - libpipeline
2025-12-03 09:39:54.053376 | controller |   - libsss_nss_idmap
2025-12-03 09:39:54.053480 | controller |   - sssd-client
2025-12-03 09:39:54.053586 | controller |   - libsss_sudo
2025-12-03 09:39:54.053689 | controller |   - libtool-ltdl
2025-12-03 09:39:54.053795 | controller |   - openldap
2025-12-03 09:39:54.053898 | controller |   - libcurl
2025-12-03 09:39:54.054002 | controller |   - tpm2-tss
2025-12-03 09:39:54.054122 | controller |   - libnfsidmap
2025-12-03 09:39:54.054240 | controller |   - sssd-nfs-idmap
2025-12-03 09:39:54.054349 | controller |   - ima-evm-utils
2025-12-03 09:39:54.054455 | controller |   - curl
2025-12-03 09:39:54.054565 | controller |   - rpm
2025-12-03 09:39:54.054672 | controller |   - rpm-libs
2025-12-03 09:39:54.054781 | controller |   - policycoreutils
2025-12-03 09:39:54.054888 | controller |   - selinux-policy
2025-12-03 09:39:54.054992 | controller |   - selinux-policy-targeted
2025-12-03 09:39:54.055117 | controller |   - libsolv
2025-12-03 09:39:54.055242 | controller |   - cockpit-ws-selinux
2025-12-03 09:39:54.055348 | controller |   - rpm-plugin-systemd-inhibit
2025-12-03 09:39:54.055451 | controller |   - sudo
2025-12-03 09:39:54.055555 | controller |   - lmdb-libs
2025-12-03 09:39:54.055658 | controller |   - nettle
2025-12-03 09:39:54.055761 | controller |   - gnutls
2025-12-03 09:39:54.055863 | controller |   - glib2
2025-12-03 09:39:54.055967 | controller |   - python3-dbus
2025-12-03 09:39:54.056082 | controller |   - NetworkManager-libnm
2025-12-03 09:39:54.056208 | controller |   - libmodulemd
2025-12-03 09:39:54.056318 | controller |   - polkit-libs
2025-12-03 09:39:54.056422 | controller |   - gobject-introspection
2025-12-03 09:39:54.056532 | controller |   - python3-gobject-base-noarch
2025-12-03 09:39:54.056639 | controller |   - python3-gobject-base
2025-12-03 09:39:54.056759 | controller |   - python3-dasbus
2025-12-03 09:39:54.056903 | controller |   - gsettings-desktop-schemas
2025-12-03 09:39:54.057033 | controller |   - json-glib
2025-12-03 09:39:54.057199 | controller |   - libuser
2025-12-03 09:39:54.057337 | controller |   - webkit2gtk3-jsc
2025-12-03 09:39:54.057467 | controller |   - libproxy-webkitgtk4
2025-12-03 09:39:54.057594 | controller |   - glib-networking
2025-12-03 09:39:54.057722 | controller |   - npth
2025-12-03 09:39:54.057849 | controller |   - gnupg2
2025-12-03 09:39:54.057975 | controller |   - gpgme
2025-12-03 09:39:54.058124 | controller |   - librepo
2025-12-03 09:39:54.058268 | controller |   - libdnf
2025-12-03 09:39:54.058396 | controller |   - python3-libdnf
2025-12-03 09:39:54.058523 | controller |   - python3-hawkey
2025-12-03 09:39:54.058650 | controller |   - python3-gpg
2025-12-03 09:39:54.058781 | controller |   - rpm-sign-libs
2025-12-03 09:39:54.058908 | controller |   - oniguruma
2025-12-03 09:39:54.059032 | controller |   - jq
2025-12-03 09:39:54.059194 | controller |   - pciutils-libs
2025-12-03 09:39:54.059334 | controller |   - sg3_utils-libs
2025-12-03 09:39:54.059461 | controller |   - slang
2025-12-03 09:39:54.059586 | controller |   - newt
2025-12-03 09:39:54.059713 | controller |   - userspace-rcu
2025-12-03 09:39:54.059840 | controller |   - checkpolicy
2025-12-03 09:39:54.059965 | controller |   - python3-policycoreutils
2025-12-03 09:39:54.060115 | controller |   - policycoreutils-python-utils
2025-12-03 09:39:54.060264 | controller |   - libestr
2025-12-03 09:39:54.060392 | controller |   - libfastjson
2025-12-03 09:39:54.060520 | controller |   - libmaxminddb
2025-12-03 09:39:54.060649 | controller |   - ipcalc
2025-12-03 09:39:54.060779 | controller |   - liburing
2025-12-03 09:39:54.060906 | controller |   - langpacks-core-en_GB
2025-12-03 09:39:54.061034 | controller |   - systemd-rpm-macros
2025-12-03 09:39:54.061202 | controller |   - dbus
2025-12-03 09:39:54.061345 | controller |   - systemd-pam
2025-12-03 09:39:54.061474 | controller |   - systemd
2025-12-03 09:39:54.061601 | controller |   - dbus-common
2025-12-03 09:39:54.061733 | controller |   - dbus-broker
2025-12-03 09:39:54.061860 | controller |   - iputils
2025-12-03 09:39:54.061998 | controller |   - dhcp-client
2025-12-03 09:39:54.062145 | controller |   - cronie-anacron
2025-12-03 09:39:54.062291 | controller |   - cronie
2025-12-03 09:39:54.062418 | controller |   - crontabs
2025-12-03 09:39:54.062544 | controller |   - initscripts-service
2025-12-03 09:39:54.062669 | controller |   - polkit
2025-12-03 09:39:54.062793 | controller |   - polkit-pkla-compat
2025-12-03 09:39:54.062917 | controller |   - samba-common
2025-12-03 09:39:54.063042 | controller |   - libldb
2025-12-03 09:39:54.063201 | controller |   - libwbclient
2025-12-03 09:39:54.063335 | controller |   - samba-client-libs
2025-12-03 09:39:54.063461 | controller |   - samba-common-libs
2025-12-03 09:39:54.063586 | controller |   - sssd-common
2025-12-03 09:39:54.063710 | controller |   - audit
2025-12-03 09:39:54.063841 | controller |   - authselect-libs
2025-12-03 09:39:54.063967 | controller |   - device-mapper-libs
2025-12-03 09:39:54.064111 | controller |   - device-mapper
2025-12-03 09:39:54.064260 | controller |   - grub2-tools-minimal
2025-12-03 09:39:54.064388 | controller |   - cryptsetup-libs
2025-12-03 09:39:54.064513 | controller |   - systemd-udev
2025-12-03 09:39:54.064638 | controller |   - NetworkManager
2025-12-03 09:39:54.064764 | controller |   - NetworkManager-team
2025-12-03 09:39:54.064888 | controller |   - libfido2
2025-12-03 09:39:54.065012 | controller |   - os-prober
2025-12-03 09:39:54.065169 | controller |   - kpartx
2025-12-03 09:39:54.065309 | controller |   - xfsprogs
2025-12-03 09:39:54.065439 | controller |   - elfutils-default-yama-scope
2025-12-03 09:39:54.065566 | controller |   - elfutils-libs
2025-12-03 09:39:54.065714 | controller |   - elfutils-debuginfod-client
2025-12-03 09:39:54.065843 | controller |   - binutils-gold
2025-12-03 09:39:54.065970 | controller |   - binutils
2025-12-03 09:39:54.066117 | controller |   - rpm-build-libs
2025-12-03 09:39:54.066265 | controller |   - python3-rpm
2025-12-03 09:39:54.066394 | controller |   - python3-dnf
2025-12-03 09:39:54.066521 | controller |   - dnf
2025-12-03 09:39:54.066648 | controller |   - setroubleshoot-plugins
2025-12-03 09:39:54.066773 | controller |   - setroubleshoot-server
2025-12-03 09:39:54.066898 | controller |   - python3-dnf-plugins-core
2025-12-03 09:39:54.067023 | controller |   - dnf-plugins-core
2025-12-03 09:39:54.067190 | controller |   - gssproxy
2025-12-03 09:39:54.067331 | controller |   - libkcapi
2025-12-03 09:39:54.067462 | controller |   - libkcapi-hmaccalc
2025-12-03 09:39:54.067598 | controller |   - dracut
2025-12-03 09:39:54.067726 | controller |   - kernel-modules-core
2025-12-03 09:39:54.067850 | controller |   - kernel-core
2025-12-03 09:39:54.067982 | controller |   - grub2-tools
2025-12-03 09:39:54.068139 | controller |   - grubby
2025-12-03 09:39:54.068284 | controller |   - kernel-modules
2025-12-03 09:39:54.068410 | controller |   - dracut-network
2025-12-03 09:39:54.068535 | controller |   - dracut-squash
2025-12-03 09:39:54.068663 | controller |   - kexec-tools
2025-12-03 09:39:54.068789 | controller |   - logrotate
2025-12-03 09:39:54.068915 | controller |   - rsyslog-logrotate
2025-12-03 09:39:54.069039 | controller |   - rsyslog
2025-12-03 09:39:54.069198 | controller |   - rpcbind
2025-12-03 09:39:54.069331 | controller |   - oddjob
2025-12-03 09:39:54.069456 | controller |   - oddjob-mkhomedir
2025-12-03 09:39:54.069580 | controller |   - authselect
2025-12-03 09:39:54.069706 | controller |   - authselect-compat
2025-12-03 09:39:54.069833 | controller |   - nfs-utils
2025-12-03 09:39:54.069958 | controller |   - cockpit-system
2025-12-03 09:39:54.070134 | controller |   - kernel
2025-12-03 09:39:54.070292 | controller |   - crypto-policies-scripts
2025-12-03 09:39:54.070425 | controller |   - grub2-pc
2025-12-03 09:39:54.070552 | controller |   - dracut-config-generic
2025-12-03 09:39:54.070683 | controller |   - yum-utils
2025-12-03 09:39:54.070807 | controller |   - yum
2025-12-03 09:39:54.070931 | controller |   - cloud-init
2025-12-03 09:39:54.071055 | controller |   - openssh-clients
2025-12-03 09:39:54.071214 | controller |   - NetworkManager-tui
2025-12-03 09:39:54.071347 | controller |   - parted
2025-12-03 09:39:54.071472 | controller |   - sssd-kcm
2025-12-03 09:39:54.071602 | controller |   - chrony
2025-12-03 09:39:54.071728 | controller |   - microcode_ctl
2025-12-03 09:39:54.071860 | controller |   - openssh-server
2025-12-03 09:39:54.071990 | controller |   - qemu-guest-agent
2025-12-03 09:39:54.072150 | controller |   - langpacks-en_GB
2025-12-03 09:39:54.072297 | controller |   - sg3_utils
2025-12-03 09:39:54.072430 | controller |   - kernel-tools
2025-12-03 09:39:54.072558 | controller |   - cockpit-ws
2025-12-03 09:39:54.072683 | controller |   - passwd
2025-12-03 09:39:54.072810 | controller |   - initscripts-rename-device
2025-12-03 09:39:54.072942 | controller |   - irqbalance
2025-12-03 09:39:54.073068 | controller |   - rpm-plugin-selinux
2025-12-03 09:39:54.073247 | controller |   - rpm-plugin-audit
2025-12-03 09:39:54.073377 | controller |   - man-db
2025-12-03 09:39:54.073505 | controller |   - iproute-tc
2025-12-03 09:39:54.073633 | controller |   - cloud-utils-growpart
2025-12-03 09:39:54.073760 | controller |   - tcpdump
2025-12-03 09:39:54.073886 | controller |   - prefixdevname
2025-12-03 09:39:54.074011 | controller |   - rsync
2025-12-03 09:39:54.074157 | controller |   - tar
2025-12-03 09:39:54.074304 | controller |   - vim-minimal
2025-12-03 09:39:54.074428 | controller |   - lshw
2025-12-03 09:39:54.074552 | controller |   - libsysfs
2025-12-03 09:39:54.074674 | controller |   - lsscsi
2025-12-03 09:39:54.074797 | controller |   - ncurses
2025-12-03 09:39:54.074920 | controller |   - rootfiles
2025-12-03 09:39:54.075044 | controller |   - gpg-pubkey
2025-12-03 09:39:54.075209 | controller |   - git-core
2025-12-03 09:39:54.075345 | controller |   - git-core-doc
2025-12-03 09:39:54.075473 | controller |   - perl-Digest
2025-12-03 09:39:54.075600 | controller |   - perl-Digest-MD5
2025-12-03 09:39:54.075723 | controller |   - perl-B
2025-12-03 09:39:54.075847 | controller |   - perl-FileHandle
2025-12-03 09:39:54.075971 | controller |   - perl-Data-Dumper
2025-12-03 09:39:54.076117 | controller |   - perl-libnet
2025-12-03 09:39:54.076263 | controller |   - perl-base
2025-12-03 09:39:54.076389 | controller |   - perl-URI
2025-12-03 09:39:54.076514 | controller |   - perl-AutoLoader
2025-12-03 09:39:54.076639 | controller |   - perl-Mozilla-CA
2025-12-03 09:39:54.076763 | controller |   - perl-if
2025-12-03 09:39:54.076889 | controller |   - perl-IO-Socket-IP
2025-12-03 09:39:54.077013 | controller |   - perl-Time-Local
2025-12-03 09:39:54.077178 | controller |   - perl-File-Path
2025-12-03 09:39:54.077316 | controller |   - perl-Pod-Escapes
2025-12-03 09:39:54.077442 | controller |   - perl-Text-Tabs+Wrap
2025-12-03 09:39:54.077566 | controller |   - perl-IO-Socket-SSL
2025-12-03 09:39:54.077690 | controller |   - perl-Net-SSLeay
2025-12-03 09:39:54.077814 | controller |   - perl-Class-Struct
2025-12-03 09:39:54.077944 | controller |   - perl-POSIX
2025-12-03 09:39:54.078069 | controller |   - perl-Term-ANSIColor
2025-12-03 09:39:54.078262 | controller |   - perl-IPC-Open3
2025-12-03 09:39:54.078397 | controller |   - perl-subs
2025-12-03 09:39:54.078523 | controller |   - perl-File-Temp
2025-12-03 09:39:54.078647 | controller |   - perl-Term-Cap
2025-12-03 09:39:54.078771 | controller |   - perl-Pod-Simple
2025-12-03 09:39:54.078895 | controller |   - perl-HTTP-Tiny
2025-12-03 09:39:54.079020 | controller |   - perl-Socket
2025-12-03 09:39:54.079185 | controller |   - perl-SelectSaver
2025-12-03 09:39:54.079321 | controller |   - perl-Symbol
2025-12-03 09:39:54.079447 | controller |   - perl-File-stat
2025-12-03 09:39:54.079571 | controller |   - perl-podlators
2025-12-03 09:39:54.079696 | controller |   - perl-Pod-Perldoc
2025-12-03 09:39:54.079822 | controller |   - perl-Fcntl
2025-12-03 09:39:54.079947 | controller |   - perl-Text-ParseWords
2025-12-03 09:39:54.080084 | controller |   - perl-mro
2025-12-03 09:39:54.080238 | controller |   - perl-IO
2025-12-03 09:39:54.080371 | controller |   - perl-overloading
2025-12-03 09:39:54.080497 | controller |   - perl-Pod-Usage
2025-12-03 09:39:54.080621 | controller |   - perl-Errno
2025-12-03 09:39:54.080745 | controller |   - perl-File-Basename
2025-12-03 09:39:54.080869 | controller |   - perl-Getopt-Std
2025-12-03 09:39:54.080999 | controller |   - perl-MIME-Base64
2025-12-03 09:39:54.081150 | controller |   - perl-Scalar-List-Utils
2025-12-03 09:39:54.081294 | controller |   - perl-constant
2025-12-03 09:39:54.081419 | controller |   - perl-Storable
2025-12-03 09:39:54.081552 | controller |   - perl-overload
2025-12-03 09:39:54.081676 | controller |   - perl-parent
2025-12-03 09:39:54.081801 | controller |   - perl-vars
2025-12-03 09:39:54.081925 | controller |   - perl-Getopt-Long
2025-12-03 09:39:54.082049 | controller |   - perl-Carp
2025-12-03 09:39:54.082214 | controller |   - perl-Exporter
2025-12-03 09:39:54.082347 | controller |   - perl-NDBM_File
2025-12-03 09:39:54.082473 | controller |   - perl-PathTools
2025-12-03 09:39:54.082597 | controller |   - perl-Encode
2025-12-03 09:39:54.082721 | controller |   - perl-libs
2025-12-03 09:39:54.082845 | controller |   - perl-interpreter
2025-12-03 09:39:54.082976 | controller |   - perl-DynaLoader
2025-12-03 09:39:54.083122 | controller |   - perl-TermReadKey
2025-12-03 09:39:54.083265 | controller |   - perl-Error
2025-12-03 09:39:54.083391 | controller |   - perl-File-Find
2025-12-03 09:39:54.083515 | controller |   - perl-lib
2025-12-03 09:39:54.083638 | controller |   - emacs-filesystem
2025-12-03 09:39:54.083762 | controller |   - perl-Git
2025-12-03 09:39:54.083886 | controller |   - git
2025-12-03 09:39:54.084010 | controller |   - traceroute
2025-12-03 09:39:54.084158 | controller |   - ruby-libs
2025-12-03 09:39:54.084303 | controller |   - rubygem-bigdecimal
2025-12-03 09:39:54.084430 | controller |   - ruby-default-gems
2025-12-03 09:39:54.084555 | controller |   - rubygem-bundler
2025-12-03 09:39:54.084688 | controller |   - rubygem-io-console
2025-12-03 09:39:54.084813 | controller |   - rubygem-json
2025-12-03 09:39:54.084937 | controller |   - rubygem-psych
2025-12-03 09:39:54.085084 | controller |   - rubygem-rdoc
2025-12-03 09:39:54.085240 | controller |   - rubygems
2025-12-03 09:39:54.085369 | controller |   - ruby
2025-12-03 09:39:54.085493 | controller |   - libmpc
2025-12-03 09:39:54.085619 | controller |   - gdb-minimal
2025-12-03 09:39:54.085743 | controller |   - dwz
2025-12-03 09:39:54.085867 | controller |   - unzip
2025-12-03 09:39:54.085991 | controller |   - elfutils
2025-12-03 09:39:54.086139 | controller |   - bzip2
2025-12-03 09:39:54.086284 | controller |   - debugedit
2025-12-03 09:39:54.086410 | controller |   - zip
2025-12-03 09:39:54.086534 | controller |   - cpp
2025-12-03 09:39:54.086660 | controller |   - rust-srpm-macros
2025-12-03 09:39:54.086787 | controller |   - qt5-srpm-macros
2025-12-03 09:39:54.086913 | controller |   - python3-pip
2025-12-03 09:39:54.087039 | controller |   - perl-srpm-macros
2025-12-03 09:39:54.087198 | controller |   - openblas-srpm-macros
2025-12-03 09:39:54.087330 | controller |   - ocaml-srpm-macros
2025-12-03 09:39:54.087460 | controller |   - ncurses-c++-libs
2025-12-03 09:39:54.087588 | controller |   - lua-srpm-macros
2025-12-03 09:39:54.087712 | controller |   - llvm-filesystem
2025-12-03 09:39:54.087835 | controller |   - llvm-libs
2025-12-03 09:39:54.087965 | controller |   - libxslt
2025-12-03 09:39:54.088111 | controller |   - libstemmer
2025-12-03 09:39:54.088259 | controller |   - libstdc++-devel
2025-12-03 09:39:54.088393 | controller |   - libsoup
2025-12-03 09:39:54.088519 | controller |   - libjpeg-turbo
2025-12-03 09:39:54.088643 | controller |   - kernel-srpm-macros
2025-12-03 09:39:54.088768 | controller |   - kernel-headers
2025-12-03 09:39:54.088895 | controller |   - hunspell-filesystem
2025-12-03 09:39:54.089020 | controller |   - hunspell-en-US
2025-12-03 09:39:54.089177 | controller |   - hunspell
2025-12-03 09:39:54.089312 | controller |   - enchant
2025-12-03 09:39:54.089439 | controller |   - python3-enchant
2025-12-03 09:39:54.089573 | controller |   - glibc-headers
2025-12-03 09:39:54.089700 | controller |   - ghc-srpm-macros
2025-12-03 09:39:54.089825 | controller |   - efi-srpm-macros
2025-12-03 09:39:54.089950 | controller |   - desktop-file-utils
2025-12-03 09:39:54.090097 | controller |   - createrepo_c-libs
2025-12-03 09:39:54.090255 | controller |   - cmake-filesystem
2025-12-03 09:39:54.090385 | controller |   - zstd
2025-12-03 09:39:54.090511 | controller |   - tcl
2025-12-03 09:39:54.090637 | controller |   - shared-mime-info
2025-12-03 09:39:54.090762 | controller |   - python3-pyparsing
2025-12-03 09:39:54.090887 | controller |   - python3-packaging
2025-12-03 09:39:54.091012 | controller |   - pkgconf-m4
2025-12-03 09:39:54.091169 | controller |   - make
2025-12-03 09:39:54.091304 | controller |   - libpng
2025-12-03 09:39:54.091431 | controller |   - gdk-pixbuf2
2025-12-03 09:39:54.091565 | controller |   - libappstream-glib
2025-12-03 09:39:54.091693 | controller |   - libpkgconf
2025-12-03 09:39:54.091817 | controller |   - pkgconf
2025-12-03 09:39:54.091942 | controller |   - pkgconf-pkg-config
2025-12-03 09:39:54.092068 | controller |   - libgpg-error-devel
2025-12-03 09:39:54.092243 | controller |   - glibc-devel
2025-12-03 09:39:54.092383 | controller |   - libxcrypt-devel
2025-12-03 09:39:54.092506 | controller |   - gcc
2025-12-03 09:39:54.092630 | controller |   - annobin
2025-12-03 09:39:54.092755 | controller |   - gcc-plugin-annobin
2025-12-03 09:39:54.092880 | controller |   - ncurses-devel
2025-12-03 09:39:54.093002 | controller |   - xz-devel
2025-12-03 09:39:54.093149 | controller |   - zlib-devel
2025-12-03 09:39:54.093295 | controller |   - libxml2-devel
2025-12-03 09:39:54.093418 | controller |   - libnftnl
2025-12-03 09:39:54.093541 | controller |   - iptables-nft
2025-12-03 09:39:54.093664 | controller |   - info
2025-12-03 09:39:54.093788 | controller |   - ed
2025-12-03 09:39:54.093913 | controller |   - patch
2025-12-03 09:39:54.094044 | controller |   - fonts-srpm-macros
2025-12-03 09:39:54.094203 | controller |   - go-srpm-macros
2025-12-03 09:39:54.094334 | controller |   - python-srpm-macros
2025-12-03 09:39:54.094459 | controller |   - redhat-rpm-config
2025-12-03 09:39:54.094583 | controller |   - rpm-build
2025-12-03 09:39:54.094708 | controller |   - pyproject-srpm-macros
2025-12-03 09:39:54.094826 | controller |   - python-rpm-macros
2025-12-03 09:39:54.094941 | controller |   - python3-rpm-macros
2025-12-03 09:39:54.095057 | controller |   - python3-rpm-generators
2025-12-03 09:39:54.095210 | controller |   - cyrus-sasl
2025-12-03 09:39:54.095342 | controller |   - cyrus-sasl-devel
2025-12-03 09:39:54.095468 | controller |   - openldap-devel
2025-12-03 09:39:54.095594 | controller |   - python3-devel
2025-12-03 09:39:54.095718 | controller |   - ruby-devel
2025-12-03 09:39:54.095851 | controller |   - iptables-nft-services
2025-12-03 09:39:54.095976 | controller |   - libxslt-devel
2025-12-03 09:39:54.096119 | controller |   - readline-devel
2025-12-03 09:39:54.096264 | controller |   - gcc-c++
2025-12-03 09:39:54.096398 | controller |   - libffi-devel
2025-12-03 09:39:54.096524 | controller |   - openssl-devel
2025-12-03 09:39:54.096649 | controller |   - rpmlint
2025-12-03 09:39:54.096774 | controller |   - expect
2025-12-03 09:39:54.096899 | controller |   - createrepo_c
2025-12-03 09:39:54.097022 | controller |   - hunspell-en-GB
2025-12-03 09:39:54.097178 | controller |   - wget
2025-12-03 09:39:54.097319 | controller |   - systemd-devel
2025-12-03 09:39:54.097445 | controller |   - time
2025-12-03 09:39:54.097571 | controller |   - rpm-sign
2025-12-03 09:39:54.097702 | controller |   - passt
2025-12-03 09:39:54.097828 | controller |   - passt-selinux
2025-12-03 09:39:54.097960 | controller |   - fuse3-libs
2025-12-03 09:39:54.098115 | controller |   - container-selinux
2025-12-03 09:39:54.098265 | controller |   - protobuf-c
2025-12-03 09:39:54.098394 | controller |   - yajl
2025-12-03 09:39:54.098518 | controller |   - libslirp
2025-12-03 09:39:54.098642 | controller |   - slirp4netns
2025-12-03 09:39:54.098766 | controller |   - libnet
2025-12-03 09:39:54.098880 | controller |   - criu
2025-12-03 09:39:54.098995 | controller |   - criu-libs
2025-12-03 09:39:54.099129 | controller |   - crun
2025-12-03 09:39:54.099260 | controller |   - conmon
2025-12-03 09:39:54.099382 | controller |   - aardvark-dns
2025-12-03 09:39:54.099512 | controller |   - netavark
2025-12-03 09:39:54.099641 | controller |   - shadow-utils-subid
2025-12-03 09:39:54.099766 | controller |   - nftables
2025-12-03 09:39:54.099890 | controller |   - fuse-common
2025-12-03 09:39:54.100016 | controller |   - fuse3
2025-12-03 09:39:54.100175 | controller |   - fuse-overlayfs
2025-12-03 09:39:54.100311 | controller |   - containers-common
2025-12-03 09:39:54.100436 | controller |   - podman
2025-12-03 09:39:54.100568 | controller |   - cyrus-sasl-gssapi
2025-12-03 09:39:54.100693 | controller |   - libvirt-libs
2025-12-03 09:39:54.100817 | controller |   - python3-libvirt
2025-12-03 09:39:54.100941 | controller |   - python3-netaddr
2025-12-03 09:39:54.101064 | controller |   - python3-lxml
2025-12-03 09:39:54.101226 | controller |   - python3-jmespath
2025-12-03 09:39:54.101357 | controller |   - python3-pbr
2025-12-03 09:39:54.101481 | controller |   - python3-typing-extensions
2025-12-03 09:39:54.101606 | controller |   - python3-os-service-types
2025-12-03 09:39:54.101732 | controller |   - python3-stevedore
2025-12-03 09:39:54.101856 | controller |   - python3-iso8601
2025-12-03 09:39:54.101979 | controller |   - python3-decorator
2025-12-03 09:39:54.102131 | controller |   - python3-keystoneauth1
2025-12-03 09:39:54.102277 | controller |   - python3-platformdirs
2025-12-03 09:39:54.102411 | controller |   - python3-psutil
2025-12-03 09:39:54.102535 | controller |   - python3-mako
2025-12-03 09:39:54.102659 | controller |   - python3-dogpile-cache
2025-12-03 09:39:54.102784 | controller |   - python3-ply
2025-12-03 09:39:54.102908 | controller |   - python3-pycparser
2025-12-03 09:39:54.103032 | controller |   - python3-cffi
2025-12-03 09:39:54.103189 | controller |   - python3-cryptography
2025-12-03 09:39:54.103324 | controller |   - python3-requestsexceptions
2025-12-03 09:39:54.103449 | controller |   - python3-openstacksdk
2025-12-03 09:39:54.103636 | controller |
2025-12-03 09:39:54.103770 | controller | TASK [osp.edpm.env_data : Output installed repositories] ***********************
2025-12-03 09:39:54.103898 | controller | Wednesday 03 December 2025  09:39:54 +0000 (0:00:00.058)       0:01:35.363 ****
2025-12-03 09:39:54.104024 | controller | ok: [compute-1] =>
2025-12-03 09:39:54.104183 | controller |   msg: |-
2025-12-03 09:39:54.104326 | controller |     #### REPOSITORIES
2025-12-03 09:39:54.104455 | controller |     repo id                       repo name
2025-12-03 09:39:54.104584 | controller |     appstream                     CentOS Stream 9 - AppStream
2025-12-03 09:39:54.104709 | controller |     baseos                        CentOS Stream 9 - BaseOS
2025-12-03 09:39:54.104836 | controller |     crb                           CentOS Stream 9 - CRB
2025-12-03 09:39:54.104961 | controller |     extras-common                 CentOS Stream 9 - Extras packages
2025-12-03 09:39:54.105100 | controller |
2025-12-03 09:39:54.105252 | controller | TASK [Enable package repos] ****************************************************
2025-12-03 09:39:54.105385 | controller | Wednesday 03 December 2025  09:39:54 +0000 (0:00:00.045)       0:01:35.408 ****
2025-12-03 09:40:01.094747 | controller | changed: [compute-1]
2025-12-03 09:41:59.208156 | controller |
2025-12-03 09:41:59.208196 | controller | TASK [Install openstack-selinux] ***********************************************
2025-12-03 09:41:59.208209 | controller | Wednesday 03 December 2025  09:40:01 +0000 (0:00:07.003)       0:01:42.411 ****
2025-12-03 09:41:59.208222 | controller | changed: [compute-1]
2025-12-03 09:41:59.408198 | controller |
2025-12-03 09:41:59.408239 | controller | TASK [Create config-data telemetry directory] **********************************
2025-12-03 09:41:59.408261 | controller | Wednesday 03 December 2025  09:41:59 +0000 (0:01:58.113)       0:03:40.524 ****
2025-12-03 09:41:59.408275 | controller | changed: [compute-1]
2025-12-03 09:41:59.408299 | controller |
2025-12-03 09:41:59.408310 | controller | TASK [Create /run/libvirt directory] *******************************************
2025-12-03 09:41:59.610583 | controller | Wednesday 03 December 2025  09:41:59 +0000 (0:00:00.200)       0:03:40.725 ****
2025-12-03 09:41:59.610605 | controller | changed: [compute-1]
2025-12-03 09:41:59.610668 | controller |
2025-12-03 09:41:59.610891 | controller | TASK [Create libvirt user] *****************************************************
2025-12-03 09:41:59.821906 | controller | Wednesday 03 December 2025  09:41:59 +0000 (0:00:00.202)       0:03:40.927 ****
2025-12-03 09:41:59.821951 | controller | changed: [compute-1]
2025-12-03 09:42:00.049806 | controller |
2025-12-03 09:42:00.049840 | controller | TASK [Create firewall directory] ***********************************************
2025-12-03 09:42:00.049848 | controller | Wednesday 03 December 2025  09:41:59 +0000 (0:00:00.211)       0:03:41.138 ****
2025-12-03 09:42:00.049858 | controller | changed: [compute-1]
2025-12-03 09:42:00.416889 | controller |
2025-12-03 09:42:00.416921 | controller | TASK [open port 22 (edpm_nftables will active this later)] *********************
2025-12-03 09:42:00.416930 | controller | Wednesday 03 December 2025  09:42:00 +0000 (0:00:00.227)       0:03:41.366 ****
2025-12-03 09:42:00.416954 | controller | changed: [compute-1]
2025-12-03 09:42:00.793798 | controller |
2025-12-03 09:42:00.793829 | controller | TASK [Create ceilometer.conf] **************************************************
2025-12-03 09:42:00.793837 | controller | Wednesday 03 December 2025  09:42:00 +0000 (0:00:00.367)       0:03:41.733 ****
2025-12-03 09:42:00.793847 | controller | changed: [compute-1]
2025-12-03 09:42:01.178511 | controller |
2025-12-03 09:42:01.178542 | controller | TASK [Create polling.yaml] *****************************************************
2025-12-03 09:42:01.178550 | controller | Wednesday 03 December 2025  09:42:00 +0000 (0:00:00.376)       0:03:42.110 ****
2025-12-03 09:42:01.178560 | controller | changed: [compute-1]
2025-12-03 09:42:02.338617 | controller |
2025-12-03 09:42:02.338651 | controller | TASK [Install crypto dependency] ***********************************************
2025-12-03 09:42:02.338660 | controller | Wednesday 03 December 2025  09:42:01 +0000 (0:00:00.384)       0:03:42.495 ****
2025-12-03 09:42:02.338677 | controller | ok: [compute-1]
2025-12-03 09:42:02.543847 | controller |
2025-12-03 09:42:02.543877 | controller | TASK [Create certs directory] **************************************************
2025-12-03 09:42:02.543886 | controller | Wednesday 03 December 2025  09:42:02 +0000 (0:00:01.159)       0:03:43.655 ****
2025-12-03 09:42:02.543897 | controller | changed: [compute-1]
2025-12-03 09:42:05.582224 | controller |
2025-12-03 09:42:05.582281 | controller | TASK [Generate an OpenSSL private key with the default values (4096 bits, RSA)] ***
2025-12-03 09:42:05.582296 | controller | Wednesday 03 December 2025  09:42:02 +0000 (0:00:00.205)       0:03:43.860 ****
2025-12-03 09:42:05.582314 | controller | changed: [compute-1]
2025-12-03 09:42:05.582363 | controller |
2025-12-03 09:42:05.582379 | controller | TASK [Create simple self-signed certificate] ***********************************
2025-12-03 09:42:06.440187 | controller | Wednesday 03 December 2025  09:42:05 +0000 (0:00:03.038)       0:03:46.899 ****
2025-12-03 09:42:06.440229 | controller | changed: [compute-1]
2025-12-03 09:42:06.440265 | controller |
2025-12-03 09:42:06.440275 | controller | PLAY RECAP *********************************************************************
2025-12-03 09:42:06.440283 | controller | compute-1                  : ok=38   changed=20   unreachable=0    failed=0    skipped=1    rescued=0    ignored=1
2025-12-03 09:42:06.440290 | controller |
2025-12-03 09:42:06.440300 | controller | Wednesday 03 December 2025  09:42:06 +0000 (0:00:00.857)       0:03:47.756 ****
2025-12-03 09:42:06.440329 | controller | ===============================================================================
2025-12-03 09:42:06.442541 | controller | Install openstack-selinux --------------------------------------------- 118.11s
2025-12-03 09:42:06.493616 | controller | ../../../../molecule/common/test_deps : Install edpm packages ---------- 71.75s
2025-12-03 09:42:06.493641 | controller | ../../../../molecule/common/test_deps : Install repo-setup pre-requirements --- 9.45s
2025-12-03 09:42:06.493649 | controller | Enable package repos ---------------------------------------------------- 7.00s
2025-12-03 09:42:06.493660 | controller | ../../../../molecule/common/test_deps : Install repo-setup -------------- 3.27s
2025-12-03 09:42:06.493667 | controller | Generate an OpenSSL private key with the default values (4096 bits, RSA) --- 3.04s
2025-12-03 09:42:06.493672 | controller | ../../../../molecule/common/test_deps : Install selinux python libs ----- 1.45s
2025-12-03 09:42:06.493678 | controller | ../../../../molecule/common/test_deps : Install extra packages ---------- 1.42s
2025-12-03 09:42:06.493683 | controller | ../../../../molecule/common/test_deps : Install python yaml libs -------- 1.40s
2025-12-03 09:42:06.493689 | controller | Install crypto dependency ----------------------------------------------- 1.16s
2025-12-03 09:42:06.493694 | controller | ../../../../molecule/common/test_deps : Get repo-setup repository ------- 1.09s
2025-12-03 09:42:06.493700 | controller | Create simple self-signed certificate ----------------------------------- 0.86s
2025-12-03 09:42:06.493705 | controller | ../../../../molecule/common/test_deps : Create repos -------------------- 0.79s
2025-12-03 09:42:06.493711 | controller | osp.edpm.env_data : Gather all installed packages ----------------------- 0.70s
2025-12-03 09:42:06.493716 | controller | ../../../../molecule/common/test_deps : Fetch latest repo version ------- 0.57s
2025-12-03 09:42:06.493722 | controller | ../../../../molecule/common/test_deps : Gather facts if they don't exist --- 0.54s
2025-12-03 09:42:06.493727 | controller | ../../../../molecule/common/test_deps : Create default repo file -------- 0.52s
2025-12-03 09:42:06.493733 | controller | ../../../../molecule/common/test_deps : Create /etc/ansible/facts.d/bootc.fact --- 0.39s
2025-12-03 09:42:06.493738 | controller | Create polling.yaml ----------------------------------------------------- 0.38s
2025-12-03 09:42:06.493744 | controller | Create ceilometer.conf -------------------------------------------------- 0.38s
2025-12-03 09:42:06.493753 | controller | INFO     Running default > converge
2025-12-03 09:42:06.903307 | controller |
2025-12-03 09:42:07.749991 | controller | PLAY [Converge] ****************************************************************
2025-12-03 09:42:07.750024 | controller |
2025-12-03 09:42:07.750032 | controller | TASK [Gathering Facts] *********************************************************
2025-12-03 09:42:07.750044 | controller | Wednesday 03 December 2025  09:42:06 +0000 (0:00:00.048)       0:00:00.048 ****
2025-12-03 09:42:07.750054 | controller | ok: [compute-1]
2025-12-03 09:42:07.834628 | controller |
2025-12-03 09:42:07.834660 | controller | TASK [Test edpm_telemetry_power_monitoring role] *******************************
2025-12-03 09:42:07.834674 | controller | Wednesday 03 December 2025  09:42:07 +0000 (0:00:00.846)       0:00:00.894 ****
2025-12-03 09:42:07.834691 | controller |
2025-12-03 09:42:07.871318 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Validating arguments against arg spec 'main' - The main entry point for the edpm_telemetry role.] ***
2025-12-03 09:42:07.871339 | controller | Wednesday 03 December 2025  09:42:07 +0000 (0:00:00.085)       0:00:00.979 ****
2025-12-03 09:42:07.871351 | controller | ok: [compute-1]
2025-12-03 09:42:07.933999 | controller |
2025-12-03 09:42:07.934017 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Adopt telemetry services from tripleo] ***
2025-12-03 09:42:07.934024 | controller | Wednesday 03 December 2025  09:42:07 +0000 (0:00:00.036)       0:00:01.016 ****
2025-12-03 09:42:07.934033 | controller | included: /home/zuul/.cache/ansible-compat/9c8f65/collections/ansible_collections/osp/edpm/roles/edpm_telemetry_power_monitoring/tasks/adoption.yml for compute-1
2025-12-03 09:42:08.041222 | controller |
2025-12-03 09:42:08.041244 | controller | TASK [Stop and disable ceilometer agent services] ******************************
2025-12-03 09:42:08.041253 | controller | Wednesday 03 December 2025  09:42:07 +0000 (0:00:00.062)       0:00:01.079 ****
2025-12-03 09:42:08.041264 | controller |
2025-12-03 09:42:08.041429 | controller | TASK [osp.edpm.edpm_tripleo_cleanup : Validating arguments against arg spec 'main' - The main entry point for the edpm_tripleo_cleanup role.] ***
2025-12-03 09:42:08.041573 | controller | Wednesday 03 December 2025  09:42:08 +0000 (0:00:00.107)       0:00:01.186 ****
2025-12-03 09:42:08.078648 | controller | ok: [compute-1]
2025-12-03 09:42:08.078832 | controller |
2025-12-03 09:42:08.079027 | controller | TASK [osp.edpm.edpm_tripleo_cleanup : Reload units to check for new changes] ***
2025-12-03 09:42:08.079245 | controller | Wednesday 03 December 2025  09:42:08 +0000 (0:00:00.037)       0:00:01.224 ****
2025-12-03 09:42:08.693768 | controller | ok: [compute-1]
2025-12-03 09:42:10.495722 | controller |
2025-12-03 09:42:10.495753 | controller | TASK [osp.edpm.edpm_tripleo_cleanup : Gather service facts] ********************
2025-12-03 09:42:10.495761 | controller | Wednesday 03 December 2025  09:42:08 +0000 (0:00:00.614)       0:00:01.838 ****
2025-12-03 09:42:10.495771 | controller | ok: [compute-1]
2025-12-03 09:42:10.534810 | controller |
2025-12-03 09:42:10.534839 | controller | TASK [osp.edpm.edpm_tripleo_cleanup : Set list of tripleo services] ************
2025-12-03 09:42:10.534848 | controller | Wednesday 03 December 2025  09:42:10 +0000 (0:00:01.802)       0:00:03.640 ****
2025-12-03 09:42:10.534860 | controller | ok: [compute-1]
2025-12-03 09:42:10.581902 | controller |
2025-12-03 09:42:10.581943 | controller | TASK [osp.edpm.edpm_tripleo_cleanup : Get all services] ************************
2025-12-03 09:42:10.581955 | controller | Wednesday 03 December 2025  09:42:10 +0000 (0:00:00.039)       0:00:03.680 ****
2025-12-03 09:42:10.581967 | controller | skipping: [compute-1]
2025-12-03 09:42:10.629164 | controller |
2025-12-03 09:42:10.629214 | controller | TASK [osp.edpm.edpm_tripleo_cleanup : Filter for tripleo services and skip the ones in skip list] ***
2025-12-03 09:42:10.629225 | controller | Wednesday 03 December 2025  09:42:10 +0000 (0:00:00.047)       0:00:03.727 ****
2025-12-03 09:42:10.629239 | controller | skipping: [compute-1]
2025-12-03 09:42:10.966533 | controller |
2025-12-03 09:42:10.966562 | controller | TASK [osp.edpm.edpm_tripleo_cleanup : Stop and disable tripleo services] *******
2025-12-03 09:42:10.966572 | controller | Wednesday 03 December 2025  09:42:10 +0000 (0:00:00.047)       0:00:03.774 ****
2025-12-03 09:42:10.966582 | controller | ok: [compute-1] => (item=tripleo_ceilometer_agent_ipmi.service)
2025-12-03 09:42:11.008514 | controller |
2025-12-03 09:42:11.008531 | controller | TASK [osp.edpm.edpm_tripleo_cleanup : Check for errors] ************************
2025-12-03 09:42:11.008538 | controller | Wednesday 03 December 2025  09:42:10 +0000 (0:00:00.337)       0:00:04.111 ****
2025-12-03 09:42:11.008547 | controller | skipping: [compute-1] => (item={'failed': False, 'msg': 'Could not find the requested service tripleo_ceilometer_agent_ipmi.service: host', 'invocation': {'module_args': {'name': 'tripleo_ceilometer_agent_ipmi.service', 'state': 'stopped', 'enabled': False, 'daemon_reload': False, 'daemon_reexec': False, 'scope': 'system', 'no_block': False, 'force': None, 'masked': None}}, 'changed': False, 'failed_when_result': False, 'item': 'tripleo_ceilometer_agent_ipmi.service', 'ansible_loop_var': 'item'})
2025-12-03 09:42:11.079022 | controller | skipping: [compute-1]
2025-12-03 09:42:11.079040 | controller |
2025-12-03 09:42:11.079047 | controller | TASK [osp.edpm.edpm_tripleo_cleanup : Remove unit files] ***********************
2025-12-03 09:42:11.079052 | controller | Wednesday 03 December 2025  09:42:11 +0000 (0:00:00.042)       0:00:04.153 ****
2025-12-03 09:42:11.079061 | controller | included: /home/zuul/.cache/ansible-compat/9c8f65/collections/ansible_collections/osp/edpm/roles/edpm_tripleo_cleanup/tasks/remove_unit_files.yml for compute-1 => (item=/usr/lib/systemd/system)
2025-12-03 09:42:11.396188 | controller | included: /home/zuul/.cache/ansible-compat/9c8f65/collections/ansible_collections/osp/edpm/roles/edpm_tripleo_cleanup/tasks/remove_unit_files.yml for compute-1 => (item=/etc/systemd/system)
2025-12-03 09:42:11.396230 | controller |
2025-12-03 09:42:11.396244 | controller | TASK [osp.edpm.edpm_tripleo_cleanup : Remove unit files from the location: /usr/lib/systemd/system] ***
2025-12-03 09:42:11.396254 | controller | Wednesday 03 December 2025  09:42:11 +0000 (0:00:00.069)       0:00:04.223 ****
2025-12-03 09:42:11.396270 | controller | ok: [compute-1] => (item=tripleo_ceilometer_agent_ipmi.service)
2025-12-03 09:42:11.628792 | controller |
2025-12-03 09:42:11.628827 | controller | TASK [osp.edpm.edpm_tripleo_cleanup : Remove unit files from the location: /etc/systemd/system] ***
2025-12-03 09:42:11.628836 | controller | Wednesday 03 December 2025  09:42:11 +0000 (0:00:00.317)       0:00:04.541 ****
2025-12-03 09:42:11.628848 | controller | ok: [compute-1] => (item=tripleo_ceilometer_agent_ipmi.service)
2025-12-03 09:42:11.727209 | controller |
2025-12-03 09:42:11.727241 | controller | TASK [Adopt (stop tracking) certs from tripleo] ********************************
2025-12-03 09:42:11.727266 | controller | Wednesday 03 December 2025  09:42:11 +0000 (0:00:00.232)       0:00:04.773 ****
2025-12-03 09:42:11.727280 | controller |
2025-12-03 09:42:11.727613 | controller | TASK [osp.edpm.edpm_install_certs : Stop and disable certmonger] ***************
2025-12-03 09:42:12.019832 | controller | Wednesday 03 December 2025  09:42:11 +0000 (0:00:00.098)       0:00:04.872 ****
2025-12-03 09:42:12.019855 | controller | ok: [compute-1]
2025-12-03 09:42:12.295474 | controller |
2025-12-03 09:42:12.295495 | controller | TASK [osp.edpm.edpm_install_certs : Find certmonger requests] ******************
2025-12-03 09:42:12.295508 | controller | Wednesday 03 December 2025  09:42:12 +0000 (0:00:00.292)       0:00:05.164 ****
2025-12-03 09:42:12.295518 | controller | [WARNING]: Skipped '/var/lib/certmonger/requests' path due to this access
2025-12-03 09:42:12.321051 | controller | issue: '/var/lib/certmonger/requests' is not a directory
2025-12-03 09:42:12.321089 | controller | ok: [compute-1]
2025-12-03 09:42:12.359934 | controller |
2025-12-03 09:42:12.359952 | controller | TASK [osp.edpm.edpm_install_certs : Backup certificate requests] ***************
2025-12-03 09:42:12.359960 | controller | Wednesday 03 December 2025  09:42:12 +0000 (0:00:00.301)       0:00:05.466 ****
2025-12-03 09:42:12.359969 | controller | skipping: [compute-1]
2025-12-03 09:42:12.444776 | controller |
2025-12-03 09:42:12.444800 | controller | TASK [osp.edpm.edpm_install_certs : Remove certificate requests] ***************
2025-12-03 09:42:12.444810 | controller | Wednesday 03 December 2025  09:42:12 +0000 (0:00:00.038)       0:00:05.505 ****
2025-12-03 09:42:12.444821 | controller | skipping: [compute-1]
2025-12-03 09:42:12.882206 | controller |
2025-12-03 09:42:12.882250 | controller | TASK [osp.edpm.edpm_tripleo_cleanup : Reload units] ****************************
2025-12-03 09:42:12.882262 | controller | Wednesday 03 December 2025  09:42:12 +0000 (0:00:00.084)       0:00:05.589 ****
2025-12-03 09:42:12.882277 | controller | ok: [compute-1]
2025-12-03 09:42:12.882308 | controller |
2025-12-03 09:42:12.882320 | controller | TASK [osp.edpm.edpm_tripleo_cleanup : Reset state of failed systemd units] *****
2025-12-03 09:42:12.882459 | controller | Wednesday 03 December 2025  09:42:12 +0000 (0:00:00.437)       0:00:06.027 ****
2025-12-03 09:42:13.126533 | controller | changed: [compute-1] => (item=tripleo_ceilometer_agent_ipmi.service)
2025-12-03 09:42:13.424856 | controller |
2025-12-03 09:42:13.424890 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Gather user fact] *************
2025-12-03 09:42:13.424900 | controller | Wednesday 03 December 2025  09:42:13 +0000 (0:00:00.244)       0:00:06.271 ****
2025-12-03 09:42:13.424912 | controller | ok: [compute-1]
2025-12-03 09:42:13.684826 | controller |
2025-12-03 09:42:13.684859 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Create ceilometer config dir] ***
2025-12-03 09:42:13.684867 | controller | Wednesday 03 December 2025  09:42:13 +0000 (0:00:00.298)       0:00:06.569 ****
2025-12-03 09:42:13.684877 | controller | changed: [compute-1] => (item={'path': '/var/lib/openstack/telemetry-power-monitoring'})
2025-12-03 09:42:13.952834 | controller |
2025-12-03 09:42:13.952866 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Determine if cacert file exists] ***
2025-12-03 09:42:13.952877 | controller | Wednesday 03 December 2025  09:42:13 +0000 (0:00:00.259)       0:00:06.829 ****
2025-12-03 09:42:13.952889 | controller | ok: [compute-1]
2025-12-03 09:42:14.378684 | controller |
2025-12-03 09:42:14.378718 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Render ceilometer config template] ***
2025-12-03 09:42:14.378727 | controller | Wednesday 03 December 2025  09:42:13 +0000 (0:00:00.267)       0:00:07.097 ****
2025-12-03 09:42:14.378739 | controller | changed: [compute-1]
2025-12-03 09:42:14.713204 | controller |
2025-12-03 09:42:14.713239 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Copy static config files] *****
2025-12-03 09:42:14.713250 | controller | Wednesday 03 December 2025  09:42:14 +0000 (0:00:00.425)       0:00:07.523 ****
2025-12-03 09:42:14.713262 | controller | changed: [compute-1]
2025-12-03 09:42:14.713292 | controller |
2025-12-03 09:42:14.713501 | controller | TASK [osp.edpm.edpm_users : Validating arguments against arg spec 'main' - The main entry point for the edpm_users role.] ***
2025-12-03 09:42:14.752185 | controller | Wednesday 03 December 2025  09:42:14 +0000 (0:00:00.334)       0:00:07.858 ****
2025-12-03 09:42:14.752218 | controller | ok: [compute-1]
2025-12-03 09:42:14.752300 | controller |
2025-12-03 09:42:14.752338 | controller | TASK [osp.edpm.edpm_users : Gather user fact] **********************************
2025-12-03 09:42:14.752371 | controller | Wednesday 03 December 2025  09:42:14 +0000 (0:00:00.038)       0:00:07.897 ****
2025-12-03 09:42:15.068988 | controller | ok: [compute-1]
2025-12-03 09:42:15.136727 | controller |
2025-12-03 09:42:15.136754 | controller | TASK [osp.edpm.edpm_users : Create host users and groups] **********************
2025-12-03 09:42:15.136763 | controller | Wednesday 03 December 2025  09:42:15 +0000 (0:00:00.316)       0:00:08.214 ****
2025-12-03 09:42:15.136776 | controller | included: /home/zuul/.cache/ansible-compat/9c8f65/collections/ansible_collections/osp/edpm/roles/edpm_users/tasks/create_users_and_groups.yml for compute-1 => (item={'name': 'ceilometer', 'uid': '42405', 'gid': '42405', 'shell': '/sbin/nologin', 'comment': 'ceilometer user', 'groups': 'libvirt'})
2025-12-03 09:42:15.425841 | controller |
2025-12-03 09:42:15.425868 | controller | TASK [osp.edpm.edpm_users : Detect when user exists and cannot be created] *****
2025-12-03 09:42:15.425877 | controller | Wednesday 03 December 2025  09:42:15 +0000 (0:00:00.067)       0:00:08.281 ****
2025-12-03 09:42:15.425886 | controller | fatal: [compute-1]: FAILED! => changed=false
2025-12-03 09:42:15.454061 | controller |   msg: One or more supplied key could not be found in the database.
2025-12-03 09:42:15.454123 | controller | ...ignoring
2025-12-03 09:42:15.809850 | controller |
2025-12-03 09:42:15.809874 | controller | TASK [osp.edpm.edpm_users : Ensure group is present on the host [ ceilometer ]] ***
2025-12-03 09:42:15.809883 | controller | Wednesday 03 December 2025  09:42:15 +0000 (0:00:00.317)       0:00:08.599 ****
2025-12-03 09:42:15.809893 | controller | changed: [compute-1]
2025-12-03 09:42:16.257175 | controller |
2025-12-03 09:42:16.257207 | controller | TASK [osp.edpm.edpm_users : Ensure user is present on the host [ ceilometer ]] ***
2025-12-03 09:42:16.257218 | controller | Wednesday 03 December 2025  09:42:15 +0000 (0:00:00.355)       0:00:08.954 ****
2025-12-03 09:42:16.257236 | controller | changed: [compute-1]
2025-12-03 09:42:16.257265 | controller |
2025-12-03 09:42:16.257276 | controller | TASK [osp.edpm.edpm_users : Create host directories] ***************************
2025-12-03 09:42:16.257435 | controller | Wednesday 03 December 2025  09:42:16 +0000 (0:00:00.447)       0:00:09.402 ****
2025-12-03 09:42:16.317257 | controller | skipping: [compute-1]
2025-12-03 09:42:16.357158 | controller |
2025-12-03 09:42:16.357194 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Gather ceilometer config files] ***
2025-12-03 09:42:16.357202 | controller | Wednesday 03 December 2025  09:42:16 +0000 (0:00:00.060)       0:00:09.462 ****
2025-12-03 09:42:16.357211 | controller | ok: [compute-1]
2025-12-03 09:42:16.357306 | controller |
2025-12-03 09:42:16.357330 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Check for custom.conf existence] ***
2025-12-03 09:42:16.357345 | controller | Wednesday 03 December 2025  09:42:16 +0000 (0:00:00.040)       0:00:09.502 ****
2025-12-03 09:42:16.540991 | controller | ok: [compute-1 -> localhost]
2025-12-03 09:42:16.575856 | controller |
2025-12-03 09:42:16.575882 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Append custom.conf to config files] ***
2025-12-03 09:42:16.575893 | controller | Wednesday 03 December 2025  09:42:16 +0000 (0:00:00.183)       0:00:09.686 ****
2025-12-03 09:42:16.575906 | controller | skipping: [compute-1]
2025-12-03 09:42:16.977796 | controller |
2025-12-03 09:42:16.977832 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Copy generated ceilometer configs] ***
2025-12-03 09:42:16.977843 | controller | Wednesday 03 December 2025  09:42:16 +0000 (0:00:00.035)       0:00:09.721 ****
2025-12-03 09:42:16.977858 | controller | changed: [compute-1] => (item={'src': '/var/lib/openstack/configs/telemetry-power-monitoring/ceilometer.conf', 'dest': '/var/lib/openstack/telemetry-power-monitoring/ceilometer.conf'})
2025-12-03 09:42:17.184563 | controller | changed: [compute-1] => (item={'src': '/var/lib/openstack/configs/telemetry-power-monitoring/polling.yaml', 'dest': '/var/lib/openstack/telemetry-power-monitoring/polling.yaml'})
2025-12-03 09:42:17.184588 | controller |
2025-12-03 09:42:17.184596 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Check that tls.crt exists] ****
2025-12-03 09:42:17.184603 | controller | Wednesday 03 December 2025  09:42:16 +0000 (0:00:00.401)       0:00:10.122 ****
2025-12-03 09:42:17.184613 | controller | ok: [compute-1]
2025-12-03 09:42:17.377184 | controller |
2025-12-03 09:42:17.377218 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Check that tls.key exists] ****
2025-12-03 09:42:17.377228 | controller | Wednesday 03 December 2025  09:42:17 +0000 (0:00:00.206)       0:00:10.329 ****
2025-12-03 09:42:17.377240 | controller | ok: [compute-1]
2025-12-03 09:42:17.732184 | controller |
2025-12-03 09:42:17.732218 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Copy TLS config for ceilometer_prom_exporter] ***
2025-12-03 09:42:17.732230 | controller | Wednesday 03 December 2025  09:42:17 +0000 (0:00:00.192)       0:00:10.522 ****
2025-12-03 09:42:17.732242 | controller | changed: [compute-1]
2025-12-03 09:42:17.732274 | controller |
2025-12-03 09:42:17.732493 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Change the owner of the crt] ***
2025-12-03 09:42:17.963031 | controller | Wednesday 03 December 2025  09:42:17 +0000 (0:00:00.355)       0:00:10.877 ****
2025-12-03 09:42:17.963064 | controller | changed: [compute-1]
2025-12-03 09:42:18.193500 | controller |
2025-12-03 09:42:18.193530 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Change the owner of the key] ***
2025-12-03 09:42:18.193539 | controller | Wednesday 03 December 2025  09:42:17 +0000 (0:00:00.230)       0:00:11.108 ****
2025-12-03 09:42:18.193549 | controller | changed: [compute-1]
2025-12-03 09:42:18.427197 | controller |
2025-12-03 09:42:18.427244 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Create a directory for container health checks] ***
2025-12-03 09:42:18.427256 | controller | Wednesday 03 December 2025  09:42:18 +0000 (0:00:00.230)       0:00:11.338 ****
2025-12-03 09:42:18.427270 | controller | changed: [compute-1]
2025-12-03 09:42:18.427295 | controller |
2025-12-03 09:42:18.427526 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Deploy telemetry health check scripts] ***
2025-12-03 09:42:19.446144 | controller | Wednesday 03 December 2025  09:42:18 +0000 (0:00:00.233)       0:00:11.572 ****
2025-12-03 09:42:19.446177 | controller | changed: [compute-1] => (item={'key': 'ceilometer_agent_ipmi', 'value': 'ceilometer_agent'})
2025-12-03 09:42:19.543886 | controller | changed: [compute-1] => (item={'key': 'kepler', 'value': 'exporter'})
2025-12-03 09:42:19.543909 | controller |
2025-12-03 09:42:19.543928 | controller | TASK [Deploy ceilometer ipmi container] ****************************************
2025-12-03 09:42:19.543935 | controller | Wednesday 03 December 2025  09:42:19 +0000 (0:00:01.018)       0:00:12.591 ****
2025-12-03 09:42:19.543944 | controller |
2025-12-03 09:42:19.645721 | controller | TASK [osp.edpm.edpm_container_standalone : Validating arguments against arg spec 'main' - The main entry point for the edpm_container_standalone role.] ***
2025-12-03 09:42:19.645746 | controller | Wednesday 03 December 2025  09:42:19 +0000 (0:00:00.098)       0:00:12.689 ****
2025-12-03 09:42:19.645760 | controller | ok: [compute-1]
2025-12-03 09:42:19.873852 | controller |
2025-12-03 09:42:19.873884 | controller | TASK [osp.edpm.edpm_container_standalone : Ensure /var/lib/edpm-config exists with correct ownership] ***
2025-12-03 09:42:19.873892 | controller | Wednesday 03 December 2025  09:42:19 +0000 (0:00:00.101)       0:00:12.790 ****
2025-12-03 09:42:19.873903 | controller | changed: [compute-1]
2025-12-03 09:42:20.090784 | controller |
2025-12-03 09:42:20.090813 | controller | TASK [osp.edpm.edpm_container_standalone : Ensure directory exists: /var/lib/kolla/config_files] ***
2025-12-03 09:42:20.090821 | controller | Wednesday 03 December 2025  09:42:19 +0000 (0:00:00.228)       0:00:13.018 ****
2025-12-03 09:42:20.090831 | controller | changed: [compute-1]
2025-12-03 09:42:20.487090 | controller |
2025-12-03 09:42:20.487119 | controller | TASK [osp.edpm.edpm_container_standalone : Create kolla config files] **********
2025-12-03 09:42:20.487127 | controller | Wednesday 03 December 2025  09:42:20 +0000 (0:00:00.217)       0:00:13.235 ****
2025-12-03 09:42:20.487139 | controller | changed: [compute-1] => (item={'key': 'ceilometer_agent_ipmi', 'value': {'command': '/usr/bin/ceilometer-polling --polling-namespaces ipmi --logfile /dev/stdout', 'config_files': [{'source': '/var/lib/kolla/config_files/src/ceilometer.conf', 'dest': '/etc/ceilometer/ceilometer.conf', 'owner': 'ceilometer', 'perm': '0600'}, {'source': '/var/lib/kolla/config_files/src/polling.yaml', 'dest': '/etc/ceilometer/polling.yaml', 'owner': 'ceilometer', 'perm': '0600'}, {'source': '/var/lib/kolla/config_files/src/custom.conf', 'dest': '/etc/ceilometer/ceilometer.conf.d/01-ceilometer-custom.conf', 'owner': 'ceilometer', 'perm': '0600', 'optional': True}, {'source': '/var/lib/kolla/config_files/src/ceilometer-host-specific.conf', 'dest': '/etc/ceilometer/ceilometer.conf.d/02-ceilometer-host-specific.conf', 'owner': 'ceilometer', 'perm': '0600', 'optional': True}]}})
2025-12-03 09:42:20.713240 | controller |
2025-12-03 09:42:20.713271 | controller | TASK [osp.edpm.edpm_container_standalone : Create config file /var/lib/edpm-config/container-startup-config/ceilometer_agent_ipmi] ***
2025-12-03 09:42:20.713281 | controller | Wednesday 03 December 2025  09:42:20 +0000 (0:00:00.395)       0:00:13.631 ****
2025-12-03 09:42:20.713300 | controller | changed: [compute-1]
2025-12-03 09:42:20.713330 | controller |
2025-12-03 09:42:20.713767 | controller | TASK [osp.edpm.edpm_container_standalone : Render container definitions: [ceilometer_agent_ipmi ]] ***
2025-12-03 09:42:21.112036 | controller | Wednesday 03 December 2025  09:42:20 +0000 (0:00:00.226)       0:00:13.858 ****
2025-12-03 09:42:21.112067 | controller | changed: [compute-1] => (item=None)
2025-12-03 09:42:21.188713 | controller | changed: [compute-1]
2025-12-03 09:42:21.188739 | controller |
2025-12-03 09:42:21.188749 | controller | TASK [Run containers: [ ceilometer_agent_ipmi ]] *******************************
2025-12-03 09:42:21.188757 | controller | Wednesday 03 December 2025  09:42:21 +0000 (0:00:00.398)       0:00:14.256 ****
2025-12-03 09:42:21.188768 | controller |
2025-12-03 09:42:21.286658 | controller | TASK [osp.edpm.edpm_container_manage : Validating arguments against arg spec 'main' - The main entry point for the edpm_container_manage role.] ***
2025-12-03 09:42:21.286687 | controller | Wednesday 03 December 2025  09:42:21 +0000 (0:00:00.077)       0:00:14.334 ****
2025-12-03 09:42:21.286700 | controller | ok: [compute-1]
2025-12-03 09:42:21.600173 | controller |
2025-12-03 09:42:21.600211 | controller | TASK [osp.edpm.edpm_container_manage : Find all matching configs configs for in /var/lib/edpm-config/container-startup-config/ceilometer_agent_ipmi] ***
2025-12-03 09:42:21.600221 | controller | Wednesday 03 December 2025  09:42:21 +0000 (0:00:00.097)       0:00:14.431 ****
2025-12-03 09:42:21.600234 | controller | ok: [compute-1]
2025-12-03 09:42:21.600256 | controller |
2025-12-03 09:42:21.600443 | controller | TASK [osp.edpm.edpm_container_manage : Initialize all_containers_hash for this invocation] ***
2025-12-03 09:42:21.746987 | controller | Wednesday 03 December 2025  09:42:21 +0000 (0:00:00.313)       0:00:14.745 ****
2025-12-03 09:42:21.747021 | controller | ok: [compute-1]
2025-12-03 09:42:21.886891 | controller |
2025-12-03 09:42:21.886933 | controller | TASK [osp.edpm.edpm_container_manage : Filter configs if container list provided] ***
2025-12-03 09:42:21.886943 | controller | Wednesday 03 December 2025  09:42:21 +0000 (0:00:00.146)       0:00:14.892 ****
2025-12-03 09:42:21.886954 | controller | ok: [compute-1] => (item=ceilometer_agent_ipmi)
2025-12-03 09:42:21.981603 | controller |
2025-12-03 09:42:21.981627 | controller | TASK [osp.edpm.edpm_container_manage : Use all configs if no filter] ***********
2025-12-03 09:42:21.981635 | controller | Wednesday 03 December 2025  09:42:21 +0000 (0:00:00.139)       0:00:15.032 ****
2025-12-03 09:42:21.981644 | controller | skipping: [compute-1]
2025-12-03 09:42:22.330644 | controller |
2025-12-03 09:42:22.330676 | controller | TASK [osp.edpm.edpm_container_manage : Update container configs with new config hashes] ***
2025-12-03 09:42:22.330685 | controller | Wednesday 03 December 2025  09:42:21 +0000 (0:00:00.094)       0:00:15.126 ****
2025-12-03 09:42:22.330696 | controller | changed: [compute-1]
2025-12-03 09:42:22.436908 | controller |
2025-12-03 09:42:22.436959 | controller | TASK [osp.edpm.edpm_container_manage : Delete orphan containers (DEPRECATED)] ***
2025-12-03 09:42:22.436972 | controller | Wednesday 03 December 2025  09:42:22 +0000 (0:00:00.349)       0:00:15.475 ****
2025-12-03 09:42:22.436988 | controller | included: /home/zuul/.cache/ansible-compat/9c8f65/collections/ansible_collections/osp/edpm/roles/edpm_container_manage/tasks/delete_orphan.yml for compute-1
2025-12-03 09:42:22.810201 | controller |
2025-12-03 09:42:22.810235 | controller | TASK [osp.edpm.edpm_container_manage : Gather podman infos] ********************
2025-12-03 09:42:22.810243 | controller | Wednesday 03 December 2025  09:42:22 +0000 (0:00:00.106)       0:00:15.581 ****
2025-12-03 09:42:22.810253 | controller | ok: [compute-1]
2025-12-03 09:42:22.867209 | controller |
2025-12-03 09:42:22.867247 | controller | TASK [osp.edpm.edpm_container_manage : Exclude Ceph containers from podman container list] ***
2025-12-03 09:42:22.867263 | controller | Wednesday 03 December 2025  09:42:22 +0000 (0:00:00.373)       0:00:15.955 ****
2025-12-03 09:42:22.867275 | controller | ok: [compute-1]
2025-12-03 09:42:22.867283 | controller |
2025-12-03 09:42:22.867289 | controller | TASK [Delete orphan containers managed by Podman for /var/lib/edpm-config/container-startup-config/ceilometer_agent_ipmi] ***
2025-12-03 09:42:22.867298 | controller | Wednesday 03 December 2025  09:42:22 +0000 (0:00:00.057)       0:00:16.012 ****
2025-12-03 09:42:22.948892 | controller |
2025-12-03 09:42:23.006657 | controller | TASK [osp.edpm.edpm_container_rm : Validating arguments against arg spec 'main' - The main entry point for the edpm_container_rm role.] ***
2025-12-03 09:42:23.006677 | controller | Wednesday 03 December 2025  09:42:22 +0000 (0:00:00.081)       0:00:16.094 ****
2025-12-03 09:42:23.006689 | controller | ok: [compute-1]
2025-12-03 09:42:23.109031 | controller |
2025-12-03 09:42:23.109055 | controller | TASK [osp.edpm.edpm_container_rm : Include edpm container rm task file] ********
2025-12-03 09:42:23.109065 | controller | Wednesday 03 December 2025  09:42:23 +0000 (0:00:00.057)       0:00:16.151 ****
2025-12-03 09:42:23.109096 | controller | skipping: [compute-1]
2025-12-03 09:42:23.190113 | controller |
2025-12-03 09:42:23.190133 | controller | TASK [osp.edpm.edpm_container_manage : Create containers from /var/lib/edpm-config/container-startup-config/ceilometer_agent_ipmi] ***
2025-12-03 09:42:23.190142 | controller | Wednesday 03 December 2025  09:42:23 +0000 (0:00:00.102)       0:00:16.254 ****
2025-12-03 09:42:23.190151 | controller | included: /home/zuul/.cache/ansible-compat/9c8f65/collections/ansible_collections/osp/edpm/roles/edpm_container_manage/tasks/create.yml for compute-1
2025-12-03 09:42:31.444172 | controller |
2025-12-03 09:42:31.444208 | controller | TASK [osp.edpm.edpm_container_manage : Create containers managed by Podman for /var/lib/edpm-config/container-startup-config/ceilometer_agent_ipmi] ***
2025-12-03 09:42:31.444219 | controller | Wednesday 03 December 2025  09:42:23 +0000 (0:00:00.081)       0:00:16.335 ****
2025-12-03 09:42:31.444233 | controller | changed: [compute-1]
2025-12-03 09:42:31.444261 | controller |
2025-12-03 09:42:31.444272 | controller | TASK [osp.edpm.edpm_container_manage : Check if /etc/sysconfig/podman_drop_in exists] ***
2025-12-03 09:42:31.444386 | controller | Wednesday 03 December 2025  09:42:31 +0000 (0:00:08.254)       0:00:24.589 ****
2025-12-03 09:42:31.677519 | controller | ok: [compute-1]
2025-12-03 09:42:31.735284 | controller |
2025-12-03 09:42:31.735307 | controller | TASK [osp.edpm.edpm_container_manage : Set podman_drop_in fact] ****************
2025-12-03 09:42:31.735315 | controller | Wednesday 03 December 2025  09:42:31 +0000 (0:00:00.233)       0:00:24.822 ****
2025-12-03 09:42:31.735325 | controller | skipping: [compute-1]
2025-12-03 09:42:33.448733 | controller |
2025-12-03 09:42:33.448766 | controller | TASK [osp.edpm.edpm_container_manage : Manage container systemd services and cleanup old systemd healthchecks for /var/lib/edpm-config/container-startup-config/ceilometer_agent_ipmi] ***
2025-12-03 09:42:33.448775 | controller | Wednesday 03 December 2025  09:42:31 +0000 (0:00:00.057)       0:00:24.880 ****
2025-12-03 09:42:33.448786 | controller | changed: [compute-1]
2025-12-03 09:42:33.562249 | controller |
2025-12-03 09:42:33.562281 | controller | TASK [osp.edpm.edpm_container_standalone : Update service state file] **********
2025-12-03 09:42:33.562297 | controller | Wednesday 03 December 2025  09:42:33 +0000 (0:00:01.713)       0:00:26.593 ****
2025-12-03 09:42:33.562310 | controller | included: /home/zuul/.cache/ansible-compat/9c8f65/collections/ansible_collections/osp/edpm/roles/edpm_container_standalone/tasks/state_file_update.yml for compute-1
2025-12-03 09:42:33.826261 | controller |
2025-12-03 09:42:33.826291 | controller | TASK [osp.edpm.edpm_container_standalone : Read current state file] ************
2025-12-03 09:42:33.826299 | controller | Wednesday 03 December 2025  09:42:33 +0000 (0:00:00.113)       0:00:26.707 ****
2025-12-03 09:42:33.826309 | controller | ok: [compute-1]
2025-12-03 09:42:33.870377 | controller |
2025-12-03 09:42:33.870406 | controller | TASK [osp.edpm.edpm_container_standalone : Parse state file data] **************
2025-12-03 09:42:33.870417 | controller | Wednesday 03 December 2025  09:42:33 +0000 (0:00:00.263)       0:00:26.971 ****
2025-12-03 09:42:33.870429 | controller | skipping: [compute-1]
2025-12-03 09:42:33.914838 | controller |
2025-12-03 09:42:33.914872 | controller | TASK [osp.edpm.edpm_container_standalone : Initialize empty state data if file doesn't exist] ***
2025-12-03 09:42:33.914883 | controller | Wednesday 03 December 2025  09:42:33 +0000 (0:00:00.044)       0:00:27.015 ****
2025-12-03 09:42:33.914896 | controller | ok: [compute-1]
2025-12-03 09:42:34.028632 | controller |
2025-12-03 09:42:34.028663 | controller | TASK [osp.edpm.edpm_container_standalone : Update service in state data] *******
2025-12-03 09:42:34.028674 | controller | Wednesday 03 December 2025  09:42:33 +0000 (0:00:00.044)       0:00:27.060 ****
2025-12-03 09:42:34.028686 | controller | ok: [compute-1]
2025-12-03 09:42:34.453209 | controller |
2025-12-03 09:42:34.453241 | controller | TASK [osp.edpm.edpm_container_standalone : Write updated state file] ***********
2025-12-03 09:42:34.453249 | controller | Wednesday 03 December 2025  09:42:34 +0000 (0:00:00.113)       0:00:27.173 ****
2025-12-03 09:42:34.453258 | controller | changed: [compute-1]
2025-12-03 09:42:34.531516 | controller |
2025-12-03 09:42:34.531544 | controller | TASK [Deploy Kepler container] *************************************************
2025-12-03 09:42:34.531554 | controller | Wednesday 03 December 2025  09:42:34 +0000 (0:00:00.424)       0:00:27.598 ****
2025-12-03 09:42:34.531566 | controller |
2025-12-03 09:42:34.630848 | controller | TASK [osp.edpm.edpm_container_standalone : Validating arguments against arg spec 'main' - The main entry point for the edpm_container_standalone role.] ***
2025-12-03 09:42:34.630878 | controller | Wednesday 03 December 2025  09:42:34 +0000 (0:00:00.078)       0:00:27.676 ****
2025-12-03 09:42:34.630891 | controller | ok: [compute-1]
2025-12-03 09:42:34.885197 | controller |
2025-12-03 09:42:34.885231 | controller | TASK [osp.edpm.edpm_container_standalone : Ensure /var/lib/edpm-config exists with correct ownership] ***
2025-12-03 09:42:34.885241 | controller | Wednesday 03 December 2025  09:42:34 +0000 (0:00:00.099)       0:00:27.776 ****
2025-12-03 09:42:34.885253 | controller | changed: [compute-1]
2025-12-03 09:42:35.142210 | controller |
2025-12-03 09:42:35.142248 | controller | TASK [osp.edpm.edpm_container_standalone : Ensure directory exists: /var/lib/kolla/config_files] ***
2025-12-03 09:42:35.142258 | controller | Wednesday 03 December 2025  09:42:34 +0000 (0:00:00.254)       0:00:28.030 ****
2025-12-03 09:42:35.142270 | controller | ok: [compute-1]
2025-12-03 09:42:35.142304 | controller |
2025-12-03 09:42:35.142512 | controller | TASK [osp.edpm.edpm_container_standalone : Create kolla config files] **********
2025-12-03 09:42:35.191181 | controller | Wednesday 03 December 2025  09:42:35 +0000 (0:00:00.257)       0:00:28.287 ****
2025-12-03 09:42:35.191214 | controller | skipping: [compute-1]
2025-12-03 09:42:35.191290 | controller |
2025-12-03 09:42:35.191312 | controller | TASK [osp.edpm.edpm_container_standalone : Create config file /var/lib/edpm-config/container-startup-config/kepler] ***
2025-12-03 09:42:35.191326 | controller | Wednesday 03 December 2025  09:42:35 +0000 (0:00:00.048)       0:00:28.336 ****
2025-12-03 09:42:35.390233 | controller | changed: [compute-1]
2025-12-03 09:42:35.774752 | controller |
2025-12-03 09:42:35.774775 | controller | TASK [osp.edpm.edpm_container_standalone : Render container definitions: [kepler ]] ***
2025-12-03 09:42:35.774784 | controller | Wednesday 03 December 2025  09:42:35 +0000 (0:00:00.198)       0:00:28.535 ****
2025-12-03 09:42:35.774794 | controller | changed: [compute-1] => (item=None)
2025-12-03 09:42:35.874967 | controller | changed: [compute-1]
2025-12-03 09:42:35.875001 | controller |
2025-12-03 09:42:35.875015 | controller | TASK [Run containers: [ kepler ]] **********************************************
2025-12-03 09:42:35.875026 | controller | Wednesday 03 December 2025  09:42:35 +0000 (0:00:00.384)       0:00:28.919 ****
2025-12-03 09:42:35.875042 | controller |
2025-12-03 09:42:35.978193 | controller | TASK [osp.edpm.edpm_container_manage : Validating arguments against arg spec 'main' - The main entry point for the edpm_container_manage role.] ***
2025-12-03 09:42:35.978230 | controller | Wednesday 03 December 2025  09:42:35 +0000 (0:00:00.100)       0:00:29.020 ****
2025-12-03 09:42:35.978246 | controller | ok: [compute-1]
2025-12-03 09:42:35.978277 | controller |
2025-12-03 09:42:35.978289 | controller | TASK [osp.edpm.edpm_container_manage : Find all matching configs configs for in /var/lib/edpm-config/container-startup-config/kepler] ***
2025-12-03 09:42:35.978329 | controller | Wednesday 03 December 2025  09:42:35 +0000 (0:00:00.103)       0:00:29.123 ****
2025-12-03 09:42:36.208179 | controller | ok: [compute-1]
2025-12-03 09:42:36.208238 | controller |
2025-12-03 09:42:36.208508 | controller | TASK [osp.edpm.edpm_container_manage : Initialize all_containers_hash for this invocation] ***
2025-12-03 09:42:36.308209 | controller | Wednesday 03 December 2025  09:42:36 +0000 (0:00:00.229)       0:00:29.353 ****
2025-12-03 09:42:36.308247 | controller | ok: [compute-1]
2025-12-03 09:42:36.452198 | controller |
2025-12-03 09:42:36.452240 | controller | TASK [osp.edpm.edpm_container_manage : Filter configs if container list provided] ***
2025-12-03 09:42:36.452253 | controller | Wednesday 03 December 2025  09:42:36 +0000 (0:00:00.099)       0:00:29.453 ****
2025-12-03 09:42:36.452269 | controller | ok: [compute-1] => (item=kepler)
2025-12-03 09:42:36.452312 | controller |
2025-12-03 09:42:36.452326 | controller | TASK [osp.edpm.edpm_container_manage : Use all configs if no filter] ***********
2025-12-03 09:42:36.548820 | controller | Wednesday 03 December 2025  09:42:36 +0000 (0:00:00.144)       0:00:29.597 ****
2025-12-03 09:42:36.548858 | controller | skipping: [compute-1]
2025-12-03 09:42:36.822227 | controller |
2025-12-03 09:42:36.822270 | controller | TASK [osp.edpm.edpm_container_manage : Update container configs with new config hashes] ***
2025-12-03 09:42:36.822287 | controller | Wednesday 03 December 2025  09:42:36 +0000 (0:00:00.096)       0:00:29.693 ****
2025-12-03 09:42:36.822302 | controller | ok: [compute-1]
2025-12-03 09:42:36.904166 | controller |
2025-12-03 09:42:36.904192 | controller | TASK [osp.edpm.edpm_container_manage : Delete orphan containers (DEPRECATED)] ***
2025-12-03 09:42:36.904202 | controller | Wednesday 03 December 2025  09:42:36 +0000 (0:00:00.273)       0:00:29.967 ****
2025-12-03 09:42:36.904213 | controller | included: /home/zuul/.cache/ansible-compat/9c8f65/collections/ansible_collections/osp/edpm/roles/edpm_container_manage/tasks/delete_orphan.yml for compute-1
2025-12-03 09:42:37.202104 | controller |
2025-12-03 09:42:37.202135 | controller | TASK [osp.edpm.edpm_container_manage : Gather podman infos] ********************
2025-12-03 09:42:37.202143 | controller | Wednesday 03 December 2025  09:42:36 +0000 (0:00:00.082)       0:00:30.049 ****
2025-12-03 09:42:37.202153 | controller | ok: [compute-1]
2025-12-03 09:42:37.273177 | controller |
2025-12-03 09:42:37.273208 | controller | TASK [osp.edpm.edpm_container_manage : Exclude Ceph containers from podman container list] ***
2025-12-03 09:42:37.273219 | controller | Wednesday 03 December 2025  09:42:37 +0000 (0:00:00.297)       0:00:30.347 ****
2025-12-03 09:42:37.273230 | controller | ok: [compute-1]
2025-12-03 09:42:37.273425 | controller |
2025-12-03 09:42:37.273448 | controller | TASK [Delete orphan containers managed by Podman for /var/lib/edpm-config/container-startup-config/kepler] ***
2025-12-03 09:42:37.381889 | controller | Wednesday 03 December 2025  09:42:37 +0000 (0:00:00.071)       0:00:30.418 ****
2025-12-03 09:42:37.381909 | controller |
2025-12-03 09:42:37.439171 | controller | TASK [osp.edpm.edpm_container_rm : Validating arguments against arg spec 'main' - The main entry point for the edpm_container_rm role.] ***
2025-12-03 09:42:37.439203 | controller | Wednesday 03 December 2025  09:42:37 +0000 (0:00:00.108)       0:00:30.527 ****
2025-12-03 09:42:37.439217 | controller | ok: [compute-1]
2025-12-03 09:42:37.439244 | controller |
2025-12-03 09:42:37.439254 | controller | TASK [osp.edpm.edpm_container_rm : Include edpm container rm task file] ********
2025-12-03 09:42:37.439370 | controller | Wednesday 03 December 2025  09:42:37 +0000 (0:00:00.057)       0:00:30.584 ****
2025-12-03 09:42:37.513182 | controller | skipping: [compute-1]
2025-12-03 09:42:37.595027 | controller |
2025-12-03 09:42:37.595058 | controller | TASK [osp.edpm.edpm_container_manage : Create containers from /var/lib/edpm-config/container-startup-config/kepler] ***
2025-12-03 09:42:37.595068 | controller | Wednesday 03 December 2025  09:42:37 +0000 (0:00:00.073)       0:00:30.658 ****
2025-12-03 09:42:37.595102 | controller | included: /home/zuul/.cache/ansible-compat/9c8f65/collections/ansible_collections/osp/edpm/roles/edpm_container_manage/tasks/create.yml for compute-1
2025-12-03 09:42:37.595156 | controller |
2025-12-03 09:42:37.595320 | controller | TASK [osp.edpm.edpm_container_manage : Create containers managed by Podman for /var/lib/edpm-config/container-startup-config/kepler] ***
2025-12-03 09:42:37.595426 | controller | Wednesday 03 December 2025  09:42:37 +0000 (0:00:00.082)       0:00:30.740 ****
2025-12-03 09:42:44.125211 | controller | changed: [compute-1]
2025-12-03 09:42:44.125366 | controller |
2025-12-03 09:42:44.125406 | controller | TASK [osp.edpm.edpm_container_manage : Check if /etc/sysconfig/podman_drop_in exists] ***
2025-12-03 09:42:44.125429 | controller | Wednesday 03 December 2025  09:42:44 +0000 (0:00:06.529)       0:00:37.270 ****
2025-12-03 09:42:44.361977 | controller | ok: [compute-1]
2025-12-03 09:42:44.415197 | controller |
2025-12-03 09:42:44.415242 | controller | TASK [osp.edpm.edpm_container_manage : Set podman_drop_in fact] ****************
2025-12-03 09:42:44.415258 | controller | Wednesday 03 December 2025  09:42:44 +0000 (0:00:00.236)       0:00:37.507 ****
2025-12-03 09:42:44.415277 | controller | skipping: [compute-1]
2025-12-03 09:42:44.415400 | controller |
2025-12-03 09:42:45.963737 | controller | TASK [osp.edpm.edpm_container_manage : Manage container systemd services and cleanup old systemd healthchecks for /var/lib/edpm-config/container-startup-config/kepler] ***
2025-12-03 09:42:45.963766 | controller | Wednesday 03 December 2025  09:42:44 +0000 (0:00:00.053)       0:00:37.560 ****
2025-12-03 09:42:45.963778 | controller | changed: [compute-1]
2025-12-03 09:42:46.084044 | controller |
2025-12-03 09:42:46.084097 | controller | TASK [osp.edpm.edpm_container_standalone : Update service state file] **********
2025-12-03 09:42:46.084114 | controller | Wednesday 03 December 2025  09:42:45 +0000 (0:00:01.547)       0:00:39.108 ****
2025-12-03 09:42:46.084323 | controller | included: /home/zuul/.cache/ansible-compat/9c8f65/collections/ansible_collections/osp/edpm/roles/edpm_container_standalone/tasks/state_file_update.yml for compute-1
2025-12-03 09:42:46.277690 | controller |
2025-12-03 09:42:46.277718 | controller | TASK [osp.edpm.edpm_container_standalone : Read current state file] ************
2025-12-03 09:42:46.277726 | controller | Wednesday 03 December 2025  09:42:46 +0000 (0:00:00.120)       0:00:39.229 ****
2025-12-03 09:42:46.277737 | controller | ok: [compute-1]
2025-12-03 09:42:46.339346 | controller |
2025-12-03 09:42:46.339382 | controller | TASK [osp.edpm.edpm_container_standalone : Parse state file data] **************
2025-12-03 09:42:46.339392 | controller | Wednesday 03 December 2025  09:42:46 +0000 (0:00:00.193)       0:00:39.422 ****
2025-12-03 09:42:46.339405 | controller | ok: [compute-1]
2025-12-03 09:42:46.339503 | controller |
2025-12-03 09:42:46.339515 | controller | TASK [osp.edpm.edpm_container_standalone : Initialize empty state data if file doesn't exist] ***
2025-12-03 09:42:46.383897 | controller | Wednesday 03 December 2025  09:42:46 +0000 (0:00:00.061)       0:00:39.484 ****
2025-12-03 09:42:46.383919 | controller | skipping: [compute-1]
2025-12-03 09:42:46.384014 | controller |
2025-12-03 09:42:46.384121 | controller | TASK [osp.edpm.edpm_container_standalone : Update service in state data] *******
2025-12-03 09:42:46.384314 | controller | Wednesday 03 December 2025  09:42:46 +0000 (0:00:00.044)       0:00:39.529 ****
2025-12-03 09:42:46.499845 | controller | ok: [compute-1]
2025-12-03 09:42:46.983717 | controller |
2025-12-03 09:42:46.983754 | controller | TASK [osp.edpm.edpm_container_standalone : Write updated state file] ***********
2025-12-03 09:42:46.983765 | controller | Wednesday 03 December 2025  09:42:46 +0000 (0:00:00.115)       0:00:39.644 ****
2025-12-03 09:42:46.983778 | controller | changed: [compute-1]
2025-12-03 09:42:48.208523 | controller |
2025-12-03 09:42:48.208560 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Restart ceilometer ipmi] ******
2025-12-03 09:42:48.208568 | controller | Wednesday 03 December 2025  09:42:46 +0000 (0:00:00.483)       0:00:40.128 ****
2025-12-03 09:42:48.208582 | controller | changed: [compute-1]
2025-12-03 09:42:48.944287 | controller |
2025-12-03 09:42:48.944316 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Enable and start Kepler service] ***
2025-12-03 09:42:48.944323 | controller | Wednesday 03 December 2025  09:42:48 +0000 (0:00:01.224)       0:00:41.353 ****
2025-12-03 09:42:48.944340 | controller | changed: [compute-1]
2025-12-03 09:42:48.944535 | controller |
2025-12-03 09:42:48.944549 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : List deployed health check scripts] ***
2025-12-03 09:42:49.184599 | controller | Wednesday 03 December 2025  09:42:48 +0000 (0:00:00.735)       0:00:42.089 ****
2025-12-03 09:42:49.184632 | controller | ok: [compute-1]
2025-12-03 09:42:49.275204 | controller |
2025-12-03 09:42:49.275265 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Correct health check scripts ownership based on container user IDs] ***
2025-12-03 09:42:49.275276 | controller | Wednesday 03 December 2025  09:42:49 +0000 (0:00:00.240)       0:00:42.329 ****
2025-12-03 09:42:49.275293 | controller | included: /home/zuul/.cache/ansible-compat/9c8f65/collections/ansible_collections/osp/edpm/roles/edpm_telemetry_power_monitoring/tasks/chown_healthcheck.yml for compute-1 => (item={'path': '/var/lib/openstack/healthchecks/ceilometer_agent_ipmi', 'mode': '0700', 'isdir': True, 'ischr': False, 'isblk': False, 'isreg': False, 'isfifo': False, 'islnk': False, 'issock': False, 'uid': 1000, 'gid': 1000, 'size': 51, 'inode': 96471802, 'dev': 64513, 'nlink': 2, 'atime': 1764754968.0272675, 'mtime': 1764754939.0570114, 'ctime': 1764754953.2801268, 'gr_name': 'zuul', 'pw_name': 'zuul', 'wusr': True, 'rusr': True, 'xusr': True, 'wgrp': False, 'rgrp': False, 'xgrp': False, 'woth': False, 'roth': False, 'xoth': False, 'isuid': False, 'isgid': False})
2025-12-03 09:42:49.275341 | controller | included: /home/zuul/.cache/ansible-compat/9c8f65/collections/ansible_collections/osp/edpm/roles/edpm_telemetry_power_monitoring/tasks/chown_healthcheck.yml for compute-1 => (item={'path': '/var/lib/openstack/healthchecks/kepler', 'mode': '0700', 'isdir': True, 'ischr': False, 'isblk': False, 'isreg': False, 'isfifo': False, 'islnk': False, 'issock': False, 'uid': 1000, 'gid': 1000, 'size': 25, 'inode': 121740673, 'dev': 64513, 'nlink': 2, 'atime': 1764754968.812275, 'mtime': 1764754939.390014, 'ctime': 1764754965.8082464, 'gr_name': 'zuul', 'pw_name': 'zuul', 'wusr': True, 'rusr': True, 'xusr': True, 'wgrp': False, 'rgrp': False, 'xgrp': False, 'woth': False, 'roth': False, 'xoth': False, 'isuid': False, 'isgid': False})
2025-12-03 09:42:49.275521 | controller |
2025-12-03 09:42:49.275548 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Resolve container name] *******
2025-12-03 09:42:49.326158 | controller | Wednesday 03 December 2025  09:42:49 +0000 (0:00:00.090)       0:00:42.420 ****
2025-12-03 09:42:49.326194 | controller | ok: [compute-1]
2025-12-03 09:42:49.623319 | controller |
2025-12-03 09:42:49.623363 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Wait until container is up and running] ***
2025-12-03 09:42:49.623374 | controller | Wednesday 03 December 2025  09:42:49 +0000 (0:00:00.050)       0:00:42.471 ****
2025-12-03 09:42:49.623389 | controller | ok: [compute-1]
2025-12-03 09:42:49.623497 | controller |
2025-12-03 09:42:49.623511 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Get user under which container runs] ***
2025-12-03 09:42:50.156129 | controller | Wednesday 03 December 2025  09:42:49 +0000 (0:00:00.297)       0:00:42.768 ****
2025-12-03 09:42:50.156171 | controller | changed: [compute-1]
2025-12-03 09:42:50.156261 | controller |
2025-12-03 09:42:50.156454 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Get group under which container runs] ***
2025-12-03 09:42:50.156491 | controller | Wednesday 03 December 2025  09:42:50 +0000 (0:00:00.533)       0:00:43.301 ****
2025-12-03 09:42:50.507321 | controller | changed: [compute-1]
2025-12-03 09:42:50.507458 | controller |
2025-12-03 09:42:50.507473 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Correct ownership if health check script for container] ***
2025-12-03 09:42:50.507486 | controller | Wednesday 03 December 2025  09:42:50 +0000 (0:00:00.350)       0:00:43.652 ****
2025-12-03 09:42:50.746794 | controller | changed: [compute-1]
2025-12-03 09:42:50.797156 | controller |
2025-12-03 09:42:50.797200 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Resolve container name] *******
2025-12-03 09:42:50.797214 | controller | Wednesday 03 December 2025  09:42:50 +0000 (0:00:00.239)       0:00:43.891 ****
2025-12-03 09:42:50.797231 | controller | ok: [compute-1]
2025-12-03 09:42:51.089358 | controller |
2025-12-03 09:42:51.089396 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Wait until container is up and running] ***
2025-12-03 09:42:51.089407 | controller | Wednesday 03 December 2025  09:42:50 +0000 (0:00:00.050)       0:00:43.942 ****
2025-12-03 09:42:51.089421 | controller | ok: [compute-1]
2025-12-03 09:42:51.089532 | controller |
2025-12-03 09:42:51.089542 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Get user under which container runs] ***
2025-12-03 09:42:51.089553 | controller | Wednesday 03 December 2025  09:42:51 +0000 (0:00:00.291)       0:00:44.233 ****
2025-12-03 09:42:51.449296 | controller | changed: [compute-1]
2025-12-03 09:42:51.449429 | controller |
2025-12-03 09:42:51.449444 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Get group under which container runs] ***
2025-12-03 09:42:51.449545 | controller | Wednesday 03 December 2025  09:42:51 +0000 (0:00:00.360)       0:00:44.594 ****
2025-12-03 09:42:51.830261 | controller | changed: [compute-1]
2025-12-03 09:42:51.830363 | controller |
2025-12-03 09:42:51.830438 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Correct ownership if health check script for container] ***
2025-12-03 09:42:51.830517 | controller | Wednesday 03 December 2025  09:42:51 +0000 (0:00:00.381)       0:00:44.975 ****
2025-12-03 09:42:52.063889 | controller | changed: [compute-1]
2025-12-03 09:42:52.064002 | controller |
2025-12-03 09:42:52.064105 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Post-install] *****************
2025-12-03 09:42:52.064282 | controller | Wednesday 03 December 2025  09:42:52 +0000 (0:00:00.233)       0:00:45.209 ****
2025-12-03 09:42:52.139752 | controller | included: /home/zuul/.cache/ansible-compat/9c8f65/collections/ansible_collections/osp/edpm/roles/edpm_telemetry_power_monitoring/tasks/post-install.yml for compute-1
2025-12-03 09:42:52.403783 | controller |
2025-12-03 09:42:52.403814 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Ensure firewall directory is present] ***
2025-12-03 09:42:52.403822 | controller | Wednesday 03 December 2025  09:42:52 +0000 (0:00:00.075)       0:00:45.284 ****
2025-12-03 09:42:52.403832 | controller | changed: [compute-1]
2025-12-03 09:42:52.827300 | controller |
2025-12-03 09:42:52.827333 | controller | TASK [osp.edpm.edpm_telemetry_power_monitoring : Copy kepler firewall config] ***
2025-12-03 09:42:52.827342 | controller | Wednesday 03 December 2025  09:42:52 +0000 (0:00:00.264)       0:00:45.548 ****
2025-12-03 09:42:52.827352 | controller | changed: [compute-1]
2025-12-03 09:42:52.908200 | controller |
2025-12-03 09:42:52.908230 | controller | TASK [Configure firewall for kepler] *******************************************
2025-12-03 09:42:52.908239 | controller | Wednesday 03 December 2025  09:42:52 +0000 (0:00:00.421)       0:00:45.970 ****
2025-12-03 09:42:52.908255 | controller |
2025-12-03 09:42:53.149880 | controller | TASK [osp.edpm.edpm_nftables : Create snippets directory] **********************
2025-12-03 09:42:53.149905 | controller | Wednesday 03 December 2025  09:42:52 +0000 (0:00:00.082)       0:00:46.053 ****
2025-12-03 09:42:53.149916 | controller | ok: [compute-1]
2025-12-03 09:42:53.607354 | controller |
2025-12-03 09:42:53.607393 | controller | TASK [osp.edpm.edpm_nftables : Push default ruleset snipet] ********************
2025-12-03 09:42:53.607405 | controller | Wednesday 03 December 2025  09:42:53 +0000 (0:00:00.241)       0:00:46.295 ****
2025-12-03 09:42:53.607418 | controller | changed: [compute-1]
2025-12-03 09:42:53.607533 | controller |
2025-12-03 09:42:53.607637 | controller | TASK [osp.edpm.edpm_nftables : Write user rules snippet] ***********************
2025-12-03 09:42:53.607649 | controller | Wednesday 03 December 2025  09:42:53 +0000 (0:00:00.457)       0:00:46.752 ****
2025-12-03 09:42:53.997859 | controller | changed: [compute-1]
2025-12-03 09:42:54.395040 | controller |
2025-12-03 09:42:54.395068 | controller | TASK [osp.edpm.edpm_nftables : Push empty ruleset] *****************************
2025-12-03 09:42:54.395100 | controller | Wednesday 03 December 2025  09:42:53 +0000 (0:00:00.389)       0:00:47.142 ****
2025-12-03 09:42:54.395111 | controller | changed: [compute-1]
2025-12-03 09:42:54.663001 | controller |
2025-12-03 09:42:54.663025 | controller | TASK [osp.edpm.edpm_nftables : Load empty ruleset] *****************************
2025-12-03 09:42:54.663033 | controller | Wednesday 03 December 2025  09:42:54 +0000 (0:00:00.397)       0:00:47.539 ****
2025-12-03 09:42:54.663042 | controller | changed: [compute-1]
2025-12-03 09:42:54.901297 | controller |
2025-12-03 09:42:54.901333 | controller | TASK [osp.edpm.edpm_nftables : Get current nftables content] *******************
2025-12-03 09:42:54.901343 | controller | Wednesday 03 December 2025  09:42:54 +0000 (0:00:00.267)       0:00:47.807 ****
2025-12-03 09:42:54.901355 | controller | changed: [compute-1]
2025-12-03 09:42:54.901448 | controller |
2025-12-03 09:42:54.901457 | controller | TASK [osp.edpm.edpm_nftables : Load firewall snippets] *************************
2025-12-03 09:42:54.901466 | controller | Wednesday 03 December 2025  09:42:54 +0000 (0:00:00.238)       0:00:48.046 ****
2025-12-03 09:42:55.295285 | controller | ok: [compute-1]
2025-12-03 09:42:55.295416 | controller |
2025-12-03 09:42:55.295430 | controller | TASK [osp.edpm.edpm_nftables : Generate chain jumps] ***************************
2025-12-03 09:42:55.295443 | controller | Wednesday 03 December 2025  09:42:55 +0000 (0:00:00.394)       0:00:48.440 ****
2025-12-03 09:42:55.733382 | controller | changed: [compute-1]
2025-12-03 09:42:55.733529 | controller |
2025-12-03 09:42:55.733539 | controller | TASK [osp.edpm.edpm_nftables : Generate chain jumps] ***************************
2025-12-03 09:42:55.733547 | controller | Wednesday 03 December 2025  09:42:55 +0000 (0:00:00.437)       0:00:48.878 ****
2025-12-03 09:42:56.182830 | controller | changed: [compute-1]
2025-12-03 09:42:56.595352 | controller |
2025-12-03 09:42:56.595394 | controller | TASK [osp.edpm.edpm_nftables : Generate nft flushes] ***************************
2025-12-03 09:42:56.595406 | controller | Wednesday 03 December 2025  09:42:56 +0000 (0:00:00.449)       0:00:49.327 ****
2025-12-03 09:42:56.595419 | controller | changed: [compute-1]
2025-12-03 09:42:57.024278 | controller |
2025-12-03 09:42:57.024310 | controller | TASK [osp.edpm.edpm_nftables : Generate nft edpm chains] ***********************
2025-12-03 09:42:57.024318 | controller | Wednesday 03 December 2025  09:42:56 +0000 (0:00:00.412)       0:00:49.739 ****
2025-12-03 09:42:57.024327 | controller | changed: [compute-1]
2025-12-03 09:42:57.024402 | controller |
2025-12-03 09:42:57.024411 | controller | TASK [osp.edpm.edpm_nftables : Generate nft ruleset in static file] ************
2025-12-03 09:42:57.482341 | controller | Wednesday 03 December 2025  09:42:57 +0000 (0:00:00.429)       0:00:50.169 ****
2025-12-03 09:42:57.482389 | controller | changed: [compute-1]
2025-12-03 09:42:57.722280 | controller |
2025-12-03 09:42:57.722314 | controller | TASK [osp.edpm.edpm_nftables : Create a sentinel file when nft rules are changed] ***
2025-12-03 09:42:57.722323 | controller | Wednesday 03 December 2025  09:42:57 +0000 (0:00:00.457)       0:00:50.627 ****
2025-12-03 09:42:57.722334 | controller | changed: [compute-1]
2025-12-03 09:42:57.722411 | controller |
2025-12-03 09:42:57.722418 | controller | TASK [osp.edpm.edpm_nftables : Validate all of the generated content before loading] ***
2025-12-03 09:42:57.722425 | controller | Wednesday 03 December 2025  09:42:57 +0000 (0:00:00.240)       0:00:50.867 ****
2025-12-03 09:42:57.997409 | controller | changed: [compute-1]
2025-12-03 09:42:57.997544 | controller |
2025-12-03 09:42:57.997558 | controller | TASK [osp.edpm.edpm_nftables : Ensure we load our different nft rulesets on boot] ***
2025-12-03 09:42:57.997570 | controller | Wednesday 03 December 2025  09:42:57 +0000 (0:00:00.275)       0:00:51.142 ****
2025-12-03 09:42:58.421813 | controller | changed: [compute-1]
2025-12-03 09:42:58.508147 | controller |
2025-12-03 09:42:58.508169 | controller | TASK [Reload firewall for kepler] **********************************************
2025-12-03 09:42:58.508183 | controller | Wednesday 03 December 2025  09:42:58 +0000 (0:00:00.423)       0:00:51.566 ****
2025-12-03 09:42:58.508193 | controller |
2025-12-03 09:42:58.754656 | controller | TASK [osp.edpm.edpm_nftables : Inject our custom chains in nftables] ***********
2025-12-03 09:42:58.754682 | controller | Wednesday 03 December 2025  09:42:58 +0000 (0:00:00.087)       0:00:51.653 ****
2025-12-03 09:42:58.754694 | controller | changed: [compute-1]
2025-12-03 09:42:58.983020 | controller |
2025-12-03 09:42:58.983052 | controller | TASK [osp.edpm.edpm_nftables : Check if rules are changed] *********************
2025-12-03 09:42:58.983060 | controller | Wednesday 03 December 2025  09:42:58 +0000 (0:00:00.246)       0:00:51.899 ****
2025-12-03 09:42:58.983103 | controller | ok: [compute-1]
2025-12-03 09:42:59.263584 | controller |
2025-12-03 09:42:59.263615 | controller | TASK [osp.edpm.edpm_nftables : Reload ruleset] *********************************
2025-12-03 09:42:59.263624 | controller | Wednesday 03 December 2025  09:42:58 +0000 (0:00:00.228)       0:00:52.128 ****
2025-12-03 09:42:59.263635 | controller | changed: [compute-1]
2025-12-03 09:42:59.610669 | controller |
2025-12-03 09:42:59.610700 | controller | TASK [osp.edpm.edpm_nftables : Delete nft_ruleset_changed file] ****************
2025-12-03 09:42:59.610708 | controller | Wednesday 03 December 2025  09:42:59 +0000 (0:00:00.280)       0:00:52.408 ****
2025-12-03 09:42:59.610718 | controller | changed: [compute-1]
2025-12-03 09:42:59.690218 | controller |
2025-12-03 09:42:59.690250 | controller | PLAY RECAP *********************************************************************
2025-12-03 09:42:59.690258 | controller | compute-1                  : ok=121  changed=53   unreachable=0    failed=0    skipped=16   rescued=0    ignored=1
2025-12-03 09:42:59.690264 | controller |
2025-12-03 09:42:59.690269 | controller | Wednesday 03 December 2025  09:42:59 +0000 (0:00:00.344)       0:00:52.753 ****
2025-12-03 09:42:59.690274 | controller | ===============================================================================
2025-12-03 09:42:59.690285 | controller | osp.edpm.edpm_container_manage : Create containers managed by Podman for /var/lib/edpm-config/container-startup-config/ceilometer_agent_ipmi --- 8.25s
2025-12-03 09:42:59.690291 | controller | osp.edpm.edpm_container_manage : Create containers managed by Podman for /var/lib/edpm-config/container-startup-config/kepler --- 6.53s
2025-12-03 09:42:59.690297 | controller | osp.edpm.edpm_tripleo_cleanup : Gather service facts -------------------- 1.80s
2025-12-03 09:42:59.690302 | controller | osp.edpm.edpm_container_manage : Manage container systemd services and cleanup old systemd healthchecks for /var/lib/edpm-config/container-startup-config/ceilometer_agent_ipmi --- 1.71s
2025-12-03 09:42:59.690307 | controller | osp.edpm.edpm_container_manage : Manage container systemd services and cleanup old systemd healthchecks for /var/lib/edpm-config/container-startup-config/kepler --- 1.55s
2025-12-03 09:42:59.690312 | controller | osp.edpm.edpm_telemetry_power_monitoring : Restart ceilometer ipmi ------ 1.23s
2025-12-03 09:42:59.690318 | controller | osp.edpm.edpm_telemetry_power_monitoring : Deploy telemetry health check scripts --- 1.02s
2025-12-03 09:42:59.690323 | controller | Gathering Facts --------------------------------------------------------- 0.85s
2025-12-03 09:42:59.690327 | controller | osp.edpm.edpm_telemetry_power_monitoring : Enable and start Kepler service --- 0.74s
2025-12-03 09:42:59.690332 | controller | osp.edpm.edpm_tripleo_cleanup : Reload units to check for new changes --- 0.61s
2025-12-03 09:42:59.690337 | controller | osp.edpm.edpm_telemetry_power_monitoring : Get user under which container runs --- 0.53s
2025-12-03 09:42:59.690342 | controller | osp.edpm.edpm_container_standalone : Write updated state file ----------- 0.48s
2025-12-03 09:42:59.690347 | controller | osp.edpm.edpm_nftables : Generate nft ruleset in static file ------------ 0.46s
2025-12-03 09:42:59.690352 | controller | osp.edpm.edpm_nftables : Push default ruleset snipet -------------------- 0.46s
2025-12-03 09:42:59.690357 | controller | osp.edpm.edpm_nftables : Generate chain jumps --------------------------- 0.45s
2025-12-03 09:42:59.690362 | controller | osp.edpm.edpm_users : Ensure user is present on the host [ ceilometer ] --- 0.45s
2025-12-03 09:42:59.690367 | controller | osp.edpm.edpm_nftables : Generate chain jumps --------------------------- 0.44s
2025-12-03 09:42:59.690371 | controller | osp.edpm.edpm_tripleo_cleanup : Reload units ---------------------------- 0.44s
2025-12-03 09:42:59.690376 | controller | osp.edpm.edpm_nftables : Generate nft edpm chains ----------------------- 0.43s
2025-12-03 09:42:59.690381 | controller | osp.edpm.edpm_telemetry_power_monitoring : Render ceilometer config template --- 0.43s
2025-12-03 09:42:59.690391 | controller | INFO     Running default > verify
2025-12-03 09:42:59.690761 | controller | INFO     Running Ansible Verifier
2025-12-03 09:43:00.116111 | controller |
2025-12-03 09:43:01.010964 | controller | PLAY [Verify ceilometer] *******************************************************
2025-12-03 09:43:01.010997 | controller |
2025-12-03 09:43:01.011005 | controller | TASK [Gathering Facts] *********************************************************
2025-12-03 09:43:01.011010 | controller | Wednesday 03 December 2025  09:43:00 +0000 (0:00:00.039)       0:00:00.039 ****
2025-12-03 09:43:01.011025 | controller | ok: [compute-1]
2025-12-03 09:43:01.093402 | controller |
2025-12-03 09:43:01.093426 | controller | TASK [ensure expected config files exist] **************************************
2025-12-03 09:43:01.093435 | controller | Wednesday 03 December 2025  09:43:01 +0000 (0:00:00.895)       0:00:00.934 ****
2025-12-03 09:43:01.093446 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_dir.yaml for compute-1 => (item=/var/lib/openstack/telemetry-power-monitoring/ceilometer.conf)
2025-12-03 09:43:01.445306 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_dir.yaml for compute-1 => (item=/var/lib/openstack/telemetry-power-monitoring/polling.yaml)
2025-12-03 09:43:01.445341 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_dir.yaml for compute-1 => (item=/var/lib/openstack/telemetry-power-monitoring/ceilometer-host-specific.conf)
2025-12-03 09:43:01.445361 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_dir.yaml for compute-1 => (item=/var/lib/openstack/telemetry-power-monitoring/firewall.yaml)
2025-12-03 09:43:01.445368 | controller |
2025-12-03 09:43:01.445374 | controller | TASK [Check if directory exists /var/lib/openstack/telemetry-power-monitoring/ceilometer.conf] ***
2025-12-03 09:43:01.445380 | controller | Wednesday 03 December 2025  09:43:01 +0000 (0:00:00.082)       0:00:01.017 ****
2025-12-03 09:43:01.445390 | controller | ok: [compute-1]
2025-12-03 09:43:01.445472 | controller |
2025-12-03 09:43:01.445482 | controller | TASK [Assert directory exists /var/lib/openstack/telemetry-power-monitoring/ceilometer.conf] ***
2025-12-03 09:43:01.511696 | controller | Wednesday 03 December 2025  09:43:01 +0000 (0:00:00.352)       0:00:01.369 ****
2025-12-03 09:43:01.511737 | controller | ok: [compute-1] => changed=false
2025-12-03 09:43:01.763870 | controller |   msg: All assertions passed
2025-12-03 09:43:01.763901 | controller |
2025-12-03 09:43:01.763910 | controller | TASK [Check if directory exists /var/lib/openstack/telemetry-power-monitoring/polling.yaml] ***
2025-12-03 09:43:01.763917 | controller | Wednesday 03 December 2025  09:43:01 +0000 (0:00:00.066)       0:00:01.435 ****
2025-12-03 09:43:01.763927 | controller | ok: [compute-1]
2025-12-03 09:43:01.809299 | controller |
2025-12-03 09:43:01.809327 | controller | TASK [Assert directory exists /var/lib/openstack/telemetry-power-monitoring/polling.yaml] ***
2025-12-03 09:43:01.809335 | controller | Wednesday 03 December 2025  09:43:01 +0000 (0:00:00.251)       0:00:01.687 ****
2025-12-03 09:43:01.809345 | controller | ok: [compute-1] => changed=false
2025-12-03 09:43:02.048339 | controller |   msg: All assertions passed
2025-12-03 09:43:02.048374 | controller |
2025-12-03 09:43:02.048384 | controller | TASK [Check if directory exists /var/lib/openstack/telemetry-power-monitoring/ceilometer-host-specific.conf] ***
2025-12-03 09:43:02.048393 | controller | Wednesday 03 December 2025  09:43:01 +0000 (0:00:00.045)       0:00:01.733 ****
2025-12-03 09:43:02.048404 | controller | ok: [compute-1]
2025-12-03 09:43:02.048505 | controller |
2025-12-03 09:43:02.048626 | controller | TASK [Assert directory exists /var/lib/openstack/telemetry-power-monitoring/ceilometer-host-specific.conf] ***
2025-12-03 09:43:02.048646 | controller | Wednesday 03 December 2025  09:43:02 +0000 (0:00:00.239)       0:00:01.972 ****
2025-12-03 09:43:02.093265 | controller | ok: [compute-1] => changed=false
2025-12-03 09:43:02.093377 | controller |   msg: All assertions passed
2025-12-03 09:43:02.093389 | controller |
2025-12-03 09:43:02.093400 | controller | TASK [Check if directory exists /var/lib/openstack/telemetry-power-monitoring/firewall.yaml] ***
2025-12-03 09:43:02.356789 | controller | Wednesday 03 December 2025  09:43:02 +0000 (0:00:00.045)       0:00:02.017 ****
2025-12-03 09:43:02.356836 | controller | ok: [compute-1]
2025-12-03 09:43:02.356949 | controller |
2025-12-03 09:43:02.356963 | controller | TASK [Assert directory exists /var/lib/openstack/telemetry-power-monitoring/firewall.yaml] ***
2025-12-03 09:43:02.357060 | controller | Wednesday 03 December 2025  09:43:02 +0000 (0:00:00.263)       0:00:02.281 ****
2025-12-03 09:43:02.398873 | controller | ok: [compute-1] => changed=false
2025-12-03 09:43:02.398993 | controller |   msg: All assertions passed
2025-12-03 09:43:02.399122 | controller |
2025-12-03 09:43:02.399225 | controller | TASK [ensure podman container exists and are running] **************************
2025-12-03 09:43:02.399316 | controller | Wednesday 03 December 2025  09:43:02 +0000 (0:00:00.042)       0:00:02.323 ****
2025-12-03 09:43:02.481647 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_podman.yaml for compute-1 => (item=ceilometer_agent_ipmi)
2025-12-03 09:43:02.854897 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_podman.yaml for compute-1 => (item=kepler)
2025-12-03 09:43:02.854924 | controller |
2025-12-03 09:43:02.854932 | controller | TASK [Check if podman container exists ceilometer_agent_ipmi] ******************
2025-12-03 09:43:02.854946 | controller | Wednesday 03 December 2025  09:43:02 +0000 (0:00:00.082)       0:00:02.405 ****
2025-12-03 09:43:02.854956 | controller | changed: [compute-1]
2025-12-03 09:43:02.927999 | controller |
2025-12-03 09:43:02.928038 | controller | TASK [Assert podman container exists ceilometer_agent_ipmi] ********************
2025-12-03 09:43:02.928057 | controller | Wednesday 03 December 2025  09:43:02 +0000 (0:00:00.373)       0:00:02.779 ****
2025-12-03 09:43:02.928106 | controller | ok: [compute-1] => changed=false
2025-12-03 09:43:03.191834 | controller |   msg: All assertions passed
2025-12-03 09:43:03.191864 | controller |
2025-12-03 09:43:03.191872 | controller | TASK [Check if podman container is running ceilometer_agent_ipmi] **************
2025-12-03 09:43:03.191879 | controller | Wednesday 03 December 2025  09:43:02 +0000 (0:00:00.072)       0:00:02.852 ****
2025-12-03 09:43:03.191889 | controller | changed: [compute-1]
2025-12-03 09:43:03.245847 | controller |
2025-12-03 09:43:03.245872 | controller | TASK [Assert podman container is running ceilometer_agent_ipmi] ****************
2025-12-03 09:43:03.245880 | controller | Wednesday 03 December 2025  09:43:03 +0000 (0:00:00.263)       0:00:03.115 ****
2025-12-03 09:43:03.245889 | controller | ok: [compute-1] => changed=false
2025-12-03 09:43:03.517017 | controller |   msg: All assertions passed
2025-12-03 09:43:03.517053 | controller |
2025-12-03 09:43:03.517063 | controller | TASK [Check if podman container exists kepler] *********************************
2025-12-03 09:43:03.517115 | controller | Wednesday 03 December 2025  09:43:03 +0000 (0:00:00.054)       0:00:03.170 ****
2025-12-03 09:43:03.517134 | controller | changed: [compute-1]
2025-12-03 09:43:03.573639 | controller |
2025-12-03 09:43:03.573662 | controller | TASK [Assert podman container exists kepler] ***********************************
2025-12-03 09:43:03.573669 | controller | Wednesday 03 December 2025  09:43:03 +0000 (0:00:00.270)       0:00:03.441 ****
2025-12-03 09:43:03.573679 | controller | ok: [compute-1] => changed=false
2025-12-03 09:43:03.878268 | controller |   msg: All assertions passed
2025-12-03 09:43:03.878304 | controller |
2025-12-03 09:43:03.878315 | controller | TASK [Check if podman container is running kepler] *****************************
2025-12-03 09:43:03.878323 | controller | Wednesday 03 December 2025  09:43:03 +0000 (0:00:00.056)       0:00:03.497 ****
2025-12-03 09:43:03.878335 | controller | changed: [compute-1]
2025-12-03 09:43:03.878434 | controller |
2025-12-03 09:43:03.878444 | controller | TASK [Assert podman container is running kepler] *******************************
2025-12-03 09:43:03.878454 | controller | Wednesday 03 December 2025  09:43:03 +0000 (0:00:00.304)       0:00:03.802 ****
2025-12-03 09:43:03.932964 | controller | ok: [compute-1] => changed=false
2025-12-03 09:43:04.014247 | controller |   msg: All assertions passed
2025-12-03 09:43:04.014270 | controller |
2025-12-03 09:43:04.014278 | controller | TASK [ensure systemd services are defined and functional] **********************
2025-12-03 09:43:04.014284 | controller | Wednesday 03 December 2025  09:43:03 +0000 (0:00:00.054)       0:00:03.857 ****
2025-12-03 09:43:04.014299 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_systemd_unit.yaml for compute-1 => (item={'name': 'edpm_ceilometer_agent_ipmi.service'})
2025-12-03 09:43:04.254021 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_systemd_unit.yaml for compute-1 => (item={'name': 'edpm_kepler.service'})
2025-12-03 09:43:04.254050 | controller |
2025-12-03 09:43:04.254064 | controller | TASK [Check if systemd file exists edpm_ceilometer_agent_ipmi.service] *********
2025-12-03 09:43:04.254102 | controller | Wednesday 03 December 2025  09:43:04 +0000 (0:00:00.081)       0:00:03.938 ****
2025-12-03 09:43:04.254117 | controller | ok: [compute-1]
2025-12-03 09:43:04.324879 | controller |
2025-12-03 09:43:04.324910 | controller | TASK [Assert systemd unit exists edpm_ceilometer_agent_ipmi.service] ***********
2025-12-03 09:43:04.324919 | controller | Wednesday 03 December 2025  09:43:04 +0000 (0:00:00.239)       0:00:04.178 ****
2025-12-03 09:43:04.324929 | controller | ok: [compute-1] => changed=false
2025-12-03 09:43:04.546197 | controller |   msg: All assertions passed
2025-12-03 09:43:04.546280 | controller |
2025-12-03 09:43:04.546291 | controller | TASK [Check if systemd unit is enabled edpm_ceilometer_agent_ipmi.service] *****
2025-12-03 09:43:04.546298 | controller | Wednesday 03 December 2025  09:43:04 +0000 (0:00:00.070)       0:00:04.248 ****
2025-12-03 09:43:04.546311 | controller | ok: [compute-1]
2025-12-03 09:43:04.590253 | controller |
2025-12-03 09:43:04.590303 | controller | TASK [Assert systemd unit is enabled edpm_ceilometer_agent_ipmi.service] *******
2025-12-03 09:43:04.590313 | controller | Wednesday 03 December 2025  09:43:04 +0000 (0:00:00.221)       0:00:04.470 ****
2025-12-03 09:43:04.590335 | controller | ok: [compute-1] => changed=false
2025-12-03 09:43:04.809295 | controller |   msg: All assertions passed
2025-12-03 09:43:04.809323 | controller |
2025-12-03 09:43:04.809334 | controller | TASK [Check if systemd unit is running edpm_ceilometer_agent_ipmi.service] *****
2025-12-03 09:43:04.809342 | controller | Wednesday 03 December 2025  09:43:04 +0000 (0:00:00.044)       0:00:04.514 ****
2025-12-03 09:43:04.809354 | controller | ok: [compute-1]
2025-12-03 09:43:04.809461 | controller |
2025-12-03 09:43:04.809473 | controller | TASK [Assert systemd unit is running edpm_ceilometer_agent_ipmi.service] *******
2025-12-03 09:43:04.858021 | controller | Wednesday 03 December 2025  09:43:04 +0000 (0:00:00.219)       0:00:04.733 ****
2025-12-03 09:43:04.858058 | controller | ok: [compute-1] => changed=false
2025-12-03 09:43:05.116189 | controller |   msg: All assertions passed
2025-12-03 09:43:05.116228 | controller |
2025-12-03 09:43:05.116238 | controller | TASK [Check if systemd file exists edpm_kepler.service] ************************
2025-12-03 09:43:05.116245 | controller | Wednesday 03 December 2025  09:43:04 +0000 (0:00:00.048)       0:00:04.782 ****
2025-12-03 09:43:05.116256 | controller | ok: [compute-1]
2025-12-03 09:43:05.161805 | controller |
2025-12-03 09:43:05.161834 | controller | TASK [Assert systemd unit exists edpm_kepler.service] **************************
2025-12-03 09:43:05.161841 | controller | Wednesday 03 December 2025  09:43:05 +0000 (0:00:00.258)       0:00:05.040 ****
2025-12-03 09:43:05.161852 | controller | ok: [compute-1] => changed=false
2025-12-03 09:43:05.389017 | controller |   msg: All assertions passed
2025-12-03 09:43:05.389063 | controller |
2025-12-03 09:43:05.389096 | controller | TASK [Check if systemd unit is enabled edpm_kepler.service] ********************
2025-12-03 09:43:05.389107 | controller | Wednesday 03 December 2025  09:43:05 +0000 (0:00:00.045)       0:00:05.086 ****
2025-12-03 09:43:05.389118 | controller | ok: [compute-1]
2025-12-03 09:43:05.436881 | controller |
2025-12-03 09:43:05.436903 | controller | TASK [Assert systemd unit is enabled edpm_kepler.service] **********************
2025-12-03 09:43:05.436911 | controller | Wednesday 03 December 2025  09:43:05 +0000 (0:00:00.227)       0:00:05.313 ****
2025-12-03 09:43:05.436921 | controller | ok: [compute-1] => changed=false
2025-12-03 09:43:05.658311 | controller |   msg: All assertions passed
2025-12-03 09:43:05.658351 | controller |
2025-12-03 09:43:05.658363 | controller | TASK [Check if systemd unit is running edpm_kepler.service] ********************
2025-12-03 09:43:05.658372 | controller | Wednesday 03 December 2025  09:43:05 +0000 (0:00:00.047)       0:00:05.361 ****
2025-12-03 09:43:05.658385 | controller | ok: [compute-1]
2025-12-03 09:43:05.658494 | controller |
2025-12-03 09:43:05.658507 | controller | TASK [Assert systemd unit is running edpm_kepler.service] **********************
2025-12-03 09:43:05.735966 | controller | Wednesday 03 December 2025  09:43:05 +0000 (0:00:00.221)       0:00:05.582 ****
2025-12-03 09:43:05.736010 | controller | ok: [compute-1] => changed=false
2025-12-03 09:43:06.897385 | controller |   msg: All assertions passed
2025-12-03 09:43:06.897425 | controller |
2025-12-03 09:43:06.897436 | controller | TASK [ensure kolla_set_configs copied the expected files and started the correct binary] ***
2025-12-03 09:43:06.897445 | controller | Wednesday 03 December 2025  09:43:05 +0000 (0:00:00.077)       0:00:05.660 ****
2025-12-03 09:43:06.897459 | controller | changed: [compute-1] => (item=Copying /var/lib/kolla/config_files/src/ceilometer.conf to /etc/ceilometer/ceilometer.conf)
2025-12-03 09:43:06.966256 | controller | changed: [compute-1] => (item=Copying /var/lib/kolla/config_files/src/polling.yaml to /etc/ceilometer/polling.yaml)
2025-12-03 09:43:06.966292 | controller | changed: [compute-1] => (item=/usr/bin/ceilometer-polling --polling-namespaces ipmi --logfile /dev/stdout)
2025-12-03 09:43:06.966302 | controller | changed: [compute-1] => (item=Copying /var/lib/kolla/config_files/src/ceilometer-host-specific.conf to /etc/ceilometer/ceilometer.conf.d/02-ceilometer-host-specific.conf)
2025-12-03 09:43:06.966309 | controller |
2025-12-03 09:43:06.966316 | controller | TASK [ensure firewall is configured] *******************************************
2025-12-03 09:43:06.966329 | controller | Wednesday 03 December 2025  09:43:06 +0000 (0:00:01.160)       0:00:06.820 ****
2025-12-03 09:43:06.966341 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/roles/edpm_telemetry_power_monitoring/molecule/default/test-helpers/kepler.yaml for compute-1
2025-12-03 09:43:07.221136 | controller |
2025-12-03 09:43:07.221164 | controller | TASK [kepler rule source file exists] ******************************************
2025-12-03 09:43:07.221173 | controller | Wednesday 03 December 2025  09:43:06 +0000 (0:00:00.069)       0:00:06.890 ****
2025-12-03 09:43:07.221184 | controller | ok: [compute-1]
2025-12-03 09:43:07.264161 | controller |
2025-12-03 09:43:07.264179 | controller | TASK [Assert kepler rule source file exists] ***********************************
2025-12-03 09:43:07.264193 | controller | Wednesday 03 December 2025  09:43:07 +0000 (0:00:00.254)       0:00:07.145 ****
2025-12-03 09:43:07.264202 | controller | ok: [compute-1] => changed=false
2025-12-03 09:43:07.504689 | controller |   msg: All assertions passed
2025-12-03 09:43:07.504714 | controller |
2025-12-03 09:43:07.504723 | controller | TASK [Run nft list command and grep for Kepler rule in EDPM_INPUT chain] *******
2025-12-03 09:43:07.504731 | controller | Wednesday 03 December 2025  09:43:07 +0000 (0:00:00.043)       0:00:07.188 ****
2025-12-03 09:43:07.504742 | controller | changed: [compute-1]
2025-12-03 09:43:07.657215 | controller |
2025-12-03 09:43:07.657233 | controller | TASK [Assert that output from greping for VNC contains the correct rule] *******
2025-12-03 09:43:07.657240 | controller | Wednesday 03 December 2025  09:43:07 +0000 (0:00:00.240)       0:00:07.428 ****
2025-12-03 09:43:07.657249 | controller | ok: [compute-1] => (item=               tcp dport 8888 ct state new counter packets 0 bytes 0 accept comment "000 Allow Kepler traffic") => changed=false
2025-12-03 09:43:07.657454 | controller |   ansible_loop_var: item
2025-12-03 09:43:07.657466 | controller |   item: "\t\ttcp dport 8888 ct state new counter packets 0 bytes 0 accept comment \"000 Allow Kepler traffic\""
2025-12-03 09:43:07.657472 | controller |   msg: All assertions passed
2025-12-03 09:43:07.657478 | controller |
2025-12-03 09:43:07.657483 | controller | PLAY RECAP *********************************************************************
2025-12-03 09:43:07.657488 | controller | compute-1                  : ok=43   changed=6    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2025-12-03 09:43:07.657493 | controller |
2025-12-03 09:43:07.657498 | controller | Wednesday 03 December 2025  09:43:07 +0000 (0:00:00.150)       0:00:07.579 ****
2025-12-03 09:43:07.657504 | controller | ===============================================================================
2025-12-03 09:43:07.657508 | controller | ensure kolla_set_configs copied the expected files and started the correct binary --- 1.16s
2025-12-03 09:43:07.657514 | controller | Gathering Facts --------------------------------------------------------- 0.90s
2025-12-03 09:43:07.657519 | controller | Check if podman container exists ceilometer_agent_ipmi ------------------ 0.37s
2025-12-03 09:43:07.657524 | controller | Check if directory exists /var/lib/openstack/telemetry-power-monitoring/ceilometer.conf --- 0.35s
2025-12-03 09:43:07.657529 | controller | Check if podman container is running kepler ----------------------------- 0.30s
2025-12-03 09:43:07.657534 | controller | Check if podman container exists kepler --------------------------------- 0.27s
2025-12-03 09:43:07.657539 | controller | Check if podman container is running ceilometer_agent_ipmi -------------- 0.26s
2025-12-03 09:43:07.657544 | controller | Check if directory exists /var/lib/openstack/telemetry-power-monitoring/firewall.yaml --- 0.26s
2025-12-03 09:43:07.657549 | controller | Check if systemd file exists edpm_kepler.service ------------------------ 0.26s
2025-12-03 09:43:07.657554 | controller | kepler rule source file exists ------------------------------------------ 0.25s
2025-12-03 09:43:07.657559 | controller | Check if directory exists /var/lib/openstack/telemetry-power-monitoring/polling.yaml --- 0.25s
2025-12-03 09:43:07.657563 | controller | Run nft list command and grep for Kepler rule in EDPM_INPUT chain ------- 0.24s
2025-12-03 09:43:07.657568 | controller | Check if systemd file exists edpm_ceilometer_agent_ipmi.service --------- 0.24s
2025-12-03 09:43:07.657573 | controller | Check if directory exists /var/lib/openstack/telemetry-power-monitoring/ceilometer-host-specific.conf --- 0.24s
2025-12-03 09:43:07.657578 | controller | Check if systemd unit is enabled edpm_kepler.service -------------------- 0.23s
2025-12-03 09:43:07.657585 | controller | Check if systemd unit is running edpm_kepler.service -------------------- 0.22s
2025-12-03 09:43:07.657803 | controller | Check if systemd unit is enabled edpm_ceilometer_agent_ipmi.service ----- 0.22s
2025-12-03 09:43:07.658035 | controller | Check if systemd unit is running edpm_ceilometer_agent_ipmi.service ----- 0.22s
2025-12-03 09:43:07.658278 | controller | Assert that output from greping for VNC contains the correct rule ------- 0.15s
2025-12-03 09:43:07.658499 | controller | ensure expected config files exist -------------------------------------- 0.08s
2025-12-03 09:43:07.698988 | controller | INFO     Verifier completed successfully.
2025-12-03 09:43:07.707838 | controller | INFO     Running default > destroy
2025-12-03 09:43:07.708256 | controller | WARNING  Skipping, instances are delegated.
2025-12-03 09:43:07.708692 | controller | INFO     Pruning extra files from scenario ephemeral directory
2025-12-03 09:43:07.976698 | controller | INFO     Writing /tmp/report.html report.
2025-12-03 09:43:13.076508 | controller | changed
2025-12-03 09:43:13.103081 | 
2025-12-03 09:43:13.103139 | PLAY RECAP
2025-12-03 09:43:13.103177 | controller | ok: 4 changed: 2 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-12-03 09:43:13.103197 | 
2025-12-03 09:43:13.165694 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-12-03 09:43:13.166522 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-12-03 09:43:13.662770 | 
2025-12-03 09:43:13.662870 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-12-03 09:43:13.681619 | 
2025-12-03 09:43:13.681688 | TASK [Filter out host if needed]
2025-12-03 09:43:13.689560 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-12-03 09:43:13.693627 | 
2025-12-03 09:43:13.693690 | TASK [Ensure file is present]
2025-12-03 09:43:13.995955 | controller | ok
2025-12-03 09:43:14.002717 | 
2025-12-03 09:43:14.002788 | TASK [Manage molecule report file]
2025-12-03 09:43:19.027537 | controller | changed
2025-12-03 09:43:19.032733 | 
2025-12-03 09:43:19.032799 | TASK [Check if we get ci-framework-data basedir]
2025-12-03 09:43:19.244861 | controller | ok
2025-12-03 09:43:19.250066 | 
2025-12-03 09:43:19.250134 | TASK [Create ci-framework-data log directory for zuul]
2025-12-03 09:43:19.553101 | controller | changed
2025-12-03 09:43:19.557896 | 
2025-12-03 09:43:19.558002 | TASK [Copy ci-framework interesting files]
2025-12-03 09:43:24.583389 | controller | changed
2025-12-03 09:43:24.588750 | 
2025-12-03 09:43:24.588817 | TASK [Get SELinux listing]
2025-12-03 09:43:29.615152 | controller | changed
2025-12-03 09:43:29.621100 | 
2025-12-03 09:43:29.621163 | TASK [Generate log index]
2025-12-03 09:43:30.312658 | controller | changed
2025-12-03 09:43:30.318169 | 
2025-12-03 09:43:30.318277 | TASK [Get some env related data]
2025-12-03 09:43:35.340477 | controller | changed
2025-12-03 09:43:35.346698 | 
2025-12-03 09:43:35.346771 | TASK [Generate list of logs to collect in home directory]
2025-12-03 09:43:35.644344 | controller | ok: All paths examined
2025-12-03 09:43:35.649757 | 
2025-12-03 09:43:35.649820 | LOOP [Copy logs from home directory]
2025-12-03 09:43:36.000774 | controller | changed:
2025-12-03 09:43:36.000945 | controller | {
2025-12-03 09:43:36.000979 | controller |   "atime": 1764754656.6600518,
2025-12-03 09:43:36.001000 | controller |   "ctime": 1764754672.7141764,
2025-12-03 09:43:36.001017 | controller |   "dev": 64513,
2025-12-03 09:43:36.001033 | controller |   "gid": 1000,
2025-12-03 09:43:36.001048 | controller |   "gr_name": "zuul",
2025-12-03 09:43:36.001063 | controller |   "inode": 4329588,
2025-12-03 09:43:36.001077 | controller |   "isblk": false,
2025-12-03 09:43:36.001092 | controller |   "ischr": false,
2025-12-03 09:43:36.001106 | controller |   "isdir": false,
2025-12-03 09:43:36.001121 | controller |   "isfifo": false,
2025-12-03 09:43:36.001136 | controller |   "isgid": false,
2025-12-03 09:43:36.001150 | controller |   "islnk": false,
2025-12-03 09:43:36.001167 | controller |   "isreg": true,
2025-12-03 09:43:36.001182 | controller |   "issock": false,
2025-12-03 09:43:36.001197 | controller |   "isuid": false,
2025-12-03 09:43:36.001211 | controller |   "mode": "0644",
2025-12-03 09:43:36.001237 | controller |   "mtime": 1764754672.7141764,
2025-12-03 09:43:36.001253 | controller |   "nlink": 1,
2025-12-03 09:43:36.001266 | controller |   "path": "/home/zuul/ansible.log",
2025-12-03 09:43:36.001279 | controller |   "pw_name": "zuul",
2025-12-03 09:43:36.001293 | controller |   "rgrp": true,
2025-12-03 09:43:36.001308 | controller |   "roth": true,
2025-12-03 09:43:36.001322 | controller |   "rusr": true,
2025-12-03 09:43:36.001336 | controller |   "size": 6749,
2025-12-03 09:43:36.001350 | controller |   "uid": 1000,
2025-12-03 09:43:36.001364 | controller |   "wgrp": false,
2025-12-03 09:43:36.001377 | controller |   "woth": false,
2025-12-03 09:43:36.001390 | controller |   "wusr": true,
2025-12-03 09:43:36.001404 | controller |   "xgrp": false,
2025-12-03 09:43:36.001420 | controller |   "xoth": false,
2025-12-03 09:43:36.001434 | controller |   "xusr": false
2025-12-03 09:43:36.001448 | controller | }
2025-12-03 09:43:36.015660 | 
2025-12-03 09:43:36.015792 | TASK [Copy crio stats log file]
2025-12-03 09:43:36.031989 | controller | skipping: Conditional result was False
2025-12-03 09:43:36.038385 | 
2025-12-03 09:43:36.038455 | TASK [Get SELinux related data]
2025-12-03 09:43:41.070505 | controller | ERROR
2025-12-03 09:43:41.070983 | controller | {
2025-12-03 09:43:41.071047 | controller |   "delta": "0:00:00.009859",
2025-12-03 09:43:41.071084 | controller |   "end": "2025-12-03 09:43:36.256784",
2025-12-03 09:43:41.071116 | controller |   "msg": "non-zero return code",
2025-12-03 09:43:41.071142 | controller |   "rc": 1,
2025-12-03 09:43:41.071168 | controller |   "start": "2025-12-03 09:43:36.246925"
2025-12-03 09:43:41.071193 | controller | }
2025-12-03 09:43:41.071229 | controller | ERROR: Ignoring Errors
2025-12-03 09:43:41.077324 | 
2025-12-03 09:43:41.077395 | TASK [Create system configuration directory]
2025-12-03 09:43:41.282481 | controller | changed
2025-12-03 09:43:41.287615 | 
2025-12-03 09:43:41.287697 | TASK [Get some of the system configurations]
2025-12-03 09:43:46.313884 | controller | changed
2025-12-03 09:43:46.320132 | 
2025-12-03 09:43:46.320214 | TASK [Copy generated documentation if available]
2025-12-03 09:43:46.346551 | controller | skipping: Conditional result was False
2025-12-03 09:43:46.352482 | 
2025-12-03 09:43:46.352555 | TASK [Copy generated AsciiDoc documentation if available]
2025-12-03 09:43:46.369460 | controller | skipping: Conditional result was False
2025-12-03 09:43:46.377048 | 
2025-12-03 09:43:46.377115 | TASK [Compress logs bigger than 2MB]
2025-12-03 09:43:51.406124 | controller | changed
2025-12-03 09:43:51.414059 | 
2025-12-03 09:43:51.414137 | TASK [Copy files from workspace on node]
2025-12-03 09:43:51.435128 | controller | ok
2025-12-03 09:43:51.457786 | 
2025-12-03 09:43:51.457867 | TASK [fetch-output : Set log path for multiple nodes]
2025-12-03 09:43:51.483604 | controller | skipping: Conditional result was False
2025-12-03 09:43:51.489359 | 
2025-12-03 09:43:51.489423 | TASK [fetch-output : Set log path for single node]
2025-12-03 09:43:51.520464 | controller | ok
2025-12-03 09:43:51.524969 | 
2025-12-03 09:43:51.525032 | LOOP [fetch-output : Ensure local output dirs]
2025-12-03 09:43:51.722259 | controller -> localhost | ok: "/var/lib/zuul/builds/936f6f7a069a41a88bb83b559735a66c/work/logs"
2025-12-03 09:43:51.722648 | controller -> localhost | changed: All items complete
2025-12-03 09:43:51.722693 | 
2025-12-03 09:43:51.918983 | controller -> localhost | changed: "/var/lib/zuul/builds/936f6f7a069a41a88bb83b559735a66c/work/artifacts"
2025-12-03 09:43:52.092481 | controller -> localhost | changed: "/var/lib/zuul/builds/936f6f7a069a41a88bb83b559735a66c/work/docs"
2025-12-03 09:43:52.106652 | 
2025-12-03 09:43:52.106807 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-12-03 09:43:52.659255 | controller | changed:
2025-12-03 09:43:52.659436 | controller | .d..t...... ./
2025-12-03 09:43:52.659467 | controller | >f+++++++++ README.html
2025-12-03 09:43:52.659488 | controller | >f+++++++++ ansible-execution.log
2025-12-03 09:43:52.659509 | controller | >f+++++++++ ansible.log
2025-12-03 09:43:52.659526 | controller | >f+++++++++ dmesg.log
2025-12-03 09:43:52.659543 | controller | >f+++++++++ installed-pkgs.log
2025-12-03 09:43:52.659559 | controller | >f+++++++++ python.log
2025-12-03 09:43:52.659575 | controller | >f+++++++++ registries.conf
2025-12-03 09:43:52.659589 | controller | >f+++++++++ report.html
2025-12-03 09:43:52.659607 | controller | >f+++++++++ selinux-denials.log
2025-12-03 09:43:52.659624 | controller | >f+++++++++ selinux-listing.log
2025-12-03 09:43:52.659639 | controller | cd+++++++++ ci-framework-data/
2025-12-03 09:43:52.659655 | controller | cd+++++++++ ci-framework-data/artifacts/
2025-12-03 09:43:52.659670 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2025-12-03 09:43:52.659685 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2025-12-03 09:43:52.659699 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2025-12-03 09:43:52.659719 | controller | cd+++++++++ ci-framework-data/logs/
2025-12-03 09:43:52.659736 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2025-12-03 09:43:52.659751 | controller | cd+++++++++ registries.conf.d/
2025-12-03 09:43:52.659765 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-12-03 09:43:52.659779 | controller | cd+++++++++ system-config/
2025-12-03 09:43:52.659793 | controller | cd+++++++++ system-config/libvirt/
2025-12-03 09:43:52.659807 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2025-12-03 09:43:52.659821 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2025-12-03 09:43:53.036760 | controller | changed: .d..t...... ./
2025-12-03 09:43:53.411983 | controller | changed: .d..t...... ./
2025-12-03 09:43:53.425358 | 
2025-12-03 09:43:53.425539 | TASK [Return artifact to Zuul]
2025-12-03 09:43:53.456588 | controller | ok
2025-12-03 09:43:53.476787 | 
2025-12-03 09:43:53.476852 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-12-03 09:43:53.477033 | 
2025-12-03 09:43:53.477070 | PLAY RECAP
2025-12-03 09:43:53.477114 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2025-12-03 09:43:53.477135 | 
2025-12-03 09:43:53.603670 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-12-03 09:43:53.604380 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-12-03 09:43:54.139688 | 
2025-12-03 09:43:54.139831 | PLAY [all]
2025-12-03 09:43:54.159139 | 
2025-12-03 09:43:54.159231 | TASK [include_role : fetch-output]
2025-12-03 09:43:54.190627 | controller | ok
2025-12-03 09:43:54.207930 | 
2025-12-03 09:43:54.208235 | TASK [fetch-output : Set log path for multiple nodes]
2025-12-03 09:43:54.264542 | controller | skipping: Conditional result was False
2025-12-03 09:43:54.270251 | 
2025-12-03 09:43:54.270324 | TASK [fetch-output : Set log path for single node]
2025-12-03 09:43:54.310502 | controller | ok
2025-12-03 09:43:54.315328 | 
2025-12-03 09:43:54.315393 | LOOP [fetch-output : Ensure local output dirs]
2025-12-03 09:43:54.677992 | controller -> localhost | ok: "/var/lib/zuul/builds/936f6f7a069a41a88bb83b559735a66c/work/logs"
2025-12-03 09:43:54.860281 | controller -> localhost | ok: "/var/lib/zuul/builds/936f6f7a069a41a88bb83b559735a66c/work/artifacts"
2025-12-03 09:43:55.034485 | controller -> localhost | ok: "/var/lib/zuul/builds/936f6f7a069a41a88bb83b559735a66c/work/docs"
2025-12-03 09:43:55.053836 | 
2025-12-03 09:43:55.054078 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-12-03 09:43:55.642032 | controller | ok
2025-12-03 09:43:55.642341 | controller | ok: All items complete
2025-12-03 09:43:55.642378 | 
2025-12-03 09:43:56.043683 | controller | ok
2025-12-03 09:43:56.442729 | controller | ok
2025-12-03 09:43:56.456084 | 
2025-12-03 09:43:56.456204 | TASK [include_role : fetch-output-openshift]
2025-12-03 09:43:56.481800 | controller | skipping: Conditional result was False
2025-12-03 09:43:56.487871 | 
2025-12-03 09:43:56.487958 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-12-03 09:43:56.868841 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007983
2025-12-03 09:43:57.059663 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008344
2025-12-03 09:43:57.090081 | 
2025-12-03 09:43:57.090305 | PLAY [all]
2025-12-03 09:43:57.104806 | 
2025-12-03 09:43:57.104883 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-12-03 09:43:57.532084 | controller | changed
2025-12-03 09:43:57.553254 | 
2025-12-03 09:43:57.553312 | PLAY RECAP
2025-12-03 09:43:57.553361 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-12-03 09:43:57.553385 | 
2025-12-03 09:43:57.645602 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-12-03 09:43:57.646718 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-12-03 09:43:58.219743 | 
2025-12-03 09:43:58.219889 | PLAY [localhost]
2025-12-03 09:43:58.237146 | 
2025-12-03 09:43:58.237233 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-12-03 09:43:58.550243 | localhost | changed
2025-12-03 09:43:58.555277 | 
2025-12-03 09:43:58.555386 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-12-03 09:43:58.586143 | localhost | ok
2025-12-03 09:43:58.594425 | 
2025-12-03 09:43:58.594502 | TASK [add-fileserver : Create SSH private key tempfile]
2025-12-03 09:43:58.939775 | localhost | changed
2025-12-03 09:43:58.946684 | 
2025-12-03 09:43:58.946788 | TASK [add-fileserver : Create SSH private key from secret]
2025-12-03 09:43:59.514264 | localhost | changed
2025-12-03 09:43:59.519333 | 
2025-12-03 09:43:59.519424 | TASK [add-fileserver : Add fileserver ssh key]
2025-12-03 09:43:59.862980 | localhost | Identity added: /var/lib/zuul/builds/936f6f7a069a41a88bb83b559735a66c/work/tmp/ansible.keks7o8k (/var/lib/zuul/builds/936f6f7a069a41a88bb83b559735a66c/work/tmp/ansible.keks7o8k)
2025-12-03 09:43:59.863171 | localhost | ok: Runtime: 0:00:00.008679
2025-12-03 09:43:59.867741 | 
2025-12-03 09:43:59.867815 | TASK [add-fileserver : Remove SSH private key from disk]
2025-12-03 09:44:00.089462 | localhost | ok: Runtime: 0:00:00.006417
2025-12-03 09:44:00.094320 | 
2025-12-03 09:44:00.094386 | TASK [add-fileserver : Add fileserver to inventory]
2025-12-03 09:44:00.145842 | localhost | changed
2025-12-03 09:44:00.150108 | 
2025-12-03 09:44:00.150178 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-12-03 09:44:00.483262 | localhost | changed
2025-12-03 09:44:00.503414 | 
2025-12-03 09:44:00.503678 | PLAY [localhost]
2025-12-03 09:44:00.515596 | 
2025-12-03 09:44:00.515665 | TASK [Generate bulk log download script]
2025-12-03 09:44:00.536800 | localhost | ok
2025-12-03 09:44:00.548094 | 
2025-12-03 09:44:00.548166 | TASK [local-log-download : Check API endpoint is defined]
2025-12-03 09:44:00.578573 | localhost | ok: All assertions passed
2025-12-03 09:44:00.582969 | 
2025-12-03 09:44:00.583033 | TASK [local-log-download : Create download script]
2025-12-03 09:44:00.943009 | localhost -> localhost | changed
2025-12-03 09:44:00.952979 | 
2025-12-03 09:44:00.953087 | TASK [Register quick-download link]
2025-12-03 09:44:00.983044 | localhost | ok
2025-12-03 09:44:01.037869 | 
2025-12-03 09:44:01.037967 | PLAY [logserver.rdoproject.org]
2025-12-03 09:44:01.047019 | 
2025-12-03 09:44:01.047083 | TASK [Set zuul-log-path fact]
2025-12-03 09:44:01.065883 | logserver.rdoproject.org | ok
2025-12-03 09:44:01.075083 | 
2025-12-03 09:44:01.075156 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-12-03 09:44:01.103065 | logserver.rdoproject.org | ok
2025-12-03 09:44:01.108112 | 
2025-12-03 09:44:01.108180 | TASK [upload-logs : Create log directories]
2025-12-03 09:44:02.855066 | logserver.rdoproject.org | changed
2025-12-03 09:44:02.858693 | 
2025-12-03 09:44:02.858826 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-12-03 09:44:03.087730 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.006730
2025-12-03 09:44:03.092695 | 
2025-12-03 09:44:03.092767 | TASK [upload-logs : Upload logs to log server]
2025-12-03 09:44:04.483268 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-12-03 09:44:04.486386 | 
2025-12-03 09:44:04.486455 | LOOP [upload-logs : Compress console log and json output]
2025-12-03 09:44:04.533605 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-03 09:44:04.542035 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-03 09:44:04.548008 | 
2025-12-03 09:44:04.548128 | LOOP [upload-logs : Upload compressed console log and json output]
2025-12-03 09:44:04.592235 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-03 09:44:04.592519 | 
2025-12-03 09:44:04.595659 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-03 09:44:04.607527 | 
2025-12-03 09:44:04.607645 | LOOP [upload-logs : Upload console log and json output]