2025-09-30 03:00:28.614182 | Job console starting... 2025-09-30 03:00:28.890107 | Updating repositories 2025-09-30 03:00:29.653501 | Preparing job workspace 2025-09-30 03:00:37.607834 | Running Ansible setup... 2025-09-30 03:00:40.664247 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-09-30 03:00:41.221045 | 2025-09-30 03:00:41.221156 | PLAY [localhost] 2025-09-30 03:00:41.230327 | 2025-09-30 03:00:41.230400 | TASK [Gathering Facts] 2025-09-30 03:00:42.121158 | localhost | ok 2025-09-30 03:00:42.135071 | 2025-09-30 03:00:42.135174 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-30 03:00:42.493425 | localhost -> localhost | changed 2025-09-30 03:00:42.500924 | 2025-09-30 03:00:42.501053 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-30 03:00:43.247820 | localhost -> localhost | changed 2025-09-30 03:00:43.257260 | 2025-09-30 03:00:43.257358 | TASK [Setup log path fact] 2025-09-30 03:00:43.276734 | localhost | ok 2025-09-30 03:00:43.292031 | 2025-09-30 03:00:43.292161 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-30 03:00:43.319720 | localhost | ok 2025-09-30 03:00:43.327440 | 2025-09-30 03:00:43.327539 | TASK [emit-job-header : Print job information] 2025-09-30 03:00:43.357795 | # Job Information 2025-09-30 03:00:43.357973 | Ansible Version: 2.15.12 2025-09-30 03:00:43.358006 | Job: cifmw-molecule-cifmw_snr_nhc 2025-09-30 03:00:43.358031 | Pipeline: github-check 2025-09-30 03:00:43.358052 | Executor: ibm-bm4-ze.softwarefactory-project.io 2025-09-30 03:00:43.358070 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3332 2025-09-30 03:00:43.358088 | Log URL (when completed): https://logserver.rdoproject.org/685/rdoproject.org/6853beabfba3437086dd876554121898/ 2025-09-30 03:00:43.358106 | Event ID: 0e973d50-9da6-11f0-93b0-093ef0192992 2025-09-30 03:00:43.361820 | 2025-09-30 03:00:43.361896 | LOOP [emit-job-header : Print node information] 2025-09-30 03:00:43.455394 | localhost | ok: 2025-09-30 03:00:43.455625 | localhost | # Node Information 2025-09-30 03:00:43.455658 | localhost | Inventory Hostname: controller 2025-09-30 03:00:43.455687 | localhost | Hostname: np0005461437 2025-09-30 03:00:43.455709 | localhost | Username: zuul 2025-09-30 03:00:43.455731 | localhost | Distro: CentOS 9 2025-09-30 03:00:43.455749 | localhost | Provider: ibm-bm4-nodepool 2025-09-30 03:00:43.455766 | localhost | Region: regionOne 2025-09-30 03:00:43.455782 | localhost | Label: cloud-centos-9-stream-tripleo-ibm 2025-09-30 03:00:43.455798 | localhost | Product Name: OpenStack Compute 2025-09-30 03:00:43.455813 | localhost | Interface IP: 192.168.26.206 2025-09-30 03:00:43.475892 | 2025-09-30 03:00:43.476047 | PLAY [all] 2025-09-30 03:00:43.482693 | 2025-09-30 03:00:43.482784 | TASK [Gather network facts] 2025-09-30 03:00:43.850623 | controller | ok 2025-09-30 03:00:43.865460 | 2025-09-30 03:00:43.865553 | TASK [include_role : start-zuul-console] 2025-09-30 03:00:43.885228 | controller | ok 2025-09-30 03:00:43.897463 | 2025-09-30 03:00:43.897561 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-30 03:00:44.232756 | controller | ok 2025-09-30 03:00:44.242730 | 2025-09-30 03:00:44.242839 | TASK [include_role : add-build-sshkey] 2025-09-30 03:00:44.263308 | controller | ok 2025-09-30 03:00:44.279001 | 2025-09-30 03:00:44.279125 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-30 03:00:44.527319 | controller -> localhost | ok 2025-09-30 03:00:44.533899 | 2025-09-30 03:00:44.533990 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-30 03:00:44.564310 | controller | ok 2025-09-30 03:00:44.577980 | controller | included: /var/lib/zuul/builds/6853beabfba3437086dd876554121898/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-30 03:00:44.584847 | 2025-09-30 03:00:44.584970 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-30 03:00:45.198563 | controller -> localhost | Generating public/private rsa key pair. 2025-09-30 03:00:45.198781 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/6853beabfba3437086dd876554121898/work/6853beabfba3437086dd876554121898_id_rsa. 2025-09-30 03:00:45.198817 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/6853beabfba3437086dd876554121898/work/6853beabfba3437086dd876554121898_id_rsa.pub. 2025-09-30 03:00:45.198842 | controller -> localhost | The key fingerprint is: 2025-09-30 03:00:45.198931 | controller -> localhost | SHA256:+b3Qa+oRGB9jhBjUOXD4heymWL10pPIrYfKuyoLaoNc zuul-build-sshkey 2025-09-30 03:00:45.198965 | controller -> localhost | The key's randomart image is: 2025-09-30 03:00:45.198987 | controller -> localhost | +---[RSA 3072]----+ 2025-09-30 03:00:45.199006 | controller -> localhost | | .+B.+. | 2025-09-30 03:00:45.199037 | controller -> localhost | | o.B.o | 2025-09-30 03:00:45.199059 | controller -> localhost | | +.=+ | 2025-09-30 03:00:45.199078 | controller -> localhost | | o B*.o | 2025-09-30 03:00:45.199095 | controller -> localhost | | o *Soo | 2025-09-30 03:00:45.199111 | controller -> localhost | | o + o. + | 2025-09-30 03:00:45.199127 | controller -> localhost | |o . + . .+ o | 2025-09-30 03:00:45.199143 | controller -> localhost | |++. E o . o.o | 2025-09-30 03:00:45.199159 | controller -> localhost | |+o+..o.. .ooo | 2025-09-30 03:00:45.199174 | controller -> localhost | +----[SHA256]-----+ 2025-09-30 03:00:45.199220 | controller -> localhost | ok: Runtime: 0:00:00.133464 2025-09-30 03:00:45.207708 | 2025-09-30 03:00:45.207790 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-30 03:00:45.232162 | controller | ok 2025-09-30 03:00:45.247639 | controller | included: /var/lib/zuul/builds/6853beabfba3437086dd876554121898/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-30 03:00:45.259434 | 2025-09-30 03:00:45.259642 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-30 03:00:45.275574 | controller | skipping: Conditional result was False 2025-09-30 03:00:45.283304 | 2025-09-30 03:00:45.283766 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-30 03:00:45.683061 | controller | changed 2025-09-30 03:00:45.690259 | 2025-09-30 03:00:45.690362 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-30 03:00:45.896689 | controller | ok 2025-09-30 03:00:45.902849 | 2025-09-30 03:00:45.902942 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-30 03:00:46.482061 | controller | changed 2025-09-30 03:00:46.487077 | 2025-09-30 03:00:46.487144 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-30 03:00:47.023928 | controller | changed 2025-09-30 03:00:47.029973 | 2025-09-30 03:00:47.030062 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-30 03:00:47.044240 | controller | skipping: Conditional result was False 2025-09-30 03:00:47.049982 | 2025-09-30 03:00:47.050049 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-30 03:00:47.380609 | controller -> localhost | changed 2025-09-30 03:00:47.392293 | 2025-09-30 03:00:47.392382 | TASK [add-build-sshkey : Add back temp key] 2025-09-30 03:00:47.640676 | controller -> localhost | Identity added: /var/lib/zuul/builds/6853beabfba3437086dd876554121898/work/6853beabfba3437086dd876554121898_id_rsa (zuul-build-sshkey) 2025-09-30 03:00:47.640867 | controller -> localhost | ok: Runtime: 0:00:00.007241 2025-09-30 03:00:47.646621 | 2025-09-30 03:00:47.646686 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-30 03:00:47.948985 | controller | ok 2025-09-30 03:00:47.953745 | 2025-09-30 03:00:47.953829 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-30 03:00:47.977853 | controller | skipping: Conditional result was False 2025-09-30 03:00:47.987550 | 2025-09-30 03:00:47.987649 | TASK [include_role : validate-host] 2025-09-30 03:00:48.008375 | controller | ok 2025-09-30 03:00:48.029309 | 2025-09-30 03:00:48.029456 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-30 03:00:48.058207 | controller | ok 2025-09-30 03:00:48.063197 | 2025-09-30 03:00:48.063265 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-30 03:00:48.290185 | controller -> localhost | ok 2025-09-30 03:00:48.296656 | 2025-09-30 03:00:48.296737 | TASK [validate-host : Collect information about the host] 2025-09-30 03:00:48.886464 | controller | ok 2025-09-30 03:00:48.898820 | 2025-09-30 03:00:48.898894 | TASK [validate-host : Sanitize hostname] 2025-09-30 03:00:49.043345 | controller | ok 2025-09-30 03:00:49.049256 | 2025-09-30 03:00:49.049389 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-30 03:00:49.536161 | controller -> localhost | changed 2025-09-30 03:00:49.542106 | 2025-09-30 03:00:49.542176 | TASK [validate-host : Collect information about zuul worker] 2025-09-30 03:00:49.876275 | controller | ok 2025-09-30 03:00:49.883215 | 2025-09-30 03:00:49.883302 | TASK [validate-host : Write out all zuul information for each host] 2025-09-30 03:00:50.290307 | controller -> localhost | changed 2025-09-30 03:00:50.303646 | 2025-09-30 03:00:50.303723 | TASK [include_role : prepare-workspace-openshift] 2025-09-30 03:00:50.328230 | controller | skipping: Conditional result was False 2025-09-30 03:00:50.336244 | 2025-09-30 03:00:50.336321 | TASK [include_role : remove-zuul-sshkey] 2025-09-30 03:00:50.350833 | controller | skipping: Conditional result was False 2025-09-30 03:00:50.357412 | 2025-09-30 03:00:50.357483 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-09-30 03:00:50.557955 | controller | ok: "logs" 2025-09-30 03:00:50.558192 | controller | ok: All items complete 2025-09-30 03:00:50.558223 | 2025-09-30 03:00:50.719886 | controller | ok: "artifacts" 2025-09-30 03:00:50.878898 | controller | ok: "docs" 2025-09-30 03:00:50.886988 | 2025-09-30 03:00:50.887086 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-09-30 03:00:51.078065 | controller | changed: "logs" 2025-09-30 03:00:51.248252 | controller | changed: "artifacts" 2025-09-30 03:00:51.410992 | controller | changed: "docs" 2025-09-30 03:00:51.443402 | 2025-09-30 03:00:51.443514 | PLAY RECAP 2025-09-30 03:00:51.443563 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-09-30 03:00:51.443593 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-30 03:00:51.443634 | 2025-09-30 03:00:51.538055 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-09-30 03:00:51.538825 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-09-30 03:00:52.112075 | 2025-09-30 03:00:52.112197 | PLAY [all] 2025-09-30 03:00:52.132441 | 2025-09-30 03:00:52.132547 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-09-30 03:00:52.182720 | controller | ok 2025-09-30 03:00:52.187678 | 2025-09-30 03:00:52.187796 | TASK [mirror-info-fork : Create /etc/ci] 2025-09-30 03:00:52.562967 | controller | changed 2025-09-30 03:00:52.571333 | 2025-09-30 03:00:52.571420 | TASK [mirror-info-fork : Install ci_mirror script] 2025-09-30 03:00:53.405899 | controller | changed 2025-09-30 03:00:53.423007 | 2025-09-30 03:00:53.423099 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-09-30 03:00:53.830808 | controller | changed: 2025-09-30 03:00:53.831203 | controller | { 2025-09-30 03:00:53.831290 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-09-30 03:00:53.831325 | controller | } 2025-09-30 03:00:54.044261 | controller | changed: 2025-09-30 03:00:54.044355 | controller | { 2025-09-30 03:00:54.044384 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-09-30 03:00:54.044407 | controller | } 2025-09-30 03:00:54.263366 | controller | changed: 2025-09-30 03:00:54.265440 | controller | { 2025-09-30 03:00:54.265491 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com" 2025-09-30 03:00:54.265518 | controller | } 2025-09-30 03:00:54.478097 | controller | changed: 2025-09-30 03:00:54.478196 | controller | { 2025-09-30 03:00:54.478232 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-09-30 03:00:54.478258 | controller | } 2025-09-30 03:00:54.720130 | controller | changed: 2025-09-30 03:00:54.720216 | controller | { 2025-09-30 03:00:54.720245 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-09-30 03:00:54.720268 | controller | } 2025-09-30 03:00:54.962725 | controller | changed: 2025-09-30 03:00:54.962821 | controller | { 2025-09-30 03:00:54.962850 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-09-30 03:00:54.962872 | controller | } 2025-09-30 03:00:55.196745 | controller | changed: 2025-09-30 03:00:55.196857 | controller | { 2025-09-30 03:00:55.196886 | 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-09-30 03:00:55.196937 | controller | } 2025-09-30 03:00:55.421283 | controller | changed: 2025-09-30 03:00:55.421626 | controller | { 2025-09-30 03:00:55.421663 | 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-09-30 03:00:55.421688 | controller | } 2025-09-30 03:00:55.641512 | controller | changed: 2025-09-30 03:00:55.641608 | controller | { 2025-09-30 03:00:55.641637 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-09-30 03:00:55.641659 | controller | } 2025-09-30 03:00:55.856701 | controller | changed: 2025-09-30 03:00:55.856785 | controller | { 2025-09-30 03:00:55.856811 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-09-30 03:00:55.856830 | controller | } 2025-09-30 03:00:56.083673 | controller | changed: 2025-09-30 03:00:56.083764 | controller | { 2025-09-30 03:00:56.083791 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-09-30 03:00:56.083812 | controller | } 2025-09-30 03:00:56.307415 | controller | changed: 2025-09-30 03:00:56.307507 | controller | { 2025-09-30 03:00:56.307535 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-09-30 03:00:56.307557 | controller | } 2025-09-30 03:00:56.532367 | controller | changed: 2025-09-30 03:00:56.532456 | controller | { 2025-09-30 03:00:56.532483 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-09-30 03:00:56.532504 | controller | } 2025-09-30 03:00:56.755585 | controller | changed: 2025-09-30 03:00:56.755742 | controller | { 2025-09-30 03:00:56.755773 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-09-30 03:00:56.755795 | controller | } 2025-09-30 03:00:56.985772 | controller | changed: 2025-09-30 03:00:56.985863 | controller | { 2025-09-30 03:00:56.985890 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-09-30 03:00:56.985940 | controller | } 2025-09-30 03:00:57.212073 | controller | changed: 2025-09-30 03:00:57.213830 | controller | { 2025-09-30 03:00:57.213873 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-09-30 03:00:57.213896 | controller | } 2025-09-30 03:00:57.445796 | controller | changed: 2025-09-30 03:00:57.445886 | controller | { 2025-09-30 03:00:57.445939 | 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-09-30 03:00:57.445968 | controller | } 2025-09-30 03:00:57.661088 | controller | changed: 2025-09-30 03:00:57.661350 | controller | { 2025-09-30 03:00:57.661390 | 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-09-30 03:00:57.661423 | controller | } 2025-09-30 03:00:57.880062 | controller | changed: 2025-09-30 03:00:57.880270 | controller | { 2025-09-30 03:00:57.880310 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-09-30 03:00:57.880335 | controller | } 2025-09-30 03:00:58.119828 | controller | changed: 2025-09-30 03:00:58.119904 | controller | { 2025-09-30 03:00:58.119953 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-09-30 03:00:58.119977 | controller | } 2025-09-30 03:00:58.340808 | controller | changed: 2025-09-30 03:00:58.340894 | controller | { 2025-09-30 03:00:58.340947 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-09-30 03:00:58.340972 | controller | } 2025-09-30 03:00:58.556975 | controller | changed: 2025-09-30 03:00:58.557062 | controller | { 2025-09-30 03:00:58.557091 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-09-30 03:00:58.557112 | controller | } 2025-09-30 03:00:58.768957 | controller | changed: 2025-09-30 03:00:58.769131 | controller | { 2025-09-30 03:00:58.769169 | 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-09-30 03:00:58.769196 | controller | } 2025-09-30 03:00:58.987036 | controller | changed: 2025-09-30 03:00:58.987126 | controller | { 2025-09-30 03:00:58.987152 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-09-30 03:00:58.987173 | controller | } 2025-09-30 03:00:59.193404 | controller | changed: 2025-09-30 03:00:59.193496 | controller | { 2025-09-30 03:00:59.193523 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-09-30 03:00:59.193545 | controller | } 2025-09-30 03:00:59.404807 | controller | changed: 2025-09-30 03:00:59.404894 | controller | { 2025-09-30 03:00:59.404951 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-09-30 03:00:59.404976 | controller | } 2025-09-30 03:00:59.428148 | 2025-09-30 03:00:59.428258 | TASK [Set timezone to UTC] 2025-09-30 03:00:59.844309 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2025-09-30 03:00:59.850764 | 2025-09-30 03:00:59.850839 | TASK [Create nodepool directory] 2025-09-30 03:01:00.097851 | controller | changed 2025-09-30 03:01:00.103783 | 2025-09-30 03:01:00.103849 | TASK [Create nodepool sub_nodes file] 2025-09-30 03:01:00.732025 | controller | changed 2025-09-30 03:01:00.738049 | 2025-09-30 03:01:00.738194 | TASK [Create nodepool sub_nodes_private file] 2025-09-30 03:01:01.300219 | controller | changed 2025-09-30 03:01:01.305511 | 2025-09-30 03:01:01.305616 | LOOP [Populate nodepool sub_nodes file] 2025-09-30 03:01:01.335838 | 2025-09-30 03:01:01.336006 | LOOP [Populate nodepool sub_nodes_private file] 2025-09-30 03:01:01.365142 | 2025-09-30 03:01:01.365279 | TASK [Create nodepool primary file] 2025-09-30 03:01:01.399217 | controller | skipping: Conditional result was False 2025-09-30 03:01:01.405692 | 2025-09-30 03:01:01.405789 | TASK [Create nodepool node_private for this node] 2025-09-30 03:01:01.986060 | controller | changed 2025-09-30 03:01:01.991950 | 2025-09-30 03:01:01.992050 | LOOP [Copy ssh keys to nodepool directory] 2025-09-30 03:01:02.353822 | controller | ok: Item: id_rsa Runtime: 0:00:00.005790 2025-09-30 03:01:02.354026 | 2025-09-30 03:01:02.519273 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004338 2025-09-30 03:01:02.535064 | 2025-09-30 03:01:02.535156 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2025-09-30 03:01:03.112516 | controller | changed 2025-09-30 03:01:03.120249 | 2025-09-30 03:01:03.120323 | TASK [Validate sudoers config after edits] 2025-09-30 03:01:03.357396 | controller | /etc/sudoers: parsed OK 2025-09-30 03:01:03.357515 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2025-09-30 03:01:03.357528 | controller | /etc/sudoers.d/zuul: parsed OK 2025-09-30 03:01:03.357536 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-09-30 03:01:03.660944 | controller | ok: Runtime: 0:00:00.005197 2025-09-30 03:01:03.666990 | 2025-09-30 03:01:03.667060 | TASK [Show the environment passed in to job shell scripts] 2025-09-30 03:01:03.898719 | controller | SHELL=/bin/bash 2025-09-30 03:01:03.898781 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2025-09-30 03:01:03.898860 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework 2025-09-30 03:01:03.898878 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/46/3346/eb5b53fb17db92a72d33d052a56c8edd0d10ea78^openstack-k8s-operators/ci-framework:main:refs/changes/32/3332/2b7f44a769d14bbef534eeafa4b4e5c8b67650d8 2025-09-30 03:01:03.898889 | controller | PWD=/home/zuul 2025-09-30 03:01:03.898895 | controller | ZUUL_PIPELINE=github-check 2025-09-30 03:01:03.898900 | controller | LOGNAME=zuul 2025-09-30 03:01:03.898906 | controller | XDG_SESSION_TYPE=tty 2025-09-30 03:01:03.898912 | controller | _=/usr/bin/env 2025-09-30 03:01:03.898917 | controller | MOTD_SHOWN=pam 2025-09-30 03:01:03.898923 | controller | HOME=/home/zuul 2025-09-30 03:01:03.898928 | controller | LANG=en_US.UTF-8 2025-09-30 03:01:03.898934 | controller | SSH_CONNECTION=192.168.26.12 53358 192.168.26.206 22 2025-09-30 03:01:03.898940 | 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-09-30 03:01:03.898946 | controller | ZUUL_CHANGE_IDS=3346,eb5b53fb17db92a72d33d052a56c8edd0d10ea78 3332,2b7f44a769d14bbef534eeafa4b4e5c8b67650d8 2025-09-30 03:01:03.898952 | controller | WORKSPACE=/home/zuul/workspace 2025-09-30 03:01:03.898957 | controller | XDG_SESSION_CLASS=user 2025-09-30 03:01:03.898963 | controller | SELINUX_ROLE_REQUESTED= 2025-09-30 03:01:03.898968 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-09-30 03:01:03.898974 | controller | USER=zuul 2025-09-30 03:01:03.898979 | controller | ZUUL_VOTING=True 2025-09-30 03:01:03.898985 | controller | BUILD_TIMEOUT=1800000 2025-09-30 03:01:03.898990 | controller | SELINUX_USE_CURRENT_RANGE= 2025-09-30 03:01:03.898995 | controller | SHLVL=1 2025-09-30 03:01:03.899001 | controller | ZUUL_PATCHSET=2b7f44a769d14bbef534eeafa4b4e5c8b67650d8 2025-09-30 03:01:03.899006 | controller | XDG_SESSION_ID=1 2025-09-30 03:01:03.899012 | controller | ZUUL_BRANCH=main 2025-09-30 03:01:03.899018 | controller | XDG_RUNTIME_DIR=/run/user/1000 2025-09-30 03:01:03.899023 | controller | SSH_CLIENT=192.168.26.12 53358 22 2025-09-30 03:01:03.899029 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2025-09-30 03:01:03.899034 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2025-09-30 03:01:03.899040 | controller | which_declare=declare -f 2025-09-30 03:01:03.899045 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-09-30 03:01:03.899052 | controller | SELINUX_LEVEL_REQUESTED= 2025-09-30 03:01:03.899057 | controller | ZUUL_CHANGE=3332 2025-09-30 03:01:03.899080 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-09-30 03:01:03.899090 | controller | ZUUL_UUID=6853beabfba3437086dd876554121898 2025-09-30 03:01:03.899098 | controller | BASH_FUNC_which%%=() { ( alias; 2025-09-30 03:01:03.899104 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-09-30 03:01:03.899109 | controller | } 2025-09-30 03:01:04.215045 | controller | ok: Runtime: 0:00:00.005684 2025-09-30 03:01:04.220714 | 2025-09-30 03:01:04.220790 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2025-09-30 03:01:04.234089 | controller | skipping: Conditional result was False 2025-09-30 03:01:04.239703 | 2025-09-30 03:01:04.239771 | TASK [Symlink /home/zuul-worker/workspace] 2025-09-30 03:01:04.765178 | controller | skipping: Conditional result was False 2025-09-30 03:01:04.770826 | 2025-09-30 03:01:04.770896 | TASK [Ensure legacy workspace directory] 2025-09-30 03:01:04.971973 | controller | changed 2025-09-30 03:01:04.991293 | 2025-09-30 03:01:04.991394 | PLAY RECAP 2025-09-30 03:01:04.991447 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-09-30 03:01:04.991472 | 2025-09-30 03:01:05.076393 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-09-30 03:01:05.077241 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-09-30 03:01:05.634418 | 2025-09-30 03:01:05.634532 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2025-09-30 03:01:05.664057 | 2025-09-30 03:01:05.664184 | TASK [Create zuul-output directory] 2025-09-30 03:01:06.009634 | controller | changed 2025-09-30 03:01:06.015438 | 2025-09-30 03:01:06.015525 | TASK [Slurp Zuul inventory test] 2025-09-30 03:01:06.312879 | controller -> localhost | ok 2025-09-30 03:01:06.321625 | 2025-09-30 03:01:06.321715 | TASK [Save zuul inventory] 2025-09-30 03:01:07.135693 | controller | changed 2025-09-30 03:01:07.141516 | 2025-09-30 03:01:07.141633 | TASK [Save zuul vars without the change_message] 2025-09-30 03:01:07.785767 | controller | changed 2025-09-30 03:01:07.804563 | 2025-09-30 03:01:07.804659 | PLAY RECAP 2025-09-30 03:01:07.804702 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-30 03:01:07.804726 | 2025-09-30 03:01:07.889848 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-09-30 03:01:07.890635 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2025-09-30 03:01:08.465771 | 2025-09-30 03:01:08.465884 | PLAY [Run ci/playbooks/molecule-prepare.yml] 2025-09-30 03:01:08.486306 | 2025-09-30 03:01:08.486400 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh] 2025-09-30 03:01:08.504788 | controller | ok 2025-09-30 03:01:08.521921 | 2025-09-30 03:01:08.522015 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-09-30 03:01:08.545353 | controller | skipping: Conditional result was False 2025-09-30 03:01:08.550759 | 2025-09-30 03:01:08.550833 | TASK [mirror-info-fork : Create /etc/ci] 2025-09-30 03:01:08.885415 | controller | ok 2025-09-30 03:01:08.895511 | 2025-09-30 03:01:08.895633 | TASK [mirror-info-fork : Install ci_mirror script] 2025-09-30 03:01:09.538788 | controller | ok 2025-09-30 03:01:09.549997 | 2025-09-30 03:01:09.550069 | TASK [Prepare workspace] 2025-09-30 03:01:09.569070 | controller | ok 2025-09-30 03:01:09.587107 | 2025-09-30 03:01:09.587212 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-09-30 03:01:09.910672 | controller | ok 2025-09-30 03:01:09.917556 | 2025-09-30 03:01:09.917641 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-09-30 03:01:12.041836 | controller | Output suppressed because no_log was given 2025-09-30 03:01:12.052562 | 2025-09-30 03:01:12.052752 | LOOP [Create zuul-output directory] 2025-09-30 03:01:12.246740 | controller | changed: "/home/zuul/ci-framework-data/logs" 2025-09-30 03:01:12.414866 | controller | ok: "/home/zuul/zuul-output/logs" 2025-09-30 03:01:12.432875 | 2025-09-30 03:01:12.433035 | TASK [Install required packages] 2025-09-30 03:02:06.518696 | controller | changed 2025-09-30 03:02:06.524231 | 2025-09-30 03:02:06.524297 | TASK [Install venv] 2025-09-30 03:03:13.836652 | controller | changed 2025-09-30 03:03:13.881779 | 2025-09-30 03:03:13.881867 | PLAY RECAP 2025-09-30 03:03:13.881959 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2025-09-30 03:03:13.881991 | 2025-09-30 03:03:13.991046 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2025-09-30 03:03:13.992167 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main] 2025-09-30 03:03:14.886417 | 2025-09-30 03:03:14.886531 | PLAY [Run ci/playbooks/molecule-test.yml] 2025-09-30 03:03:14.928234 | 2025-09-30 03:03:14.928355 | TASK [Gather required facts] 2025-09-30 03:03:15.659286 | controller | ok 2025-09-30 03:03:15.664717 | 2025-09-30 03:03:15.664816 | TASK [Load environment var if instructed to] 2025-09-30 03:03:15.743156 | controller | skipping: Conditional result was False 2025-09-30 03:03:15.749002 | 2025-09-30 03:03:15.749118 | TASK [Run molecule] 2025-09-30 03:03:16.737813 | controller | INFO Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml 2025-09-30 03:03:16.808261 | controller | WARNING Driver podman does not provide a schema. 2025-09-30 03:03:16.810811 | controller | INFO Performing prerun with role_name_check=0... 2025-09-30 03:03:33.534261 | controller | WARNING Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 03:03:33.534694 | controller | WARNING Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 03:03:33.535162 | controller | WARNING Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 03:03:33.535630 | controller | WARNING Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 03:03:33.536108 | controller | WARNING Another version of 'cifmw.general' 1.0.0+5e80db1c was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.0.0+5e80db1c (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 03:03:33.536578 | controller | WARNING Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 03:03:33.537018 | controller | WARNING Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 03:03:33.537495 | controller | WARNING Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 03:03:33.537940 | controller | WARNING Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 03:03:33.538416 | controller | WARNING Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 03:03:33.538838 | controller | WARNING Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 03:03:33.539313 | controller | WARNING Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 03:03:33.539747 | controller | WARNING Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 03:03:33.540215 | controller | WARNING Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 03:03:33.540671 | controller | WARNING Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 03:03:33.551438 | controller | INFO Running default > dependency 2025-09-30 03:03:33.552379 | controller | WARNING Skipping, missing the requirements file. 2025-09-30 03:03:33.553089 | controller | WARNING Skipping, missing the requirements file. 2025-09-30 03:03:33.562254 | controller | INFO Running default > create 2025-09-30 03:03:33.791364 | controller | INFO Sanity checks: 'podman' 2025-09-30 03:03:34.707503 | controller | 2025-09-30 03:03:34.707598 | controller | PLAY [Create] ****************************************************************** 2025-09-30 03:03:34.707690 | controller | 2025-09-30 03:03:34.707790 | controller | TASK [Get podman executable path] ********************************************** 2025-09-30 03:03:34.707888 | controller | Tuesday 30 September 2025 03:03:34 +0000 (0:00:00.014) 0:00:00.014 ***** 2025-09-30 03:03:35.015129 | controller | ok: [localhost] 2025-09-30 03:03:35.015195 | controller | 2025-09-30 03:03:35.015309 | controller | TASK [Register podman executable path] ***************************************** 2025-09-30 03:03:35.015411 | controller | Tuesday 30 September 2025 03:03:35 +0000 (0:00:00.306) 0:00:00.321 ***** 2025-09-30 03:03:35.056491 | controller | ok: [localhost] 2025-09-30 03:03:35.056609 | controller | 2025-09-30 03:03:35.056739 | controller | TASK [Get passwd entries for USER env] ***************************************** 2025-09-30 03:03:35.056858 | controller | Tuesday 30 September 2025 03:03:35 +0000 (0:00:00.042) 0:00:00.363 ***** 2025-09-30 03:03:35.353861 | controller | ok: [localhost] 2025-09-30 03:03:35.353932 | controller | 2025-09-30 03:03:35.354034 | controller | TASK [Get shell async_dir] ***************************************************** 2025-09-30 03:03:35.354164 | controller | Tuesday 30 September 2025 03:03:35 +0000 (0:00:00.295) 0:00:00.659 ***** 2025-09-30 03:03:35.395868 | controller | ok: [localhost] 2025-09-30 03:03:35.395959 | controller | 2025-09-30 03:03:35.396095 | controller | TASK [Set async_dir for HOME env] ********************************************** 2025-09-30 03:03:35.396257 | controller | Tuesday 30 September 2025 03:03:35 +0000 (0:00:00.044) 0:00:00.703 ***** 2025-09-30 03:03:35.429835 | controller | skipping: [localhost] 2025-09-30 03:03:35.429940 | controller | 2025-09-30 03:03:35.430079 | controller | TASK [Log into a container registry] ******************************************* 2025-09-30 03:03:35.430236 | controller | Tuesday 30 September 2025 03:03:35 +0000 (0:00:00.033) 0:00:00.737 ***** 2025-09-30 03:03:35.475537 | controller | skipping: [localhost] => (item="instance registry username: None specified") 2025-09-30 03:03:35.475641 | controller | skipping: [localhost] 2025-09-30 03:03:35.475732 | controller | 2025-09-30 03:03:35.475834 | controller | TASK [Check presence of custom Dockerfiles] ************************************ 2025-09-30 03:03:35.475936 | controller | Tuesday 30 September 2025 03:03:35 +0000 (0:00:00.045) 0:00:00.783 ***** 2025-09-30 03:03:35.769810 | controller | ok: [localhost] => (item=Dockerfile: None specified) 2025-09-30 03:03:35.769895 | controller | 2025-09-30 03:03:35.770006 | controller | TASK [Create Dockerfiles from image names] ************************************* 2025-09-30 03:03:35.770118 | controller | Tuesday 30 September 2025 03:03:35 +0000 (0:00:00.294) 0:00:01.077 ***** 2025-09-30 03:03:35.809026 | controller | skipping: [localhost] => (item="Dockerfile: None specified; Image: registry.access.redhat.com/ubi9/ubi:latest") 2025-09-30 03:03:35.809113 | controller | skipping: [localhost] 2025-09-30 03:03:35.809241 | controller | 2025-09-30 03:03:35.809351 | controller | TASK [Discover local Podman images] ******************************************** 2025-09-30 03:03:35.809453 | controller | Tuesday 30 September 2025 03:03:35 +0000 (0:00:00.039) 0:00:01.116 ***** 2025-09-30 03:03:36.652082 | controller | ok: [localhost] => (item=instance) 2025-09-30 03:03:36.652135 | controller | 2025-09-30 03:03:36.652290 | controller | TASK [Build an Ansible compatible image] *************************************** 2025-09-30 03:03:36.652385 | controller | Tuesday 30 September 2025 03:03:36 +0000 (0:00:00.842) 0:00:01.959 ***** 2025-09-30 03:03:36.692268 | controller | skipping: [localhost] => (item=registry.access.redhat.com/ubi9/ubi:latest) 2025-09-30 03:03:36.692383 | controller | skipping: [localhost] 2025-09-30 03:03:36.692505 | controller | 2025-09-30 03:03:36.692633 | controller | TASK [Determine the CMD directives] ******************************************** 2025-09-30 03:03:36.692761 | controller | Tuesday 30 September 2025 03:03:36 +0000 (0:00:00.040) 0:00:01.999 ***** 2025-09-30 03:03:36.742253 | controller | ok: [localhost] => (item="instance command: sleep infinity") 2025-09-30 03:03:36.742311 | controller | 2025-09-30 03:03:36.742430 | controller | TASK [Remove possible pre-existing containers] ********************************* 2025-09-30 03:03:36.742535 | controller | Tuesday 30 September 2025 03:03:36 +0000 (0:00:00.049) 0:00:02.049 ***** 2025-09-30 03:03:36.983776 | controller | changed: [localhost] 2025-09-30 03:03:37.030963 | controller | 2025-09-30 03:03:37.031000 | controller | TASK [Discover local podman networks] ****************************************** 2025-09-30 03:03:37.031009 | controller | Tuesday 30 September 2025 03:03:36 +0000 (0:00:00.241) 0:00:02.290 ***** 2025-09-30 03:03:37.031021 | controller | skipping: [localhost] => (item=instance: None specified) 2025-09-30 03:03:37.068507 | controller | skipping: [localhost] 2025-09-30 03:03:37.068544 | controller | 2025-09-30 03:03:37.068551 | controller | TASK [Create podman network dedicated to this scenario] ************************ 2025-09-30 03:03:37.068557 | controller | Tuesday 30 September 2025 03:03:37 +0000 (0:00:00.046) 0:00:02.337 ***** 2025-09-30 03:03:37.068569 | controller | skipping: [localhost] 2025-09-30 03:03:37.411208 | controller | 2025-09-30 03:03:37.411252 | controller | TASK [Create molecule instance(s)] ********************************************* 2025-09-30 03:03:37.411261 | controller | Tuesday 30 September 2025 03:03:37 +0000 (0:00:00.037) 0:00:02.375 ***** 2025-09-30 03:03:37.411275 | controller | changed: [localhost] => (item=instance) 2025-09-30 03:03:42.889191 | controller | 2025-09-30 03:03:42.889228 | controller | TASK [Wait for instance(s) creation to complete] ******************************* 2025-09-30 03:03:42.889250 | controller | Tuesday 30 September 2025 03:03:37 +0000 (0:00:00.342) 0:00:02.717 ***** 2025-09-30 03:03:42.889265 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) creation to complete (300 retries left). 2025-09-30 03:03:42.889294 | controller | changed: [localhost] => (item=instance) 2025-09-30 03:03:42.889302 | controller | 2025-09-30 03:03:42.889309 | controller | PLAY RECAP ********************************************************************* 2025-09-30 03:03:42.889315 | controller | localhost : ok=10 changed=3 unreachable=0 failed=0 skipped=6 rescued=0 ignored=0 2025-09-30 03:03:42.889322 | controller | 2025-09-30 03:03:42.889329 | controller | Tuesday 30 September 2025 03:03:42 +0000 (0:00:05.478) 0:00:08.195 ***** 2025-09-30 03:03:42.889335 | controller | =============================================================================== 2025-09-30 03:03:42.889344 | controller | Wait for instance(s) creation to complete ------------------------------- 5.48s 2025-09-30 03:03:42.890827 | controller | Discover local Podman images -------------------------------------------- 0.84s 2025-09-30 03:03:42.946179 | controller | Create molecule instance(s) --------------------------------------------- 0.34s 2025-09-30 03:03:42.946215 | controller | Get podman executable path ---------------------------------------------- 0.31s 2025-09-30 03:03:42.946223 | controller | Get passwd entries for USER env ----------------------------------------- 0.30s 2025-09-30 03:03:42.946229 | controller | Check presence of custom Dockerfiles ------------------------------------ 0.29s 2025-09-30 03:03:42.946250 | controller | Remove possible pre-existing containers --------------------------------- 0.24s 2025-09-30 03:03:42.946257 | controller | Determine the CMD directives -------------------------------------------- 0.05s 2025-09-30 03:03:42.946263 | controller | Discover local podman networks ------------------------------------------ 0.05s 2025-09-30 03:03:42.946268 | controller | Log into a container registry ------------------------------------------- 0.05s 2025-09-30 03:03:42.946274 | controller | Get shell async_dir ----------------------------------------------------- 0.04s 2025-09-30 03:03:42.946279 | controller | Register podman executable path ----------------------------------------- 0.04s 2025-09-30 03:03:42.946285 | controller | Build an Ansible compatible image --------------------------------------- 0.04s 2025-09-30 03:03:42.946295 | controller | Create Dockerfiles from image names ------------------------------------- 0.04s 2025-09-30 03:03:42.946300 | controller | Create podman network dedicated to this scenario ------------------------ 0.04s 2025-09-30 03:03:42.946306 | controller | Set async_dir for HOME env ---------------------------------------------- 0.03s 2025-09-30 03:03:42.946317 | controller | INFO Running default > prepare 2025-09-30 03:03:43.368525 | controller | 2025-09-30 03:03:44.509186 | controller | PLAY [Prepare] ***************************************************************** 2025-09-30 03:03:44.509218 | controller | 2025-09-30 03:03:44.509226 | controller | TASK [Gathering Facts] ********************************************************* 2025-09-30 03:03:44.509232 | controller | Tuesday 30 September 2025 03:03:43 +0000 (0:00:00.010) 0:00:00.010 ***** 2025-09-30 03:03:44.509242 | controller | ok: [instance] 2025-09-30 03:03:44.509278 | controller | 2025-09-30 03:03:44.509448 | controller | TASK [Install Python pip and dependencies using dnf] *************************** 2025-09-30 03:03:51.232211 | controller | Tuesday 30 September 2025 03:03:44 +0000 (0:00:01.141) 0:00:01.151 ***** 2025-09-30 03:03:51.232248 | controller | changed: [instance] 2025-09-30 03:03:51.232274 | controller | 2025-09-30 03:03:51.232470 | controller | TASK [Install Python dependencies] ********************************************* 2025-09-30 03:03:56.769200 | controller | Tuesday 30 September 2025 03:03:51 +0000 (0:00:06.723) 0:00:07.874 ***** 2025-09-30 03:03:56.769237 | controller | changed: [instance] 2025-09-30 03:03:58.364802 | controller | 2025-09-30 03:03:58.364832 | controller | TASK [Create mock kubeconfig file] ********************************************* 2025-09-30 03:03:58.364840 | controller | Tuesday 30 September 2025 03:03:56 +0000 (0:00:05.536) 0:00:13.411 ***** 2025-09-30 03:03:58.364850 | controller | changed: [instance] 2025-09-30 03:03:59.696509 | controller | 2025-09-30 03:03:59.696541 | controller | TASK [Create mock kubeadmin password file] ************************************* 2025-09-30 03:03:59.696549 | controller | Tuesday 30 September 2025 03:03:58 +0000 (0:00:01.595) 0:00:15.007 ***** 2025-09-30 03:03:59.696559 | controller | changed: [instance] 2025-09-30 03:03:59.749881 | controller | 2025-09-30 03:03:59.749911 | controller | PLAY RECAP ********************************************************************* 2025-09-30 03:03:59.749919 | controller | instance : ok=5 changed=4 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2025-09-30 03:03:59.749925 | controller | 2025-09-30 03:03:59.749931 | controller | Tuesday 30 September 2025 03:03:59 +0000 (0:00:01.331) 0:00:16.338 ***** 2025-09-30 03:03:59.749936 | controller | =============================================================================== 2025-09-30 03:03:59.749942 | controller | Install Python pip and dependencies using dnf --------------------------- 6.72s 2025-09-30 03:03:59.749947 | controller | Install Python dependencies --------------------------------------------- 5.54s 2025-09-30 03:03:59.749952 | controller | Create mock kubeconfig file --------------------------------------------- 1.60s 2025-09-30 03:03:59.749958 | controller | Create mock kubeadmin password file ------------------------------------- 1.33s 2025-09-30 03:03:59.749963 | controller | Gathering Facts --------------------------------------------------------- 1.14s 2025-09-30 03:03:59.749974 | controller | INFO Running default > converge 2025-09-30 03:04:00.201567 | controller | 2025-09-30 03:04:00.227197 | controller | PLAY [Converge] **************************************************************** 2025-09-30 03:04:00.227229 | controller | 2025-09-30 03:04:00.227244 | controller | TASK [Test that required variables are defined] ******************************** 2025-09-30 03:04:00.227250 | controller | Tuesday 30 September 2025 03:04:00 +0000 (0:00:00.020) 0:00:00.020 ***** 2025-09-30 03:04:00.227260 | controller | ok: [instance] => changed=false 2025-09-30 03:04:00.227280 | controller | msg: Required variables are defined 2025-09-30 03:04:00.227562 | controller | 2025-09-30 03:04:00.227595 | controller | TASK [Display test information] ************************************************ 2025-09-30 03:04:00.247705 | controller | Tuesday 30 September 2025 03:04:00 +0000 (0:00:00.026) 0:00:00.047 ***** 2025-09-30 03:04:00.247733 | controller | ok: [instance] => 2025-09-30 03:04:01.405022 | controller | msg: 'Testing role cifmw_snr_nhc with kubeconfig: /tmp/kubeconfig and namespace: workload-availability' 2025-09-30 03:04:01.405078 | controller | 2025-09-30 03:04:01.405093 | controller | TASK [Test that Python kubernetes library is available] ************************ 2025-09-30 03:04:01.405099 | controller | Tuesday 30 September 2025 03:04:00 +0000 (0:00:00.020) 0:00:00.067 ***** 2025-09-30 03:04:01.405109 | controller | ok: [instance] 2025-09-30 03:04:01.429091 | controller | 2025-09-30 03:04:01.429121 | controller | TASK [Display kubernetes library test result] ********************************** 2025-09-30 03:04:01.429129 | controller | Tuesday 30 September 2025 03:04:01 +0000 (0:00:01.157) 0:00:01.224 ***** 2025-09-30 03:04:01.429140 | controller | ok: [instance] => 2025-09-30 03:04:02.157134 | controller | msg: Library available 2025-09-30 03:04:02.157168 | controller | 2025-09-30 03:04:02.157176 | controller | TASK [Test that mock kubeconfig exists] **************************************** 2025-09-30 03:04:02.157182 | controller | Tuesday 30 September 2025 03:04:01 +0000 (0:00:00.023) 0:00:01.248 ***** 2025-09-30 03:04:02.157192 | controller | ok: [instance] 2025-09-30 03:04:02.157217 | controller | 2025-09-30 03:04:02.157457 | controller | TASK [Assert kubeconfig exists] ************************************************ 2025-09-30 03:04:02.180127 | controller | Tuesday 30 September 2025 03:04:02 +0000 (0:00:00.728) 0:00:01.977 ***** 2025-09-30 03:04:02.180159 | controller | ok: [instance] => changed=false 2025-09-30 03:04:02.180185 | controller | msg: Kubeconfig file exists 2025-09-30 03:04:02.180192 | controller | 2025-09-30 03:04:02.180198 | controller | TASK [Test kubernetes.core.k8s module availability] **************************** 2025-09-30 03:04:02.180206 | controller | Tuesday 30 September 2025 03:04:02 +0000 (0:00:00.022) 0:00:02.000 ***** 2025-09-30 03:04:03.722689 | controller | ok: [instance] 2025-09-30 03:04:03.744147 | controller | 2025-09-30 03:04:03.744181 | controller | TASK [Display k8s connection test result] ************************************** 2025-09-30 03:04:03.744190 | controller | Tuesday 30 September 2025 03:04:03 +0000 (0:00:01.542) 0:00:03.542 ***** 2025-09-30 03:04:03.744200 | controller | ok: [instance] => 2025-09-30 03:04:03.805786 | controller | msg: 'K8s connection test result: False' 2025-09-30 03:04:03.805815 | controller | 2025-09-30 03:04:03.805823 | controller | TASK [Include the cifmw_snr_nhc role] ****************************************** 2025-09-30 03:04:03.805830 | controller | Tuesday 30 September 2025 03:04:03 +0000 (0:00:00.021) 0:00:03.564 ***** 2025-09-30 03:04:03.805839 | controller | 2025-09-30 03:04:03.832931 | controller | TASK [cifmw_snr_nhc : Check if NodeHealthCheck exists and is active] *********** 2025-09-30 03:04:03.832962 | controller | Tuesday 30 September 2025 03:04:03 +0000 (0:00:00.061) 0:00:03.625 ***** 2025-09-30 03:04:03.832975 | controller | skipping: [instance] 2025-09-30 03:04:03.859272 | controller | 2025-09-30 03:04:03.859300 | controller | TASK [cifmw_snr_nhc : Check for active SelfNodeRemediations] ******************* 2025-09-30 03:04:03.859308 | controller | Tuesday 30 September 2025 03:04:03 +0000 (0:00:00.026) 0:00:03.652 ***** 2025-09-30 03:04:03.859318 | controller | skipping: [instance] 2025-09-30 03:04:03.885189 | controller | 2025-09-30 03:04:03.885214 | controller | TASK [cifmw_snr_nhc : Display active remediations info] ************************ 2025-09-30 03:04:03.885222 | controller | Tuesday 30 September 2025 03:04:03 +0000 (0:00:00.026) 0:00:03.679 ***** 2025-09-30 03:04:03.885232 | controller | skipping: [instance] 2025-09-30 03:04:03.885380 | controller | 2025-09-30 03:04:03.885545 | controller | TASK [cifmw_snr_nhc : Disable NodeHealthCheck to stop active remediations] ***** 2025-09-30 03:04:03.885689 | controller | Tuesday 30 September 2025 03:04:03 +0000 (0:00:00.026) 0:00:03.705 ***** 2025-09-30 03:04:03.914136 | controller | skipping: [instance] 2025-09-30 03:04:03.914293 | controller | 2025-09-30 03:04:03.914455 | controller | TASK [cifmw_snr_nhc : Wait for active remediations to stop] ******************** 2025-09-30 03:04:03.914600 | controller | Tuesday 30 September 2025 03:04:03 +0000 (0:00:00.028) 0:00:03.734 ***** 2025-09-30 03:04:03.940858 | controller | skipping: [instance] 2025-09-30 03:04:03.941263 | controller | 2025-09-30 03:04:03.941461 | controller | TASK [cifmw_snr_nhc : Delete existing NodeHealthCheck resources] *************** 2025-09-30 03:04:03.941610 | controller | Tuesday 30 September 2025 03:04:03 +0000 (0:00:00.026) 0:00:03.761 ***** 2025-09-30 03:04:03.967771 | controller | skipping: [instance] 2025-09-30 03:04:03.967928 | controller | 2025-09-30 03:04:03.968100 | controller | TASK [cifmw_snr_nhc : Check for blocking remediations when deletion fails] ***** 2025-09-30 03:04:03.968268 | controller | Tuesday 30 September 2025 03:04:03 +0000 (0:00:00.026) 0:00:03.788 ***** 2025-09-30 03:04:03.994482 | controller | skipping: [instance] 2025-09-30 03:04:03.994636 | controller | 2025-09-30 03:04:03.994783 | controller | TASK [cifmw_snr_nhc : Display blocking remediation details] ******************** 2025-09-30 03:04:03.994935 | controller | Tuesday 30 September 2025 03:04:03 +0000 (0:00:00.026) 0:00:03.814 ***** 2025-09-30 03:04:04.021560 | controller | skipping: [instance] 2025-09-30 03:04:04.021752 | controller | 2025-09-30 03:04:04.021921 | controller | TASK [cifmw_snr_nhc : Display warning if NodeHealthCheck deletion failed due to active remediation] *** 2025-09-30 03:04:04.022088 | controller | Tuesday 30 September 2025 03:04:04 +0000 (0:00:00.027) 0:00:03.841 ***** 2025-09-30 03:04:04.049536 | controller | skipping: [instance] 2025-09-30 03:04:04.049711 | controller | 2025-09-30 03:04:04.049870 | controller | TASK [cifmw_snr_nhc : Skip NodeHealthCheck deletion retry if webhook blocks it] *** 2025-09-30 03:04:04.050016 | controller | Tuesday 30 September 2025 03:04:04 +0000 (0:00:00.027) 0:00:03.869 ***** 2025-09-30 03:04:04.076472 | controller | skipping: [instance] 2025-09-30 03:04:04.076629 | controller | 2025-09-30 03:04:04.076778 | controller | TASK [cifmw_snr_nhc : Check if SelfNodeRemediationConfig exists] *************** 2025-09-30 03:04:04.076932 | controller | Tuesday 30 September 2025 03:04:04 +0000 (0:00:00.027) 0:00:03.896 ***** 2025-09-30 03:04:04.106515 | controller | skipping: [instance] 2025-09-30 03:04:04.106723 | controller | 2025-09-30 03:04:04.106903 | controller | TASK [cifmw_snr_nhc : Delete existing SelfNodeRemediationConfig resources] ***** 2025-09-30 03:04:04.107081 | controller | Tuesday 30 September 2025 03:04:04 +0000 (0:00:00.029) 0:00:03.926 ***** 2025-09-30 03:04:04.133307 | controller | skipping: [instance] 2025-09-30 03:04:04.133499 | controller | 2025-09-30 03:04:04.133652 | controller | TASK [cifmw_snr_nhc : Check if SelfNodeRemediationTemplate exists] ************* 2025-09-30 03:04:04.133798 | controller | Tuesday 30 September 2025 03:04:04 +0000 (0:00:00.026) 0:00:03.953 ***** 2025-09-30 03:04:04.160498 | controller | skipping: [instance] 2025-09-30 03:04:04.160704 | controller | 2025-09-30 03:04:04.160884 | controller | TASK [cifmw_snr_nhc : Delete existing SelfNodeRemediationTemplate resources] *** 2025-09-30 03:04:04.161058 | controller | Tuesday 30 September 2025 03:04:04 +0000 (0:00:00.027) 0:00:03.980 ***** 2025-09-30 03:04:04.187053 | controller | skipping: [instance] 2025-09-30 03:04:04.187270 | controller | 2025-09-30 03:04:04.187447 | controller | TASK [cifmw_snr_nhc : Check if Subscriptions exist] **************************** 2025-09-30 03:04:04.187593 | controller | Tuesday 30 September 2025 03:04:04 +0000 (0:00:00.026) 0:00:04.007 ***** 2025-09-30 03:04:04.213865 | controller | skipping: [instance] 2025-09-30 03:04:04.214038 | controller | 2025-09-30 03:04:04.214223 | controller | TASK [cifmw_snr_nhc : Delete existing Subscriptions] *************************** 2025-09-30 03:04:04.214372 | controller | Tuesday 30 September 2025 03:04:04 +0000 (0:00:00.026) 0:00:04.034 ***** 2025-09-30 03:04:04.246217 | controller | skipping: [instance] => (item=self-node-remediation-operator) 2025-09-30 03:04:04.246431 | controller | skipping: [instance] => (item=node-health-check-operator) 2025-09-30 03:04:04.246580 | controller | skipping: [instance] 2025-09-30 03:04:04.246716 | controller | 2025-09-30 03:04:04.246857 | controller | TASK [cifmw_snr_nhc : Check if OperatorGroup exists] *************************** 2025-09-30 03:04:04.246994 | controller | Tuesday 30 September 2025 03:04:04 +0000 (0:00:00.032) 0:00:04.066 ***** 2025-09-30 03:04:04.275497 | controller | skipping: [instance] 2025-09-30 03:04:04.275711 | controller | 2025-09-30 03:04:04.275926 | controller | TASK [cifmw_snr_nhc : Delete existing OperatorGroup] *************************** 2025-09-30 03:04:04.276137 | controller | Tuesday 30 September 2025 03:04:04 +0000 (0:00:00.029) 0:00:04.095 ***** 2025-09-30 03:04:04.302538 | controller | skipping: [instance] 2025-09-30 03:04:04.302737 | controller | 2025-09-30 03:04:04.302917 | controller | TASK [cifmw_snr_nhc : Delete the entire workload-availability namespace] ******* 2025-09-30 03:04:04.303120 | controller | Tuesday 30 September 2025 03:04:04 +0000 (0:00:00.027) 0:00:04.122 ***** 2025-09-30 03:04:04.329582 | controller | skipping: [instance] 2025-09-30 03:04:04.329754 | controller | 2025-09-30 03:04:04.329906 | controller | TASK [cifmw_snr_nhc : Wait for namespace deletion to complete] ***************** 2025-09-30 03:04:04.330089 | controller | Tuesday 30 September 2025 03:04:04 +0000 (0:00:00.026) 0:00:04.149 ***** 2025-09-30 03:04:04.356452 | controller | skipping: [instance] 2025-09-30 03:04:04.356626 | controller | 2025-09-30 03:04:04.356787 | controller | TASK [cifmw_snr_nhc : Create the workload-availability namespace] ************** 2025-09-30 03:04:04.356931 | controller | Tuesday 30 September 2025 03:04:04 +0000 (0:00:00.026) 0:00:04.176 ***** 2025-09-30 03:04:05.638695 | controller | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: urllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host='api.test.example.com', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(': Failed to establish a new connection: [Errno -2] Name or service not known')) 2025-09-30 03:04:05.641256 | controller | fatal: [instance]: FAILED! => changed=false 2025-09-30 03:04:05.641306 | controller | module_stderr: |- 2025-09-30 03:04:05.641315 | controller | Traceback (most recent call last): 2025-09-30 03:04:05.641321 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn 2025-09-30 03:04:05.641327 | controller | conn = connection.create_connection( 2025-09-30 03:04:05.641333 | controller | File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection 2025-09-30 03:04:05.641338 | controller | for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM): 2025-09-30 03:04:05.641346 | controller | File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo 2025-09-30 03:04:05.641368 | controller | for res in _socket.getaddrinfo(host, port, family, type, proto, flags): 2025-09-30 03:04:05.642103 | controller | socket.gaierror: [Errno -2] Name or service not known 2025-09-30 03:04:05.643177 | controller | 2025-09-30 03:04:05.643210 | controller | During handling of the above exception, another exception occurred: 2025-09-30 03:04:05.643219 | controller | 2025-09-30 03:04:05.643225 | controller | Traceback (most recent call last): 2025-09-30 03:04:05.643231 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen 2025-09-30 03:04:05.643237 | controller | httplib_response = self._make_request( 2025-09-30 03:04:05.643253 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request 2025-09-30 03:04:05.643360 | controller | self._validate_conn(conn) 2025-09-30 03:04:05.643370 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn 2025-09-30 03:04:05.643376 | controller | conn.connect() 2025-09-30 03:04:05.643381 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect 2025-09-30 03:04:05.643387 | controller | conn = self._new_conn() 2025-09-30 03:04:05.643393 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn 2025-09-30 03:04:05.643409 | controller | raise NewConnectionError( 2025-09-30 03:04:05.643416 | controller | urllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known 2025-09-30 03:04:05.643421 | controller | 2025-09-30 03:04:05.643427 | controller | During handling of the above exception, another exception occurred: 2025-09-30 03:04:05.643432 | controller | 2025-09-30 03:04:05.643440 | controller | Traceback (most recent call last): 2025-09-30 03:04:05.643507 | controller | File "/tmp/ansible-tmp-1759201444.3697464-28235-174746284565627/AnsiballZ_k8s.py", line 107, in 2025-09-30 03:04:05.643625 | controller | _ansiballz_main() 2025-09-30 03:04:05.643750 | controller | File "/tmp/ansible-tmp-1759201444.3697464-28235-174746284565627/AnsiballZ_k8s.py", line 99, in _ansiballz_main 2025-09-30 03:04:05.643868 | controller | invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS) 2025-09-30 03:04:05.643985 | controller | File "/tmp/ansible-tmp-1759201444.3697464-28235-174746284565627/AnsiballZ_k8s.py", line 47, in invoke_module 2025-09-30 03:04:05.644134 | controller | runpy.run_module(mod_name='ansible_collections.kubernetes.core.plugins.modules.k8s', init_globals=dict(_module_fqn='ansible_collections.kubernetes.core.plugins.modules.k8s', _modlib_path=modlib_path), 2025-09-30 03:04:05.644261 | controller | File "/usr/lib64/python3.9/runpy.py", line 225, in run_module 2025-09-30 03:04:05.644378 | controller | return _run_module_code(code, init_globals, run_name, mod_spec) 2025-09-30 03:04:05.644509 | controller | File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code 2025-09-30 03:04:05.644623 | controller | _run_code(code, mod_globals, init_globals, 2025-09-30 03:04:05.644738 | controller | File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code 2025-09-30 03:04:05.644857 | controller | exec(code, run_globals) 2025-09-30 03:04:05.644982 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_lsoov336/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in 2025-09-30 03:04:05.645121 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_lsoov336/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main 2025-09-30 03:04:05.645246 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_lsoov336/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", line 88, in run_module 2025-09-30 03:04:05.645379 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_lsoov336/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client 2025-09-30 03:04:05.645516 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_lsoov336/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper 2025-09-30 03:04:05.645645 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_lsoov336/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client 2025-09-30 03:04:05.645779 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__ 2025-09-30 03:04:05.645900 | controller | self.__discoverer = discoverer(self, cache_file) 2025-09-30 03:04:05.646024 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_lsoov336/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__ 2025-09-30 03:04:05.646162 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_lsoov336/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__ 2025-09-30 03:04:05.646288 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_lsoov336/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache 2025-09-30 03:04:05.646426 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info 2025-09-30 03:04:05.646553 | controller | 'kubernetes': self.client.request('get', '/version', serializer=just_json) 2025-09-30 03:04:05.646674 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner 2025-09-30 03:04:05.646789 | controller | resp = func(self, *args, **kwargs) 2025-09-30 03:04:05.646907 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request 2025-09-30 03:04:05.647026 | controller | api_response = self.client.call_api( 2025-09-30 03:04:05.647171 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api 2025-09-30 03:04:05.647295 | controller | return self.__call_api(resource_path, method, 2025-09-30 03:04:05.647429 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api 2025-09-30 03:04:05.647546 | controller | response_data = self.request( 2025-09-30 03:04:05.647662 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request 2025-09-30 03:04:05.647776 | controller | return self.rest_client.GET(url, 2025-09-30 03:04:05.647896 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET 2025-09-30 03:04:05.648009 | controller | return self.request("GET", url, 2025-09-30 03:04:05.648143 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request 2025-09-30 03:04:05.648271 | controller | r = self.pool_manager.request(method, url, 2025-09-30 03:04:05.648388 | controller | File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request 2025-09-30 03:04:05.648513 | controller | return self.request_encode_url( 2025-09-30 03:04:05.648632 | controller | File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url 2025-09-30 03:04:05.648747 | controller | return self.urlopen(method, url, **extra_kw) 2025-09-30 03:04:05.648871 | controller | File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen 2025-09-30 03:04:05.648984 | controller | response = conn.urlopen(method, u.request_uri, **kw) 2025-09-30 03:04:05.649118 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen 2025-09-30 03:04:05.649238 | controller | return self.urlopen( 2025-09-30 03:04:05.649355 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen 2025-09-30 03:04:05.649495 | controller | return self.urlopen( 2025-09-30 03:04:05.649624 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen 2025-09-30 03:04:05.649740 | controller | return self.urlopen( 2025-09-30 03:04:05.649858 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen 2025-09-30 03:04:05.649970 | controller | retries = retries.increment( 2025-09-30 03:04:05.650107 | controller | File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment 2025-09-30 03:04:05.650231 | controller | raise MaxRetryError(_pool, url, error or ResponseError(cause)) 2025-09-30 03:04:05.650366 | controller | urllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host='api.test.example.com', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(': Failed to establish a new connection: [Errno -2] Name or service not known')) 2025-09-30 03:04:05.650512 | controller | module_stdout: '' 2025-09-30 03:04:05.650627 | controller | msg: |- 2025-09-30 03:04:05.650746 | controller | MODULE FAILURE 2025-09-30 03:04:05.650860 | controller | See stdout/stderr for the exact error 2025-09-30 03:04:05.650971 | controller | rc: 1 2025-09-30 03:04:05.651169 | controller | 2025-09-30 03:04:05.651290 | controller | TASK [Capture role execution error] ******************************************** 2025-09-30 03:04:05.651420 | controller | Tuesday 30 September 2025 03:04:05 +0000 (0:00:01.291) 0:00:05.468 ***** 2025-09-30 03:04:05.670840 | controller | ok: [instance] 2025-09-30 03:04:05.670994 | controller | 2025-09-30 03:04:05.671144 | controller | TASK [Display role execution error details] ************************************ 2025-09-30 03:04:05.671279 | controller | Tuesday 30 September 2025 03:04:05 +0000 (0:00:00.022) 0:00:05.491 ***** 2025-09-30 03:04:05.692729 | controller | ok: [instance] => 2025-09-30 03:04:05.692906 | controller | msg: |- 2025-09-30 03:04:05.693055 | controller | Role execution failed with error: 2025-09-30 03:04:05.693246 | controller | {'delegate_to': None, 'delegate_facts': None, 'notify': None, 'collections': [], 'tags': [], 'when': [], 'name': 'Create the workload-availability namespace', 'connection': 'ssh', 'port': None, 'remote_user': None, 'vars': {}, 'module_defaults': [], 'environment': [{}], 'no_log': False, 'run_once': None, 'ignore_errors': None, 'ignore_unreachable': None, 'check_mode': False, 'diff': False, 'any_errors_fatal': False, 'throttle': 0, 'timeout': 0, 'debugger': None, 'become': False, 'become_method': 'sudo', 'become_user': None, 'become_flags': None, 'become_exe': None, 'args': {'kubeconfig': '/tmp/kubeconfig', 'state': 'present', 'resource_definition': {'apiVersion': 'v1', 'kind': 'Namespace', 'metadata': {'name': 'workload-availability'}}}, 'action': 'kubernetes.core.k8s', 'async_val': 0, 'async': 0, 'changed_when': [], 'delay': 5, 'failed_when': [], 'loop': None, 'loop_control': {'loop_var': 'item', 'index_var': None, 'label': None, 'pause': 0.0, 'extended': None, 'extended_allitems': True, 'uuid': 'fa163e7e-e7e8-f134-5ed8-000000000166', 'finalized': True, 'squashed': False}, 'poll': 15, 'register': 'namespace_result', 'retries': 3, 'until': [], 'loop_with': None, 'uuid': 'fa163e7e-e7e8-f134-5ed8-00000000008f', 'finalized': True, 'squashed': True} 2025-09-30 03:04:05.693369 | controller | 2025-09-30 03:04:05.693505 | controller | TASK [Analyze specific error patterns] ***************************************** 2025-09-30 03:04:05.693617 | controller | Tuesday 30 September 2025 03:04:05 +0000 (0:00:00.021) 0:00:05.513 ***** 2025-09-30 03:04:05.728355 | controller | ok: [instance] => 2025-09-30 03:04:05.728527 | controller | msg: |- 2025-09-30 03:04:05.728673 | controller | Error analysis: 2025-09-30 03:04:05.728833 | controller | - Connection error: False 2025-09-30 03:04:05.728981 | controller | - Authentication error: False 2025-09-30 03:04:05.729139 | controller | - API error: False 2025-09-30 03:04:05.729260 | controller | - Timeout error: False 2025-09-30 03:04:05.729373 | controller | 2025-09-30 03:04:05.729516 | controller | TASK [Continue with test evaluation] ******************************************* 2025-09-30 03:04:05.729636 | controller | Tuesday 30 September 2025 03:04:05 +0000 (0:00:00.035) 0:00:05.548 ***** 2025-09-30 03:04:05.747932 | controller | ok: [instance] => 2025-09-30 03:04:05.748142 | controller | msg: Role failed as expected in test environment - this is normal 2025-09-30 03:04:05.748283 | controller | 2025-09-30 03:04:05.748416 | controller | TASK [Verify namespace exists] ************************************************* 2025-09-30 03:04:05.748559 | controller | Tuesday 30 September 2025 03:04:05 +0000 (0:00:00.019) 0:00:05.568 ***** 2025-09-30 03:04:07.151611 | controller | ok: [instance] 2025-09-30 03:04:07.168163 | controller | 2025-09-30 03:04:07.168199 | controller | TASK [Display namespace verification result] *********************************** 2025-09-30 03:04:07.168208 | controller | Tuesday 30 September 2025 03:04:07 +0000 (0:00:01.403) 0:00:06.971 ***** 2025-09-30 03:04:07.168218 | controller | ok: [instance] => 2025-09-30 03:04:07.168244 | controller | msg: 'Namespace verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n conn = connection.create_connection(\n File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n httplib_response = self._make_request(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n self._validate_conn(conn)\n File 2025-09-30 03:04:07.168252 | controller | "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n conn.connect()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n conn = self._new_conn()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n raise NewConnectionError(\nurllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/tmp/ansible-tmp-1759201445.761243-28410-70374496196666/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759201445.761243-28410-70374496196666/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759201445.761243-28410-70374496196666/AnsiballZ_k8s.py", 2025-09-30 03:04:07.168271 | controller | line 47, in invoke_module\n runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n return _run_module_code(code, init_globals, run_name, mod_spec)\n File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n _run_code(code, mod_globals, init_globals,\n File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n exec(code, run_globals)\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", 2025-09-30 03:04:07.169113 | controller | line 88, in run_module\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n self.__discoverer = discoverer(self, cache_file)\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-09-30 03:04:07.169127 | controller | line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n resp = func(self, *args, **kwargs)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n api_response = self.client.call_api(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n return self.__call_api(resource_path, method,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n response_data = self.request(\n File 2025-09-30 03:04:07.169133 | controller | "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n return self.rest_client.GET(url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n return self.request("GET", url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n r = self.pool_manager.request(method, url,\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n return self.request_encode_url(\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n return self.urlopen(method, url, **extra_kw)\n File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n response = conn.urlopen(method, u.request_uri, **kw)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", 2025-09-30 03:04:07.169148 | controller | line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen\n retries = retries.increment(\n File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\'': Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n conn = connection.create_connection(\n File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", 2025-09-30 03:04:07.169628 | controller | line 73, in create_connection\n for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n httplib_response = self._make_request(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n self._validate_conn(conn)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n conn.connect()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n conn = self._new_conn()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n raise 2025-09-30 03:04:07.169656 | controller | NewConnectionError(\nurllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/tmp/ansible-tmp-1759201445.761243-28410-70374496196666/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759201445.761243-28410-70374496196666/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759201445.761243-28410-70374496196666/AnsiballZ_k8s.py", line 47, in invoke_module\n runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n return 2025-09-30 03:04:07.169663 | controller | _run_module_code(code, init_globals, run_name, mod_spec)\n File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n _run_code(code, mod_globals, init_globals,\n File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n exec(code, run_globals)\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", line 88, in run_module\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, 2025-09-30 03:04:07.169683 | controller | in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n self.__discoverer = discoverer(self, cache_file)\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_a2irzsfw/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-09-30 03:04:07.173691 | controller | line 92, in __init_cache\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n resp = func(self, *args, **kwargs)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n api_response = self.client.call_api(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n return self.__call_api(resource_path, method,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n response_data = self.request(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n return self.rest_client.GET(url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", 2025-09-30 03:04:07.173711 | controller | line 244, in GET\n return self.request("GET", url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n r = self.pool_manager.request(method, url,\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n return self.request_encode_url(\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n return self.urlopen(method, url, **extra_kw)\n File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n response = conn.urlopen(method, u.request_uri, **kw)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", 2025-09-30 03:04:07.173726 | controller | line 756, in urlopen\n retries = retries.increment(\n File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\'': Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}' 2025-09-30 03:04:07.173743 | controller | 2025-09-30 03:04:08.389002 | controller | TASK [Test namespace creation idempotency] ************************************* 2025-09-30 03:04:08.389033 | controller | Tuesday 30 September 2025 03:04:07 +0000 (0:00:00.022) 0:00:06.993 ***** 2025-09-30 03:04:08.389045 | controller | ok: [instance] 2025-09-30 03:04:08.412389 | controller | 2025-09-30 03:04:08.412434 | controller | TASK [Assert expected behavior for namespace creation] ************************* 2025-09-30 03:04:08.412443 | controller | Tuesday 30 September 2025 03:04:08 +0000 (0:00:01.215) 0:00:08.208 ***** 2025-09-30 03:04:08.412454 | controller | ok: [instance] => changed=false 2025-09-30 03:04:09.712673 | controller | msg: Namespace creation task behaves consistently 2025-09-30 03:04:09.712702 | controller | 2025-09-30 03:04:09.712709 | controller | TASK [Verify OperatorGroup exists] ********************************************* 2025-09-30 03:04:09.712716 | controller | Tuesday 30 September 2025 03:04:08 +0000 (0:00:00.023) 0:00:08.232 ***** 2025-09-30 03:04:09.712725 | controller | ok: [instance] 2025-09-30 03:04:09.731145 | controller | 2025-09-30 03:04:09.731167 | controller | TASK [Display OperatorGroup verification result] ******************************* 2025-09-30 03:04:09.731175 | controller | Tuesday 30 September 2025 03:04:09 +0000 (0:00:01.300) 0:00:09.532 ***** 2025-09-30 03:04:09.731186 | controller | ok: [instance] => 2025-09-30 03:04:09.731193 | controller | msg: 'OperatorGroup verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n conn = connection.create_connection(\n File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n httplib_response = self._make_request(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n self._validate_conn(conn)\n File 2025-09-30 03:04:09.731200 | controller | "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n conn.connect()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n conn = self._new_conn()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n raise NewConnectionError(\nurllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/tmp/ansible-tmp-1759201448.4253204-28750-228100145233613/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759201448.4253204-28750-228100145233613/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759201448.4253204-28750-228100145233613/AnsiballZ_k8s.py", 2025-09-30 03:04:09.731206 | controller | line 47, in invoke_module\n runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n return _run_module_code(code, init_globals, run_name, mod_spec)\n File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n _run_code(code, mod_globals, init_globals,\n File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n exec(code, run_globals)\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", 2025-09-30 03:04:09.731225 | controller | line 88, in run_module\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n self.__discoverer = discoverer(self, cache_file)\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-09-30 03:04:09.731232 | controller | line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n resp = func(self, *args, **kwargs)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n api_response = self.client.call_api(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n return self.__call_api(resource_path, method,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n response_data = self.request(\n File 2025-09-30 03:04:09.731240 | controller | "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n return self.rest_client.GET(url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n return self.request("GET", url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n r = self.pool_manager.request(method, url,\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n return self.request_encode_url(\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n return self.urlopen(method, url, **extra_kw)\n File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n response = conn.urlopen(method, u.request_uri, **kw)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", 2025-09-30 03:04:09.731249 | controller | line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen\n retries = retries.increment(\n File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\'': Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n conn = connection.create_connection(\n File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", 2025-09-30 03:04:09.731258 | controller | line 73, in create_connection\n for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n httplib_response = self._make_request(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n self._validate_conn(conn)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n conn.connect()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n conn = self._new_conn()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n raise 2025-09-30 03:04:09.731263 | controller | NewConnectionError(\nurllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/tmp/ansible-tmp-1759201448.4253204-28750-228100145233613/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759201448.4253204-28750-228100145233613/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759201448.4253204-28750-228100145233613/AnsiballZ_k8s.py", line 47, in invoke_module\n runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n return 2025-09-30 03:04:09.731271 | controller | _run_module_code(code, init_globals, run_name, mod_spec)\n File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n _run_code(code, mod_globals, init_globals,\n File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n exec(code, run_globals)\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", line 88, in run_module\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, 2025-09-30 03:04:09.731282 | controller | in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n self.__discoverer = discoverer(self, cache_file)\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_i4u6xsv0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-09-30 03:04:09.731293 | controller | line 92, in __init_cache\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n resp = func(self, *args, **kwargs)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n api_response = self.client.call_api(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n return self.__call_api(resource_path, method,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n response_data = self.request(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n return self.rest_client.GET(url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", 2025-09-30 03:04:09.731320 | controller | line 244, in GET\n return self.request("GET", url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n r = self.pool_manager.request(method, url,\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n return self.request_encode_url(\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n return self.urlopen(method, url, **extra_kw)\n File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n response = conn.urlopen(method, u.request_uri, **kw)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", 2025-09-30 03:04:09.731400 | controller | line 756, in urlopen\n retries = retries.increment(\n File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\'': Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}' 2025-09-30 03:04:09.737106 | controller | 2025-09-30 03:04:10.797200 | controller | TASK [Test OperatorGroup creation idempotency] ********************************* 2025-09-30 03:04:10.797240 | controller | Tuesday 30 September 2025 03:04:09 +0000 (0:00:00.024) 0:00:09.557 ***** 2025-09-30 03:04:10.797252 | controller | ok: [instance] 2025-09-30 03:04:10.820948 | controller | 2025-09-30 03:04:10.820974 | controller | TASK [Assert expected behavior for OperatorGroup creation] ********************* 2025-09-30 03:04:10.820982 | controller | Tuesday 30 September 2025 03:04:10 +0000 (0:00:01.059) 0:00:10.617 ***** 2025-09-30 03:04:10.820992 | controller | ok: [instance] => changed=false 2025-09-30 03:04:12.066689 | controller | msg: OperatorGroup creation task behaves consistently 2025-09-30 03:04:12.066728 | controller | 2025-09-30 03:04:12.066736 | controller | TASK [Verify SNR Subscription exists] ****************************************** 2025-09-30 03:04:12.066742 | controller | Tuesday 30 September 2025 03:04:10 +0000 (0:00:00.023) 0:00:10.640 ***** 2025-09-30 03:04:12.066753 | controller | ok: [instance] 2025-09-30 03:04:12.066778 | controller | 2025-09-30 03:04:12.066787 | controller | TASK [Display SNR Subscription verification result] **************************** 2025-09-30 03:04:12.066821 | controller | Tuesday 30 September 2025 03:04:12 +0000 (0:00:01.245) 0:00:11.886 ***** 2025-09-30 03:04:12.083902 | controller | ok: [instance] => 2025-09-30 03:04:12.083935 | controller | msg: 'SNR Subscription verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n conn = connection.create_connection(\n File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n httplib_response = self._make_request(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n self._validate_conn(conn)\n File 2025-09-30 03:04:12.083944 | controller | "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n conn.connect()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n conn = self._new_conn()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n raise NewConnectionError(\nurllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/tmp/ansible-tmp-1759201450.8338-29091-64002729883752/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759201450.8338-29091-64002729883752/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759201450.8338-29091-64002729883752/AnsiballZ_k8s.py", 2025-09-30 03:04:12.083951 | controller | line 47, in invoke_module\n runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n return _run_module_code(code, init_globals, run_name, mod_spec)\n File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n _run_code(code, mod_globals, init_globals,\n File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n exec(code, run_globals)\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", 2025-09-30 03:04:12.083969 | controller | line 88, in run_module\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n self.__discoverer = discoverer(self, cache_file)\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-09-30 03:04:12.085158 | controller | line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n resp = func(self, *args, **kwargs)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n api_response = self.client.call_api(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n return self.__call_api(resource_path, method,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n response_data = self.request(\n File 2025-09-30 03:04:12.085196 | controller | "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n return self.rest_client.GET(url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n return self.request("GET", url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n r = self.pool_manager.request(method, url,\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n return self.request_encode_url(\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n return self.urlopen(method, url, **extra_kw)\n File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n response = conn.urlopen(method, u.request_uri, **kw)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", 2025-09-30 03:04:12.085205 | controller | line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen\n retries = retries.increment(\n File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\'': Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n conn = connection.create_connection(\n File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", 2025-09-30 03:04:12.085215 | controller | line 73, in create_connection\n for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n httplib_response = self._make_request(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n self._validate_conn(conn)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n conn.connect()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n conn = self._new_conn()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n raise 2025-09-30 03:04:12.085226 | controller | NewConnectionError(\nurllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/tmp/ansible-tmp-1759201450.8338-29091-64002729883752/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759201450.8338-29091-64002729883752/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759201450.8338-29091-64002729883752/AnsiballZ_k8s.py", line 47, in invoke_module\n runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n return 2025-09-30 03:04:12.085235 | controller | _run_module_code(code, init_globals, run_name, mod_spec)\n File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n _run_code(code, mod_globals, init_globals,\n File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n exec(code, run_globals)\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", line 88, in run_module\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, 2025-09-30 03:04:12.085241 | controller | in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n self.__discoverer = discoverer(self, cache_file)\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_ggy90zj9/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-09-30 03:04:12.085254 | controller | line 92, in __init_cache\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n resp = func(self, *args, **kwargs)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n api_response = self.client.call_api(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n return self.__call_api(resource_path, method,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n response_data = self.request(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n return self.rest_client.GET(url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", 2025-09-30 03:04:12.085263 | controller | line 244, in GET\n return self.request("GET", url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n r = self.pool_manager.request(method, url,\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n return self.request_encode_url(\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n return self.urlopen(method, url, **extra_kw)\n File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n response = conn.urlopen(method, u.request_uri, **kw)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", 2025-09-30 03:04:12.089553 | controller | line 756, in urlopen\n retries = retries.increment(\n File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\'': Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}' 2025-09-30 03:04:12.089572 | controller | 2025-09-30 03:04:12.089724 | controller | TASK [Test SNR Subscription creation idempotency] ****************************** 2025-09-30 03:04:12.089870 | controller | Tuesday 30 September 2025 03:04:12 +0000 (0:00:00.023) 0:00:11.910 ***** 2025-09-30 03:04:13.411452 | controller | ok: [instance] 2025-09-30 03:04:13.435099 | controller | 2025-09-30 03:04:13.435137 | controller | TASK [Assert expected behavior for SNR Subscription creation] ****************** 2025-09-30 03:04:13.435145 | controller | Tuesday 30 September 2025 03:04:13 +0000 (0:00:01.321) 0:00:13.231 ***** 2025-09-30 03:04:13.435156 | controller | ok: [instance] => changed=false 2025-09-30 03:04:14.850596 | controller | msg: SNR Subscription creation task behaves consistently 2025-09-30 03:04:14.850626 | controller | 2025-09-30 03:04:14.850634 | controller | TASK [Verify SNR deployment status] ******************************************** 2025-09-30 03:04:14.850640 | controller | Tuesday 30 September 2025 03:04:13 +0000 (0:00:00.023) 0:00:13.254 ***** 2025-09-30 03:04:14.850650 | controller | ok: [instance] 2025-09-30 03:04:14.869170 | controller | 2025-09-30 03:04:14.869204 | controller | TASK [Display SNR deployment verification result] ****************************** 2025-09-30 03:04:14.869213 | controller | Tuesday 30 September 2025 03:04:14 +0000 (0:00:01.415) 0:00:14.670 ***** 2025-09-30 03:04:14.869224 | controller | ok: [instance] => 2025-09-30 03:04:14.869237 | controller | msg: 'SNR deployment verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n conn = connection.create_connection(\n File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n httplib_response = self._make_request(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n self._validate_conn(conn)\n File 2025-09-30 03:04:14.869244 | controller | "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n conn.connect()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n conn = self._new_conn()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n raise NewConnectionError(\nurllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/tmp/ansible-tmp-1759201453.4488318-29428-220361554828821/AnsiballZ_k8s_info.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759201453.4488318-29428-220361554828821/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759201453.4488318-29428-220361554828821/AnsiballZ_k8s_info.py", 2025-09-30 03:04:14.869251 | controller | line 47, in invoke_module\n runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', _modlib_path=modlib_path),\n File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n return _run_module_code(code, init_globals, run_name, mod_spec)\n File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n _run_code(code, mod_globals, init_globals,\n File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n exec(code, run_globals)\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 229, in \n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 221, in main\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", 2025-09-30 03:04:14.869265 | controller | line 352, in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n self.__discoverer = discoverer(self, cache_file)\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 2025-09-30 03:04:14.869272 | controller | 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n resp = func(self, *args, **kwargs)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n api_response = self.client.call_api(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n return self.__call_api(resource_path, method,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n response_data = self.request(\n File 2025-09-30 03:04:14.869278 | controller | "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n return self.rest_client.GET(url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n return self.request("GET", url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n r = self.pool_manager.request(method, url,\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n return self.request_encode_url(\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n return self.urlopen(method, url, **extra_kw)\n File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n response = conn.urlopen(method, u.request_uri, **kw)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", 2025-09-30 03:04:14.869284 | controller | line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen\n retries = retries.increment(\n File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\'': Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n conn = connection.create_connection(\n File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", 2025-09-30 03:04:14.869297 | controller | line 73, in create_connection\n for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n httplib_response = self._make_request(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n self._validate_conn(conn)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n conn.connect()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n conn = self._new_conn()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n raise 2025-09-30 03:04:14.869303 | controller | NewConnectionError(\nurllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/tmp/ansible-tmp-1759201453.4488318-29428-220361554828821/AnsiballZ_k8s_info.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759201453.4488318-29428-220361554828821/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759201453.4488318-29428-220361554828821/AnsiballZ_k8s_info.py", line 47, in invoke_module\n runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', _modlib_path=modlib_path),\n File "/usr/lib64/python3.9/runpy.py", 2025-09-30 03:04:14.869308 | controller | line 225, in run_module\n return _run_module_code(code, init_globals, run_name, mod_spec)\n File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n _run_code(code, mod_globals, init_globals,\n File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n exec(code, run_globals)\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 229, in \n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 221, in main\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", 2025-09-30 03:04:14.869317 | controller | line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n self.__discoverer = discoverer(self, cache_file)\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_mv19ai90/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 2025-09-30 03:04:14.869327 | controller | 92, in __init_cache\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n resp = func(self, *args, **kwargs)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n api_response = self.client.call_api(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n return self.__call_api(resource_path, method,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n response_data = self.request(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n return self.rest_client.GET(url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", 2025-09-30 03:04:14.874929 | controller | line 244, in GET\n return self.request("GET", url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n r = self.pool_manager.request(method, url,\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n return self.request_encode_url(\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n return self.urlopen(method, url, **extra_kw)\n File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n response = conn.urlopen(method, u.request_uri, **kw)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", 2025-09-30 03:04:14.874972 | controller | line 756, in urlopen\n retries = retries.increment(\n File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\'': Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}' 2025-09-30 03:04:14.874988 | controller | 2025-09-30 03:04:14.894140 | controller | TASK [Test deployment verification behavior] *********************************** 2025-09-30 03:04:14.894172 | controller | Tuesday 30 September 2025 03:04:14 +0000 (0:00:00.024) 0:00:14.695 ***** 2025-09-30 03:04:14.894184 | controller | ok: [instance] => 2025-09-30 03:04:14.894269 | controller | msg: Testing deployment verification logic - expected to fail in mock environment 2025-09-30 03:04:14.894420 | controller | 2025-09-30 03:04:14.894603 | controller | TASK [Assert SNR deployment verification behaves as expected] ****************** 2025-09-30 03:04:14.894720 | controller | Tuesday 30 September 2025 03:04:14 +0000 (0:00:00.019) 0:00:14.714 ***** 2025-09-30 03:04:14.915876 | controller | ok: [instance] => changed=false 2025-09-30 03:04:14.916032 | controller | msg: SNR deployment verification logic behaves as expected 2025-09-30 03:04:14.916206 | controller | 2025-09-30 03:04:14.916359 | controller | TASK [Verify NHC Subscription exists] ****************************************** 2025-09-30 03:04:14.916542 | controller | Tuesday 30 September 2025 03:04:14 +0000 (0:00:00.021) 0:00:14.736 ***** 2025-09-30 03:04:16.115630 | controller | ok: [instance] 2025-09-30 03:04:16.132160 | controller | 2025-09-30 03:04:16.132184 | controller | TASK [Display NHC Subscription verification result] **************************** 2025-09-30 03:04:16.132192 | controller | Tuesday 30 September 2025 03:04:16 +0000 (0:00:01.199) 0:00:15.935 ***** 2025-09-30 03:04:16.132202 | controller | ok: [instance] => 2025-09-30 03:04:16.132227 | controller | msg: 'NHC Subscription verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n conn = connection.create_connection(\n File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n httplib_response = self._make_request(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n self._validate_conn(conn)\n File 2025-09-30 03:04:16.132235 | controller | "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n conn.connect()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n conn = self._new_conn()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n raise NewConnectionError(\nurllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/tmp/ansible-tmp-1759201454.9285421-29607-217267791991981/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759201454.9285421-29607-217267791991981/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759201454.9285421-29607-217267791991981/AnsiballZ_k8s.py", 2025-09-30 03:04:16.132241 | controller | line 47, in invoke_module\n runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n return _run_module_code(code, init_globals, run_name, mod_spec)\n File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n _run_code(code, mod_globals, init_globals,\n File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n exec(code, run_globals)\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", 2025-09-30 03:04:16.132250 | controller | line 88, in run_module\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n self.__discoverer = discoverer(self, cache_file)\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-09-30 03:04:16.133164 | controller | line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n resp = func(self, *args, **kwargs)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n api_response = self.client.call_api(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n return self.__call_api(resource_path, method,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n response_data = self.request(\n File 2025-09-30 03:04:16.133201 | controller | "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n return self.rest_client.GET(url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n return self.request("GET", url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n r = self.pool_manager.request(method, url,\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n return self.request_encode_url(\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n return self.urlopen(method, url, **extra_kw)\n File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n response = conn.urlopen(method, u.request_uri, **kw)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", 2025-09-30 03:04:16.133210 | controller | line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen\n retries = retries.increment(\n File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\'': Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n conn = connection.create_connection(\n File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", 2025-09-30 03:04:16.133216 | controller | line 73, in create_connection\n for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n httplib_response = self._make_request(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n self._validate_conn(conn)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n conn.connect()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n conn = self._new_conn()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n raise 2025-09-30 03:04:16.133232 | controller | NewConnectionError(\nurllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/tmp/ansible-tmp-1759201454.9285421-29607-217267791991981/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759201454.9285421-29607-217267791991981/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759201454.9285421-29607-217267791991981/AnsiballZ_k8s.py", line 47, in invoke_module\n runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n return 2025-09-30 03:04:16.133575 | controller | _run_module_code(code, init_globals, run_name, mod_spec)\n File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n _run_code(code, mod_globals, init_globals,\n File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n exec(code, run_globals)\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", line 88, in run_module\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, 2025-09-30 03:04:16.133592 | controller | in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n self.__discoverer = discoverer(self, cache_file)\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_z13h9p3k/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-09-30 03:04:16.133608 | controller | line 92, in __init_cache\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n resp = func(self, *args, **kwargs)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n api_response = self.client.call_api(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n return self.__call_api(resource_path, method,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n response_data = self.request(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n return self.rest_client.GET(url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", 2025-09-30 03:04:16.138505 | controller | line 244, in GET\n return self.request("GET", url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n r = self.pool_manager.request(method, url,\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n return self.request_encode_url(\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n return self.urlopen(method, url, **extra_kw)\n File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n response = conn.urlopen(method, u.request_uri, **kw)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", 2025-09-30 03:04:16.138522 | controller | line 756, in urlopen\n retries = retries.increment(\n File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\'': Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}' 2025-09-30 03:04:16.138532 | controller | 2025-09-30 03:04:17.326141 | controller | TASK [Test NHC Subscription creation idempotency] ****************************** 2025-09-30 03:04:17.326173 | controller | Tuesday 30 September 2025 03:04:16 +0000 (0:00:00.023) 0:00:15.958 ***** 2025-09-30 03:04:17.326185 | controller | ok: [instance] 2025-09-30 03:04:17.326599 | controller | 2025-09-30 03:04:17.349179 | controller | TASK [Assert expected behavior for NHC Subscription creation] ****************** 2025-09-30 03:04:17.349217 | controller | Tuesday 30 September 2025 03:04:17 +0000 (0:00:01.187) 0:00:17.146 ***** 2025-09-30 03:04:17.349233 | controller | ok: [instance] => changed=false 2025-09-30 03:04:18.477451 | controller | msg: NHC Subscription creation task behaves consistently 2025-09-30 03:04:18.477485 | controller | 2025-09-30 03:04:18.477503 | controller | TASK [Verify CSV status] ******************************************************* 2025-09-30 03:04:18.477509 | controller | Tuesday 30 September 2025 03:04:17 +0000 (0:00:00.022) 0:00:17.168 ***** 2025-09-30 03:04:18.477520 | controller | ok: [instance] 2025-09-30 03:04:18.493129 | controller | 2025-09-30 03:04:18.493151 | controller | TASK [Display CSV verification result] ***************************************** 2025-09-30 03:04:18.493159 | controller | Tuesday 30 September 2025 03:04:18 +0000 (0:00:01.128) 0:00:18.297 ***** 2025-09-30 03:04:18.493172 | controller | ok: [instance] => 2025-09-30 03:04:18.493179 | controller | msg: 'CSV verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n conn = connection.create_connection(\n File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n httplib_response = self._make_request(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n self._validate_conn(conn)\n File 2025-09-30 03:04:18.493186 | controller | "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n conn.connect()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n conn = self._new_conn()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n raise NewConnectionError(\nurllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/tmp/ansible-tmp-1759201457.3606927-29947-158498873840824/AnsiballZ_k8s_info.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759201457.3606927-29947-158498873840824/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759201457.3606927-29947-158498873840824/AnsiballZ_k8s_info.py", 2025-09-30 03:04:18.493192 | controller | line 47, in invoke_module\n runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', _modlib_path=modlib_path),\n File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n return _run_module_code(code, init_globals, run_name, mod_spec)\n File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n _run_code(code, mod_globals, init_globals,\n File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n exec(code, run_globals)\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 229, in \n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 221, in main\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", 2025-09-30 03:04:18.493206 | controller | line 352, in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n self.__discoverer = discoverer(self, cache_file)\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 2025-09-30 03:04:18.493233 | controller | 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n resp = func(self, *args, **kwargs)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n api_response = self.client.call_api(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n return self.__call_api(resource_path, method,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n response_data = self.request(\n File 2025-09-30 03:04:18.494366 | controller | "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n return self.rest_client.GET(url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n return self.request("GET", url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n r = self.pool_manager.request(method, url,\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n return self.request_encode_url(\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n return self.urlopen(method, url, **extra_kw)\n File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n response = conn.urlopen(method, u.request_uri, **kw)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", 2025-09-30 03:04:18.494389 | controller | line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen\n retries = retries.increment(\n File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\'': Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n conn = connection.create_connection(\n File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", 2025-09-30 03:04:18.494397 | controller | line 73, in create_connection\n for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n httplib_response = self._make_request(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n self._validate_conn(conn)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n conn.connect()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n conn = self._new_conn()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n raise 2025-09-30 03:04:18.494406 | controller | NewConnectionError(\nurllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/tmp/ansible-tmp-1759201457.3606927-29947-158498873840824/AnsiballZ_k8s_info.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759201457.3606927-29947-158498873840824/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759201457.3606927-29947-158498873840824/AnsiballZ_k8s_info.py", line 47, in invoke_module\n runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', _modlib_path=modlib_path),\n File "/usr/lib64/python3.9/runpy.py", 2025-09-30 03:04:18.494418 | controller | line 225, in run_module\n return _run_module_code(code, init_globals, run_name, mod_spec)\n File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n _run_code(code, mod_globals, init_globals,\n File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n exec(code, run_globals)\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 229, in \n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 221, in main\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", 2025-09-30 03:04:18.494424 | controller | line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n self.__discoverer = discoverer(self, cache_file)\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_1_zmda5u/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 2025-09-30 03:04:18.494430 | controller | 92, in __init_cache\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n resp = func(self, *args, **kwargs)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n api_response = self.client.call_api(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n return self.__call_api(resource_path, method,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n response_data = self.request(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n return self.rest_client.GET(url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", 2025-09-30 03:04:18.494442 | controller | line 244, in GET\n return self.request("GET", url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n r = self.pool_manager.request(method, url,\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n return self.request_encode_url(\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n return self.urlopen(method, url, **extra_kw)\n File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n response = conn.urlopen(method, u.request_uri, **kw)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", 2025-09-30 03:04:18.499139 | controller | line 756, in urlopen\n retries = retries.increment(\n File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\'': Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}' 2025-09-30 03:04:18.499161 | controller | 2025-09-30 03:04:18.516290 | controller | TASK [Test CSV verification behavior] ****************************************** 2025-09-30 03:04:18.516312 | controller | Tuesday 30 September 2025 03:04:18 +0000 (0:00:00.021) 0:00:18.319 ***** 2025-09-30 03:04:18.516325 | controller | ok: [instance] => 2025-09-30 03:04:18.535142 | controller | msg: Testing CSV verification logic - expected to fail in mock environment 2025-09-30 03:04:18.535164 | controller | 2025-09-30 03:04:18.535174 | controller | TASK [Assert CSV verification behaves as expected] ***************************** 2025-09-30 03:04:18.535181 | controller | Tuesday 30 September 2025 03:04:18 +0000 (0:00:00.016) 0:00:18.336 ***** 2025-09-30 03:04:18.535192 | controller | ok: [instance] => changed=false 2025-09-30 03:04:18.535375 | controller | msg: CSV verification logic behaves as expected 2025-09-30 03:04:18.535534 | controller | 2025-09-30 03:04:18.535681 | controller | TASK [Verify NHC CR exists] **************************************************** 2025-09-30 03:04:18.535824 | controller | Tuesday 30 September 2025 03:04:18 +0000 (0:00:00.019) 0:00:18.355 ***** 2025-09-30 03:04:19.808590 | controller | ok: [instance] 2025-09-30 03:04:19.825845 | controller | 2025-09-30 03:04:19.825878 | controller | TASK [Display NHC CR verification result] ************************************** 2025-09-30 03:04:19.825886 | controller | Tuesday 30 September 2025 03:04:19 +0000 (0:00:01.272) 0:00:19.628 ***** 2025-09-30 03:04:19.825897 | controller | ok: [instance] => 2025-09-30 03:04:19.825904 | controller | msg: 'NHC CR verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n conn = connection.create_connection(\n File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n httplib_response = self._make_request(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n self._validate_conn(conn)\n File 2025-09-30 03:04:19.825920 | controller | "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n conn.connect()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n conn = self._new_conn()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n raise NewConnectionError(\nurllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/tmp/ansible-tmp-1759201458.5463843-30122-225648417681048/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759201458.5463843-30122-225648417681048/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759201458.5463843-30122-225648417681048/AnsiballZ_k8s.py", 2025-09-30 03:04:19.825927 | controller | line 47, in invoke_module\n runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n return _run_module_code(code, init_globals, run_name, mod_spec)\n File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n _run_code(code, mod_globals, init_globals,\n File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n exec(code, run_globals)\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", 2025-09-30 03:04:19.825940 | controller | line 88, in run_module\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n self.__discoverer = discoverer(self, cache_file)\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-09-30 03:04:19.826144 | controller | line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n resp = func(self, *args, **kwargs)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n api_response = self.client.call_api(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n return self.__call_api(resource_path, method,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n response_data = self.request(\n File 2025-09-30 03:04:19.826178 | controller | "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n return self.rest_client.GET(url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n return self.request("GET", url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n r = self.pool_manager.request(method, url,\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n return self.request_encode_url(\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n return self.urlopen(method, url, **extra_kw)\n File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n response = conn.urlopen(method, u.request_uri, **kw)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", 2025-09-30 03:04:19.826187 | controller | line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen\n retries = retries.increment(\n File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\'': Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n conn = connection.create_connection(\n File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", 2025-09-30 03:04:19.826204 | controller | line 73, in create_connection\n for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n httplib_response = self._make_request(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n self._validate_conn(conn)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n conn.connect()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n conn = self._new_conn()\n File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n raise 2025-09-30 03:04:19.826873 | controller | NewConnectionError(\nurllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File "/tmp/ansible-tmp-1759201458.5463843-30122-225648417681048/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759201458.5463843-30122-225648417681048/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759201458.5463843-30122-225648417681048/AnsiballZ_k8s.py", line 47, in invoke_module\n runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n return 2025-09-30 03:04:19.826890 | controller | _run_module_code(code, init_globals, run_name, mod_spec)\n File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n _run_code(code, mod_globals, init_globals,\n File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n exec(code, run_globals)\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", line 88, in run_module\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, 2025-09-30 03:04:19.826902 | controller | in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n self.__discoverer = discoverer(self, cache_file)\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_dw793fn5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-09-30 03:04:19.826908 | controller | line 92, in __init_cache\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n resp = func(self, *args, **kwargs)\n File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n api_response = self.client.call_api(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n return self.__call_api(resource_path, method,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n response_data = self.request(\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n return self.rest_client.GET(url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", 2025-09-30 03:04:19.826920 | controller | line 244, in GET\n return self.request("GET", url,\n File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n r = self.pool_manager.request(method, url,\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n return self.request_encode_url(\n File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n return self.urlopen(method, url, **extra_kw)\n File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n response = conn.urlopen(method, u.request_uri, **kw)\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n return self.urlopen(\n File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", 2025-09-30 03:04:19.832093 | controller | line 756, in urlopen\n retries = retries.increment(\n File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\'': Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}' 2025-09-30 03:04:19.832121 | controller | 2025-09-30 03:04:19.832268 | controller | TASK [Test NHC CR creation idempotency] **************************************** 2025-09-30 03:04:19.832427 | controller | Tuesday 30 September 2025 03:04:19 +0000 (0:00:00.023) 0:00:19.652 ***** 2025-09-30 03:04:21.074965 | controller | ok: [instance] 2025-09-30 03:04:21.097793 | controller | 2025-09-30 03:04:21.097822 | controller | TASK [Assert expected behavior for NHC CR creation] **************************** 2025-09-30 03:04:21.097830 | controller | Tuesday 30 September 2025 03:04:21 +0000 (0:00:01.242) 0:00:20.894 ***** 2025-09-30 03:04:21.097840 | controller | ok: [instance] => changed=false 2025-09-30 03:04:21.149167 | controller | msg: NHC CR creation task behaves consistently 2025-09-30 03:04:21.149202 | controller | 2025-09-30 03:04:21.149210 | controller | TASK [Verify role structure and logic] ***************************************** 2025-09-30 03:04:21.149216 | controller | Tuesday 30 September 2025 03:04:21 +0000 (0:00:00.022) 0:00:20.917 ***** 2025-09-30 03:04:21.149227 | controller | ok: [instance] => 2025-09-30 03:04:21.149251 | controller | msg: Role execution and verification completed - errors are expected in test environment without real K8s cluster 2025-09-30 03:04:21.149257 | controller | 2025-09-30 03:04:21.149263 | controller | PLAY RECAP ********************************************************************* 2025-09-30 03:04:21.149268 | controller | instance : ok=41 changed=0 unreachable=0 failed=0 skipped=20 rescued=1 ignored=0 2025-09-30 03:04:21.149274 | controller | 2025-09-30 03:04:21.149279 | controller | Tuesday 30 September 2025 03:04:21 +0000 (0:00:00.050) 0:00:20.968 ***** 2025-09-30 03:04:21.149285 | controller | =============================================================================== 2025-09-30 03:04:21.149291 | controller | Test kubernetes.core.k8s module availability ---------------------------- 1.54s 2025-09-30 03:04:21.149297 | controller | Verify SNR deployment status -------------------------------------------- 1.42s 2025-09-30 03:04:21.149304 | controller | Verify namespace exists ------------------------------------------------- 1.40s 2025-09-30 03:04:21.149325 | controller | Test SNR Subscription creation idempotency ------------------------------ 1.32s 2025-09-30 03:04:21.150899 | controller | Verify OperatorGroup exists --------------------------------------------- 1.30s 2025-09-30 03:04:21.208435 | controller | cifmw_snr_nhc : Create the workload-availability namespace -------------- 1.29s 2025-09-30 03:04:21.208467 | controller | Verify NHC CR exists ---------------------------------------------------- 1.27s 2025-09-30 03:04:21.208475 | controller | Verify SNR Subscription exists ------------------------------------------ 1.25s 2025-09-30 03:04:21.208482 | controller | Test NHC CR creation idempotency ---------------------------------------- 1.24s 2025-09-30 03:04:21.208487 | controller | Test namespace creation idempotency ------------------------------------- 1.22s 2025-09-30 03:04:21.208492 | controller | Verify NHC Subscription exists ------------------------------------------ 1.20s 2025-09-30 03:04:21.208498 | controller | Test NHC Subscription creation idempotency ------------------------------ 1.19s 2025-09-30 03:04:21.208503 | controller | Test that Python kubernetes library is available ------------------------ 1.16s 2025-09-30 03:04:21.208509 | controller | Verify CSV status ------------------------------------------------------- 1.13s 2025-09-30 03:04:21.208536 | controller | Test OperatorGroup creation idempotency --------------------------------- 1.06s 2025-09-30 03:04:21.208542 | controller | Test that mock kubeconfig exists ---------------------------------------- 0.73s 2025-09-30 03:04:21.208547 | controller | Include the cifmw_snr_nhc role ------------------------------------------ 0.06s 2025-09-30 03:04:21.208552 | controller | Verify role structure and logic ----------------------------------------- 0.05s 2025-09-30 03:04:21.208557 | controller | Analyze specific error patterns ----------------------------------------- 0.04s 2025-09-30 03:04:21.208563 | controller | cifmw_snr_nhc : Delete existing Subscriptions --------------------------- 0.03s 2025-09-30 03:04:21.208573 | controller | INFO Running default > verify 2025-09-30 03:04:21.208923 | controller | INFO Running Ansible Verifier 2025-09-30 03:04:21.636735 | controller | 2025-09-30 03:04:21.636930 | controller | PLAY [Verify] ****************************************************************** 2025-09-30 03:04:21.637093 | controller | 2025-09-30 03:04:21.637256 | controller | TASK [Check if Python kubernetes library is installed] ************************* 2025-09-30 03:04:21.637408 | controller | Tuesday 30 September 2025 03:04:21 +0000 (0:00:00.019) 0:00:00.019 ***** 2025-09-30 03:04:22.850359 | controller | ok: [instance] 2025-09-30 03:04:22.850416 | controller | 2025-09-30 03:04:22.850428 | controller | TASK [Display kubernetes library version] ************************************** 2025-09-30 03:04:22.873158 | controller | Tuesday 30 September 2025 03:04:22 +0000 (0:00:01.213) 0:00:01.233 ***** 2025-09-30 03:04:22.873195 | controller | ok: [instance] => 2025-09-30 03:04:22.873227 | controller | msg: 'kubernetes library version: 34.1.0' 2025-09-30 03:04:22.873568 | controller | 2025-09-30 03:04:23.652675 | controller | TASK [Verify kubeconfig mock file exists] ************************************** 2025-09-30 03:04:23.652710 | controller | Tuesday 30 September 2025 03:04:22 +0000 (0:00:00.023) 0:00:01.256 ***** 2025-09-30 03:04:23.652722 | controller | ok: [instance] 2025-09-30 03:04:23.674164 | controller | 2025-09-30 03:04:23.674199 | controller | TASK [Assert kubeconfig mock file exists] ************************************** 2025-09-30 03:04:23.674208 | controller | Tuesday 30 September 2025 03:04:23 +0000 (0:00:00.779) 0:00:02.035 ***** 2025-09-30 03:04:23.674218 | controller | ok: [instance] => changed=false 2025-09-30 03:04:23.674225 | controller | msg: Mock kubeconfig file exists 2025-09-30 03:04:23.674231 | controller | 2025-09-30 03:04:23.674237 | controller | TASK [Verify kubeadmin password mock file exists] ****************************** 2025-09-30 03:04:23.674244 | controller | Tuesday 30 September 2025 03:04:23 +0000 (0:00:00.021) 0:00:02.057 ***** 2025-09-30 03:04:24.299515 | controller | ok: [instance] 2025-09-30 03:04:24.320418 | controller | 2025-09-30 03:04:24.320461 | controller | TASK [Assert kubeadmin password mock file exists] ****************************** 2025-09-30 03:04:24.320471 | controller | Tuesday 30 September 2025 03:04:24 +0000 (0:00:00.625) 0:00:02.682 ***** 2025-09-30 03:04:24.320481 | controller | ok: [instance] => changed=false 2025-09-30 03:04:25.042622 | controller | msg: Mock kubeadmin password file exists 2025-09-30 03:04:25.042659 | controller | 2025-09-30 03:04:25.042668 | controller | TASK [Test Python yaml library] ************************************************ 2025-09-30 03:04:25.042674 | controller | Tuesday 30 September 2025 03:04:24 +0000 (0:00:00.021) 0:00:02.703 ***** 2025-09-30 03:04:25.042684 | controller | ok: [instance] 2025-09-30 03:04:25.077222 | controller | 2025-09-30 03:04:25.077257 | controller | TASK [Display yaml test result] ************************************************ 2025-09-30 03:04:25.077266 | controller | Tuesday 30 September 2025 03:04:25 +0000 (0:00:00.721) 0:00:03.425 ***** 2025-09-30 03:04:25.077277 | controller | ok: [instance] => 2025-09-30 03:04:25.078170 | controller | msg: yaml library works 2025-09-30 03:04:25.078203 | controller | 2025-09-30 03:04:25.078212 | controller | PLAY RECAP ********************************************************************* 2025-09-30 03:04:25.078218 | controller | instance : ok=8 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2025-09-30 03:04:25.078224 | controller | 2025-09-30 03:04:25.078230 | controller | Tuesday 30 September 2025 03:04:25 +0000 (0:00:00.034) 0:00:03.460 ***** 2025-09-30 03:04:25.078240 | controller | =============================================================================== 2025-09-30 03:04:25.128186 | controller | Check if Python kubernetes library is installed ------------------------- 1.21s 2025-09-30 03:04:25.128221 | controller | Verify kubeconfig mock file exists -------------------------------------- 0.78s 2025-09-30 03:04:25.128229 | controller | Test Python yaml library ------------------------------------------------ 0.72s 2025-09-30 03:04:25.128235 | controller | Verify kubeadmin password mock file exists ------------------------------ 0.63s 2025-09-30 03:04:25.128245 | controller | Display yaml test result ------------------------------------------------ 0.03s 2025-09-30 03:04:25.128251 | controller | Display kubernetes library version -------------------------------------- 0.02s 2025-09-30 03:04:25.128257 | controller | Assert kubeconfig mock file exists -------------------------------------- 0.02s 2025-09-30 03:04:25.128262 | controller | Assert kubeadmin password mock file exists ------------------------------ 0.02s 2025-09-30 03:04:25.128273 | controller | INFO Verifier completed successfully. 2025-09-30 03:04:25.138289 | controller | INFO Running default > destroy 2025-09-30 03:04:25.570686 | controller | 2025-09-30 03:04:25.880816 | controller | PLAY [Destroy] ***************************************************************** 2025-09-30 03:04:25.880851 | controller | 2025-09-30 03:04:25.880859 | controller | TASK [Get passwd entries for USER env] ***************************************** 2025-09-30 03:04:25.880865 | controller | Tuesday 30 September 2025 03:04:25 +0000 (0:00:00.015) 0:00:00.015 ***** 2025-09-30 03:04:25.880875 | controller | ok: [localhost] 2025-09-30 03:04:25.924642 | controller | 2025-09-30 03:04:25.924673 | controller | TASK [Get shell async_dir] ***************************************************** 2025-09-30 03:04:25.924681 | controller | Tuesday 30 September 2025 03:04:25 +0000 (0:00:00.310) 0:00:00.325 ***** 2025-09-30 03:04:25.924692 | controller | ok: [localhost] 2025-09-30 03:04:25.959621 | controller | 2025-09-30 03:04:25.959652 | controller | TASK [Set async_dir for HOME env] ********************************************** 2025-09-30 03:04:25.959660 | controller | Tuesday 30 September 2025 03:04:25 +0000 (0:00:00.043) 0:00:00.369 ***** 2025-09-30 03:04:25.959669 | controller | skipping: [localhost] 2025-09-30 03:04:26.361143 | controller | 2025-09-30 03:04:26.361182 | controller | TASK [Destroy molecule instance(s)] ******************************************** 2025-09-30 03:04:26.361192 | controller | Tuesday 30 September 2025 03:04:25 +0000 (0:00:00.034) 0:00:00.404 ***** 2025-09-30 03:04:26.361206 | controller | changed: [localhost] => (item={'capabilities': ['SYS_ADMIN'], 'command': 'sleep infinity', 'image': 'registry.access.redhat.com/ubi9/ubi:latest', 'name': 'instance', 'pre_build_image': True, 'privileged': True, 'tmpfs': ['/run', '/tmp'], 'volumes': ['/sys/fs/cgroup:/sys/fs/cgroup:ro']}) 2025-09-30 03:04:26.361226 | controller | 2025-09-30 03:04:26.361425 | controller | TASK [Wait for instance(s) deletion to complete] ******************************* 2025-09-30 03:04:37.003111 | controller | Tuesday 30 September 2025 03:04:26 +0000 (0:00:00.401) 0:00:00.806 ***** 2025-09-30 03:04:37.003153 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) deletion to complete (300 retries left). 2025-09-30 03:04:37.055185 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) deletion to complete (299 retries left). 2025-09-30 03:04:37.055223 | controller | changed: [localhost] => (item={'failed': 0, 'started': 1, 'finished': 0, 'ansible_job_id': 'j972220687884.31191', 'results_file': '/home/zuul/.ansible_async/j972220687884.31191', 'changed': True, 'item': {'capabilities': ['SYS_ADMIN'], 'command': 'sleep infinity', 'image': 'registry.access.redhat.com/ubi9/ubi:latest', 'name': 'instance', 'pre_build_image': True, 'privileged': True, 'tmpfs': ['/run', '/tmp'], 'volumes': ['/sys/fs/cgroup:/sys/fs/cgroup:ro']}, 'ansible_loop_var': 'item'}) 2025-09-30 03:04:37.055235 | controller | 2025-09-30 03:04:37.055243 | controller | TASK [Delete podman network dedicated to this scenario] ************************ 2025-09-30 03:04:37.055250 | controller | Tuesday 30 September 2025 03:04:37 +0000 (0:00:10.641) 0:00:11.447 ***** 2025-09-30 03:04:37.055262 | controller | skipping: [localhost] => (item=instance: None specified) 2025-09-30 03:04:37.055291 | controller | skipping: [localhost] 2025-09-30 03:04:37.055300 | controller | 2025-09-30 03:04:37.055307 | controller | PLAY RECAP ********************************************************************* 2025-09-30 03:04:37.055314 | controller | localhost : ok=4 changed=2 unreachable=0 failed=0 skipped=2 rescued=0 ignored=0 2025-09-30 03:04:37.055323 | controller | 2025-09-30 03:04:37.056092 | controller | Tuesday 30 September 2025 03:04:37 +0000 (0:00:00.052) 0:00:11.500 ***** 2025-09-30 03:04:37.106935 | controller | =============================================================================== 2025-09-30 03:04:37.106967 | controller | Wait for instance(s) deletion to complete ------------------------------ 10.64s 2025-09-30 03:04:37.106975 | controller | Destroy molecule instance(s) -------------------------------------------- 0.40s 2025-09-30 03:04:37.106981 | controller | Get passwd entries for USER env ----------------------------------------- 0.31s 2025-09-30 03:04:37.106986 | controller | Delete podman network dedicated to this scenario ------------------------ 0.05s 2025-09-30 03:04:37.106992 | controller | Get shell async_dir ----------------------------------------------------- 0.04s 2025-09-30 03:04:37.106997 | controller | Set async_dir for HOME env ---------------------------------------------- 0.03s 2025-09-30 03:04:37.107007 | controller | INFO Pruning extra files from scenario ephemeral directory 2025-09-30 03:04:37.108941 | controller | INFO Writing /tmp/report.html report. 2025-09-30 03:04:37.378733 | controller | changed 2025-09-30 03:04:37.403710 | 2025-09-30 03:04:37.403794 | PLAY RECAP 2025-09-30 03:04:37.403838 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2025-09-30 03:04:37.403862 | 2025-09-30 03:04:37.478387 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main] 2025-09-30 03:04:37.479260 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-09-30 03:04:38.049391 | 2025-09-30 03:04:38.049504 | PLAY [Run ci/playbooks/collect-logs.yml] 2025-09-30 03:04:38.075775 | 2025-09-30 03:04:38.075899 | TASK [Filter out host if needed] 2025-09-30 03:04:38.084870 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-09-30 03:04:38.089607 | 2025-09-30 03:04:38.089680 | TASK [Ensure file is present] 2025-09-30 03:04:38.433657 | controller | ok 2025-09-30 03:04:38.445100 | 2025-09-30 03:04:38.445212 | TASK [Manage molecule report file] 2025-09-30 03:04:39.012351 | controller | changed 2025-09-30 03:04:39.018877 | 2025-09-30 03:04:39.018974 | TASK [Check if we get ci-framework-data basedir] 2025-09-30 03:04:39.245074 | controller | ok 2025-09-30 03:04:39.250369 | 2025-09-30 03:04:39.250446 | TASK [Create ci-framework-data log directory for zuul] 2025-09-30 03:04:39.598723 | controller | changed 2025-09-30 03:04:39.604854 | 2025-09-30 03:04:39.604984 | TASK [Copy ci-framework interesting files] 2025-09-30 03:04:39.821370 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2025-09-30 03:04:40.141360 | controller | changed 2025-09-30 03:04:40.146679 | 2025-09-30 03:04:40.146755 | TASK [Get SELinux listing] 2025-09-30 03:04:40.671944 | controller | changed 2025-09-30 03:04:40.678031 | 2025-09-30 03:04:40.678121 | TASK [Generate log index] 2025-09-30 03:04:41.372693 | controller | changed 2025-09-30 03:04:41.381358 | 2025-09-30 03:04:41.381497 | TASK [Get some env related data] 2025-09-30 03:04:41.963142 | controller | /home/zuul/.local/bin/ansible 2025-09-30 03:04:42.934326 | controller | changed 2025-09-30 03:04:42.940969 | 2025-09-30 03:04:42.941065 | TASK [Generate list of logs to collect in home directory] 2025-09-30 03:04:43.239306 | controller | ok: All paths examined 2025-09-30 03:04:43.245776 | 2025-09-30 03:04:43.245873 | LOOP [Copy logs from home directory] 2025-09-30 03:04:43.589498 | controller | changed: 2025-09-30 03:04:43.589846 | controller | { 2025-09-30 03:04:43.589885 | controller | "atime": 1759201371.8412266, 2025-09-30 03:04:43.589922 | controller | "ctime": 1759201393.39461, 2025-09-30 03:04:43.589948 | controller | "dev": 64513, 2025-09-30 03:04:43.589968 | controller | "gid": 1000, 2025-09-30 03:04:43.589984 | controller | "gr_name": "zuul", 2025-09-30 03:04:43.590006 | controller | "inode": 4331240, 2025-09-30 03:04:43.590022 | controller | "isblk": false, 2025-09-30 03:04:43.590036 | controller | "ischr": false, 2025-09-30 03:04:43.590050 | controller | "isdir": false, 2025-09-30 03:04:43.590064 | controller | "isfifo": false, 2025-09-30 03:04:43.590078 | controller | "isgid": false, 2025-09-30 03:04:43.590093 | controller | "islnk": false, 2025-09-30 03:04:43.590108 | controller | "isreg": true, 2025-09-30 03:04:43.590242 | controller | "issock": false, 2025-09-30 03:04:43.590265 | controller | "isuid": false, 2025-09-30 03:04:43.590282 | controller | "mode": "0644", 2025-09-30 03:04:43.590298 | controller | "mtime": 1759201393.39461, 2025-09-30 03:04:43.590313 | controller | "nlink": 1, 2025-09-30 03:04:43.590327 | controller | "path": "/home/zuul/ansible.log", 2025-09-30 03:04:43.590343 | controller | "pw_name": "zuul", 2025-09-30 03:04:43.590358 | controller | "rgrp": true, 2025-09-30 03:04:43.590374 | controller | "roth": true, 2025-09-30 03:04:43.590388 | controller | "rusr": true, 2025-09-30 03:04:43.590402 | controller | "size": 6749, 2025-09-30 03:04:43.590416 | controller | "uid": 1000, 2025-09-30 03:04:43.590430 | controller | "wgrp": false, 2025-09-30 03:04:43.590444 | controller | "woth": false, 2025-09-30 03:04:43.590460 | controller | "wusr": true, 2025-09-30 03:04:43.590475 | controller | "xgrp": false, 2025-09-30 03:04:43.590489 | controller | "xoth": false, 2025-09-30 03:04:43.590503 | controller | "xusr": false 2025-09-30 03:04:43.590516 | controller | } 2025-09-30 03:04:43.607474 | 2025-09-30 03:04:43.607560 | TASK [Copy crio stats log file] 2025-09-30 03:04:43.622353 | controller | skipping: Conditional result was False 2025-09-30 03:04:43.628337 | 2025-09-30 03:04:43.628411 | TASK [Get SELinux related data] 2025-09-30 03:04:43.843245 | controller | 2025-09-30 03:04:44.158192 | controller | ERROR 2025-09-30 03:04:44.158320 | controller | { 2025-09-30 03:04:44.158352 | controller | "delta": "0:00:00.009640", 2025-09-30 03:04:44.158373 | controller | "end": "2025-09-30 03:04:43.844198", 2025-09-30 03:04:44.158391 | controller | "msg": "non-zero return code", 2025-09-30 03:04:44.158407 | controller | "rc": 1, 2025-09-30 03:04:44.158422 | controller | "start": "2025-09-30 03:04:43.834558" 2025-09-30 03:04:44.158437 | controller | } 2025-09-30 03:04:44.158458 | controller | ERROR: Ignoring Errors 2025-09-30 03:04:44.163748 | 2025-09-30 03:04:44.163811 | TASK [Create system configuration directory] 2025-09-30 03:04:44.354855 | controller | changed 2025-09-30 03:04:44.359797 | 2025-09-30 03:04:44.359873 | TASK [Get some of the system configurations] 2025-09-30 03:04:44.887948 | controller | changed 2025-09-30 03:04:44.893511 | 2025-09-30 03:04:44.893605 | TASK [Copy generated documentation if available] 2025-09-30 03:04:44.907067 | controller | skipping: Conditional result was False 2025-09-30 03:04:44.913381 | 2025-09-30 03:04:44.913461 | TASK [Copy generated AsciiDoc documentation if available] 2025-09-30 03:04:44.927330 | controller | skipping: Conditional result was False 2025-09-30 03:04:44.933759 | 2025-09-30 03:04:44.933833 | TASK [Compress logs bigger than 2MB] 2025-09-30 03:04:45.459818 | controller | changed 2025-09-30 03:04:45.465718 | 2025-09-30 03:04:45.465813 | TASK [Copy files from workspace on node] 2025-09-30 03:04:45.484038 | controller | ok 2025-09-30 03:04:45.507634 | 2025-09-30 03:04:45.507746 | TASK [fetch-output : Set log path for multiple nodes] 2025-09-30 03:04:45.521311 | controller | skipping: Conditional result was False 2025-09-30 03:04:45.527395 | 2025-09-30 03:04:45.527471 | TASK [fetch-output : Set log path for single node] 2025-09-30 03:04:45.556419 | controller | ok 2025-09-30 03:04:45.562608 | 2025-09-30 03:04:45.562704 | LOOP [fetch-output : Ensure local output dirs] 2025-09-30 03:04:45.782591 | controller -> localhost | ok: "/var/lib/zuul/builds/6853beabfba3437086dd876554121898/work/logs" 2025-09-30 03:04:45.782811 | controller -> localhost | changed: All items complete 2025-09-30 03:04:45.782844 | 2025-09-30 03:04:45.972969 | controller -> localhost | changed: "/var/lib/zuul/builds/6853beabfba3437086dd876554121898/work/artifacts" 2025-09-30 03:04:46.184444 | controller -> localhost | changed: "/var/lib/zuul/builds/6853beabfba3437086dd876554121898/work/docs" 2025-09-30 03:04:46.195227 | 2025-09-30 03:04:46.195338 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-09-30 03:04:46.757377 | controller | changed: 2025-09-30 03:04:46.757580 | controller | .d..t...... ./ 2025-09-30 03:04:46.757612 | controller | >f+++++++++ README.html 2025-09-30 03:04:46.757636 | controller | >f+++++++++ ansible-execution.log 2025-09-30 03:04:46.757657 | controller | >f+++++++++ ansible.log 2025-09-30 03:04:46.757676 | controller | >f+++++++++ dmesg.log 2025-09-30 03:04:46.757694 | controller | >f+++++++++ installed-pkgs.log 2025-09-30 03:04:46.757715 | controller | >f+++++++++ python.log 2025-09-30 03:04:46.757736 | controller | >f+++++++++ registries.conf 2025-09-30 03:04:46.757755 | controller | >f+++++++++ report.html 2025-09-30 03:04:46.757775 | controller | >f+++++++++ selinux-denials.log 2025-09-30 03:04:46.757921 | controller | >f+++++++++ selinux-listing.log 2025-09-30 03:04:46.757958 | controller | cd+++++++++ ci-framework-data/ 2025-09-30 03:04:46.757981 | controller | cd+++++++++ ci-framework-data/artifacts/ 2025-09-30 03:04:46.758001 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2025-09-30 03:04:46.758020 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2025-09-30 03:04:46.758038 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2025-09-30 03:04:46.758056 | controller | cd+++++++++ ci-framework-data/logs/ 2025-09-30 03:04:46.758073 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log 2025-09-30 03:04:46.758091 | controller | cd+++++++++ registries.conf.d/ 2025-09-30 03:04:46.758108 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2025-09-30 03:04:46.758125 | controller | cd+++++++++ system-config/ 2025-09-30 03:04:46.758141 | controller | cd+++++++++ system-config/libvirt/ 2025-09-30 03:04:46.758158 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2025-09-30 03:04:46.758175 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2025-09-30 03:04:47.171007 | controller | changed: .d..t...... ./ 2025-09-30 03:04:47.562818 | controller | changed: .d..t...... ./ 2025-09-30 03:04:47.581442 | 2025-09-30 03:04:47.581546 | TASK [Return artifact to Zuul] 2025-09-30 03:04:47.615425 | controller | ok 2025-09-30 03:04:47.636902 | 2025-09-30 03:04:47.637039 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2025-09-30 03:04:47.637145 | 2025-09-30 03:04:47.637172 | PLAY RECAP 2025-09-30 03:04:47.637211 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1 2025-09-30 03:04:47.637232 | 2025-09-30 03:04:47.731773 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-09-30 03:04:47.732518 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-09-30 03:04:48.273127 | 2025-09-30 03:04:48.273228 | PLAY [all] 2025-09-30 03:04:48.291649 | 2025-09-30 03:04:48.291756 | TASK [include_role : fetch-output] 2025-09-30 03:04:48.319858 | controller | ok 2025-09-30 03:04:48.336659 | 2025-09-30 03:04:48.336742 | TASK [fetch-output : Set log path for multiple nodes] 2025-09-30 03:04:48.380096 | controller | skipping: Conditional result was False 2025-09-30 03:04:48.385545 | 2025-09-30 03:04:48.385627 | TASK [fetch-output : Set log path for single node] 2025-09-30 03:04:48.413369 | controller | ok 2025-09-30 03:04:48.418284 | 2025-09-30 03:04:48.418354 | LOOP [fetch-output : Ensure local output dirs] 2025-09-30 03:04:48.760033 | controller -> localhost | ok: "/var/lib/zuul/builds/6853beabfba3437086dd876554121898/work/logs" 2025-09-30 03:04:48.958858 | controller -> localhost | ok: "/var/lib/zuul/builds/6853beabfba3437086dd876554121898/work/artifacts" 2025-09-30 03:04:49.156719 | controller -> localhost | ok: "/var/lib/zuul/builds/6853beabfba3437086dd876554121898/work/docs" 2025-09-30 03:04:49.169155 | 2025-09-30 03:04:49.169252 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-09-30 03:04:49.734695 | controller | ok 2025-09-30 03:04:49.734885 | controller | ok: All items complete 2025-09-30 03:04:49.734934 | 2025-09-30 03:04:50.106774 | controller | ok 2025-09-30 03:04:50.513044 | controller | ok 2025-09-30 03:04:50.534021 | 2025-09-30 03:04:50.534113 | TASK [include_role : fetch-output-openshift] 2025-09-30 03:04:50.547509 | controller | skipping: Conditional result was False 2025-09-30 03:04:50.553171 | 2025-09-30 03:04:50.553245 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-09-30 03:04:50.913391 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007504 2025-09-30 03:04:51.132966 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007488 2025-09-30 03:04:51.164887 | 2025-09-30 03:04:51.165048 | PLAY [all] 2025-09-30 03:04:51.179020 | 2025-09-30 03:04:51.179103 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-30 03:04:51.593719 | controller | changed 2025-09-30 03:04:51.618027 | 2025-09-30 03:04:51.618102 | PLAY RECAP 2025-09-30 03:04:51.618152 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-09-30 03:04:51.618178 | 2025-09-30 03:04:51.697764 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-09-30 03:04:51.698539 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-09-30 03:04:52.319385 | 2025-09-30 03:04:52.319501 | PLAY [localhost] 2025-09-30 03:04:52.338468 | 2025-09-30 03:04:52.338582 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-30 03:04:52.715166 | localhost | changed 2025-09-30 03:04:52.743850 | 2025-09-30 03:04:52.744406 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-30 03:04:52.773207 | localhost | ok 2025-09-30 03:04:52.781895 | 2025-09-30 03:04:52.782014 | TASK [add-fileserver : Create SSH private key tempfile] 2025-09-30 03:04:53.111922 | localhost | changed 2025-09-30 03:04:53.117795 | 2025-09-30 03:04:53.117898 | TASK [add-fileserver : Create SSH private key from secret] 2025-09-30 03:04:53.755455 | localhost | changed 2025-09-30 03:04:53.760449 | 2025-09-30 03:04:53.760525 | TASK [add-fileserver : Add fileserver ssh key] 2025-09-30 03:04:54.105368 | localhost | Identity added: /var/lib/zuul/builds/6853beabfba3437086dd876554121898/work/tmp/ansible.y39xnsag (/var/lib/zuul/builds/6853beabfba3437086dd876554121898/work/tmp/ansible.y39xnsag) 2025-09-30 03:04:54.105558 | localhost | ok: Runtime: 0:00:00.007377 2025-09-30 03:04:54.110337 | 2025-09-30 03:04:54.110479 | TASK [add-fileserver : Remove SSH private key from disk] 2025-09-30 03:04:54.352772 | localhost | ok: Runtime: 0:00:00.004796 2025-09-30 03:04:54.357667 | 2025-09-30 03:04:54.357749 | TASK [add-fileserver : Add fileserver to inventory] 2025-09-30 03:04:54.407626 | localhost | changed 2025-09-30 03:04:54.411770 | 2025-09-30 03:04:54.411840 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-09-30 03:04:54.747746 | localhost | changed 2025-09-30 03:04:54.772841 | 2025-09-30 03:04:54.772962 | PLAY [localhost] 2025-09-30 03:04:54.786501 | 2025-09-30 03:04:54.786635 | TASK [Generate bulk log download script] 2025-09-30 03:04:54.807464 | localhost | ok 2025-09-30 03:04:54.822082 | 2025-09-30 03:04:54.822184 | TASK [local-log-download : Check API endpoint is defined] 2025-09-30 03:04:54.867984 | localhost | ok: All assertions passed 2025-09-30 03:04:54.872649 | 2025-09-30 03:04:54.872712 | TASK [local-log-download : Create download script] 2025-09-30 03:04:55.281392 | localhost -> localhost | changed 2025-09-30 03:04:55.291691 | 2025-09-30 03:04:55.291775 | TASK [Register quick-download link] 2025-09-30 03:04:55.330381 | localhost | ok 2025-09-30 03:04:55.395085 | 2025-09-30 03:04:55.395171 | PLAY [logserver.rdoproject.org] 2025-09-30 03:04:55.405385 | 2025-09-30 03:04:55.405466 | TASK [Set zuul-log-path fact] 2025-09-30 03:04:55.431586 | logserver.rdoproject.org | ok 2025-09-30 03:04:55.441644 | 2025-09-30 03:04:55.441750 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-30 03:04:55.468907 | logserver.rdoproject.org | ok 2025-09-30 03:04:55.475319 | 2025-09-30 03:04:55.475391 | TASK [upload-logs : Create log directories] 2025-09-30 03:04:57.407141 | logserver.rdoproject.org | changed 2025-09-30 03:04:57.410437 | 2025-09-30 03:04:57.410527 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-30 03:04:57.668826 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.014817 2025-09-30 03:04:57.673851 | 2025-09-30 03:04:57.673953 | TASK [upload-logs : Upload logs to log server] 2025-09-30 03:04:59.256963 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-09-30 03:04:59.261593 | 2025-09-30 03:04:59.261708 | LOOP [upload-logs : Compress console log and json output] 2025-09-30 03:04:59.309427 | logserver.rdoproject.org | skipping: Conditional result was False 2025-09-30 03:04:59.321011 | logserver.rdoproject.org | skipping: Conditional result was False 2025-09-30 03:04:59.330793 | 2025-09-30 03:04:59.330895 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-30 03:04:59.371763 | logserver.rdoproject.org | skipping: Conditional result was False 2025-09-30 03:04:59.372036 | 2025-09-30 03:04:59.375973 | logserver.rdoproject.org | skipping: Conditional result was False 2025-09-30 03:04:59.389309 | 2025-09-30 03:04:59.389393 | LOOP [upload-logs : Upload console log and json output]