2025-10-13 10:25:25.372487 | Job console starting... 2025-10-13 10:25:25.609515 | Updating repositories 2025-10-13 10:25:26.373453 | Preparing job workspace 2025-10-13 10:25:35.092290 | Running Ansible setup... 2025-10-13 10:25:38.695574 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-13 10:25:39.574212 | 2025-10-13 10:25:39.574360 | PLAY [localhost] 2025-10-13 10:25:39.602069 | 2025-10-13 10:25:39.602198 | TASK [Gathering Facts] 2025-10-13 10:25:41.186237 | localhost | ok 2025-10-13 10:25:41.204991 | 2025-10-13 10:25:41.205075 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-13 10:25:41.856825 | localhost -> localhost | changed 2025-10-13 10:25:41.862500 | 2025-10-13 10:25:41.862573 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-13 10:25:43.544178 | localhost -> localhost | changed 2025-10-13 10:25:43.552171 | 2025-10-13 10:25:43.552239 | TASK [Setup log path fact] 2025-10-13 10:25:43.601625 | localhost | ok 2025-10-13 10:25:43.618431 | 2025-10-13 10:25:43.618502 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-13 10:25:43.703358 | localhost | ok 2025-10-13 10:25:43.711765 | 2025-10-13 10:25:43.711833 | TASK [emit-job-header : Print job information] 2025-10-13 10:25:43.806957 | # Job Information 2025-10-13 10:25:43.807112 | Ansible Version: 2.15.12 2025-10-13 10:25:43.807143 | Job: cifmw-molecule-build_push_container 2025-10-13 10:25:43.807166 | Pipeline: github-check 2025-10-13 10:25:43.807187 | Executor: ibm-bm4-ze.softwarefactory-project.io 2025-10-13 10:25:43.807206 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3402 2025-10-13 10:25:43.807225 | Log URL (when completed): https://logserver.rdoproject.org/cbd/rdoproject.org/cbdd31099e1e422493fdf5a12ee21ac0/ 2025-10-13 10:25:43.807244 | Event ID: b851a8d0-a81e-11f0-8ce8-952b773708ea 2025-10-13 10:25:43.811047 | 2025-10-13 10:25:43.811115 | LOOP [emit-job-header : Print node information] 2025-10-13 10:25:44.220312 | localhost | ok: 2025-10-13 10:25:44.220460 | localhost | # Node Information 2025-10-13 10:25:44.220492 | localhost | Inventory Hostname: controller 2025-10-13 10:25:44.220517 | localhost | Hostname: np0005483527 2025-10-13 10:25:44.220540 | localhost | Username: zuul 2025-10-13 10:25:44.220562 | localhost | Distro: CentOS 9 2025-10-13 10:25:44.220582 | localhost | Provider: ibm-bm4-nodepool 2025-10-13 10:25:44.220601 | localhost | Region: regionOne 2025-10-13 10:25:44.220620 | localhost | Label: cloud-centos-9-stream-tripleo-ibm 2025-10-13 10:25:44.220637 | localhost | Product Name: OpenStack Compute 2025-10-13 10:25:44.220667 | localhost | Interface IP: 192.168.26.252 2025-10-13 10:25:44.285943 | 2025-10-13 10:25:44.286008 | PLAY [all] 2025-10-13 10:25:44.301007 | 2025-10-13 10:25:44.301072 | TASK [Gather network facts] 2025-10-13 10:25:44.767223 | controller | ok 2025-10-13 10:25:44.806240 | 2025-10-13 10:25:44.806315 | TASK [include_role : start-zuul-console] 2025-10-13 10:25:44.867328 | controller | ok 2025-10-13 10:25:44.908967 | 2025-10-13 10:25:44.909053 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-13 10:25:45.662741 | controller | ok 2025-10-13 10:25:45.691136 | 2025-10-13 10:25:45.691224 | TASK [include_role : add-build-sshkey] 2025-10-13 10:25:45.771245 | controller | ok 2025-10-13 10:25:45.802434 | 2025-10-13 10:25:45.802517 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-13 10:25:46.445130 | controller -> localhost | ok 2025-10-13 10:25:46.451207 | 2025-10-13 10:25:46.451274 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-13 10:25:46.529801 | controller | ok 2025-10-13 10:25:46.555085 | controller | included: /var/lib/zuul/builds/cbdd31099e1e422493fdf5a12ee21ac0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-13 10:25:46.573922 | 2025-10-13 10:25:46.574006 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-13 10:25:47.363783 | controller -> localhost | Generating public/private rsa key pair. 2025-10-13 10:25:47.364063 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/cbdd31099e1e422493fdf5a12ee21ac0/work/cbdd31099e1e422493fdf5a12ee21ac0_id_rsa. 2025-10-13 10:25:47.364103 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/cbdd31099e1e422493fdf5a12ee21ac0/work/cbdd31099e1e422493fdf5a12ee21ac0_id_rsa.pub. 2025-10-13 10:25:47.364130 | controller -> localhost | The key fingerprint is: 2025-10-13 10:25:47.364152 | controller -> localhost | SHA256:70NWJ8p8CeyGv3C0SY6C/qSIU+0GkmitQc9Vzl9pabc zuul-build-sshkey 2025-10-13 10:25:47.364171 | controller -> localhost | The key's randomart image is: 2025-10-13 10:25:47.364190 | controller -> localhost | +---[RSA 3072]----+ 2025-10-13 10:25:47.364209 | controller -> localhost | | | 2025-10-13 10:25:47.364228 | controller -> localhost | | . | 2025-10-13 10:25:47.364247 | controller -> localhost | | + . o | 2025-10-13 10:25:47.364265 | controller -> localhost | | . . o o*o.. | 2025-10-13 10:25:47.364283 | controller -> localhost | |o.+.. S=*+.+. | 2025-10-13 10:25:47.364300 | controller -> localhost | |+oo+.. .BOooE | 2025-10-13 10:25:47.364316 | controller -> localhost | |.ooo. o o=*. | 2025-10-13 10:25:47.364336 | controller -> localhost | |.o ooo . +o | 2025-10-13 10:25:47.364354 | controller -> localhost | |....o.. oo | 2025-10-13 10:25:47.364371 | controller -> localhost | +----[SHA256]-----+ 2025-10-13 10:25:47.364412 | controller -> localhost | ok: Runtime: 0:00:00.160698 2025-10-13 10:25:47.372269 | 2025-10-13 10:25:47.372335 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-13 10:25:47.408734 | controller | ok 2025-10-13 10:25:47.449408 | controller | included: /var/lib/zuul/builds/cbdd31099e1e422493fdf5a12ee21ac0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-13 10:25:47.489447 | 2025-10-13 10:25:47.489553 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-13 10:25:47.562317 | controller | skipping: Conditional result was False 2025-10-13 10:25:47.569447 | 2025-10-13 10:25:47.569526 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-13 10:25:48.467029 | controller | changed 2025-10-13 10:25:48.471548 | 2025-10-13 10:25:48.471607 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-13 10:25:48.802309 | controller | ok 2025-10-13 10:25:48.812233 | 2025-10-13 10:25:48.812301 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-13 10:25:49.701458 | controller | changed 2025-10-13 10:25:49.717972 | 2025-10-13 10:25:49.718041 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-13 10:25:50.478053 | controller | changed 2025-10-13 10:25:50.483056 | 2025-10-13 10:25:50.483121 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-13 10:25:50.576274 | controller | skipping: Conditional result was False 2025-10-13 10:25:50.583403 | 2025-10-13 10:25:50.583477 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-13 10:25:51.648528 | controller -> localhost | changed 2025-10-13 10:25:51.658066 | 2025-10-13 10:25:51.658130 | TASK [add-build-sshkey : Add back temp key] 2025-10-13 10:25:52.890508 | controller -> localhost | Identity added: /var/lib/zuul/builds/cbdd31099e1e422493fdf5a12ee21ac0/work/cbdd31099e1e422493fdf5a12ee21ac0_id_rsa (zuul-build-sshkey) 2025-10-13 10:25:52.890649 | controller -> localhost | ok: Runtime: 0:00:00.038463 2025-10-13 10:25:52.900589 | 2025-10-13 10:25:52.900663 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-13 10:25:53.363766 | controller | ok 2025-10-13 10:25:53.370303 | 2025-10-13 10:25:53.370370 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-13 10:25:53.445506 | controller | skipping: Conditional result was False 2025-10-13 10:25:53.455115 | 2025-10-13 10:25:53.455186 | TASK [include_role : validate-host] 2025-10-13 10:25:53.537921 | controller | ok 2025-10-13 10:25:53.575648 | 2025-10-13 10:25:53.575740 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-13 10:25:53.629885 | controller | ok 2025-10-13 10:25:53.634507 | 2025-10-13 10:25:53.634568 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-13 10:25:54.102960 | controller -> localhost | ok 2025-10-13 10:25:54.109074 | 2025-10-13 10:25:54.109140 | TASK [validate-host : Collect information about the host] 2025-10-13 10:25:54.815737 | controller | ok 2025-10-13 10:25:54.846587 | 2025-10-13 10:25:54.846692 | TASK [validate-host : Sanitize hostname] 2025-10-13 10:25:54.966619 | controller | ok 2025-10-13 10:25:54.971295 | 2025-10-13 10:25:54.971362 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-13 10:25:56.402213 | controller -> localhost | changed 2025-10-13 10:25:56.408292 | 2025-10-13 10:25:56.408363 | TASK [validate-host : Collect information about zuul worker] 2025-10-13 10:25:57.029001 | controller | ok 2025-10-13 10:25:57.041094 | 2025-10-13 10:25:57.041172 | TASK [validate-host : Write out all zuul information for each host] 2025-10-13 10:25:59.674330 | controller -> localhost | changed 2025-10-13 10:25:59.687237 | 2025-10-13 10:25:59.687300 | TASK [include_role : prepare-workspace-openshift] 2025-10-13 10:25:59.777949 | controller | skipping: Conditional result was False 2025-10-13 10:25:59.783386 | 2025-10-13 10:25:59.783470 | TASK [include_role : remove-zuul-sshkey] 2025-10-13 10:25:59.878692 | controller | skipping: Conditional result was False 2025-10-13 10:25:59.884456 | 2025-10-13 10:25:59.884524 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-10-13 10:26:00.194180 | controller | ok: "logs" 2025-10-13 10:26:00.194409 | controller | ok: All items complete 2025-10-13 10:26:00.194441 | 2025-10-13 10:26:00.369984 | controller | ok: "artifacts" 2025-10-13 10:26:00.543248 | controller | ok: "docs" 2025-10-13 10:26:00.559431 | 2025-10-13 10:26:00.559503 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-10-13 10:26:00.898194 | controller | changed: "logs" 2025-10-13 10:26:01.091094 | controller | changed: "artifacts" 2025-10-13 10:26:01.296443 | controller | changed: "docs" 2025-10-13 10:26:01.342992 | 2025-10-13 10:26:01.343083 | PLAY RECAP 2025-10-13 10:26:01.343130 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-13 10:26:01.343158 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-13 10:26:01.343178 | 2025-10-13 10:26:01.670798 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-13 10:26:01.671555 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-13 10:26:04.166781 | 2025-10-13 10:26:04.166883 | PLAY [all] 2025-10-13 10:26:04.215417 | 2025-10-13 10:26:04.215507 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-10-13 10:26:04.333692 | controller | ok 2025-10-13 10:26:04.340570 | 2025-10-13 10:26:04.340660 | TASK [mirror-info-fork : Create /etc/ci] 2025-10-13 10:26:05.076616 | controller | changed 2025-10-13 10:26:05.082325 | 2025-10-13 10:26:05.082398 | TASK [mirror-info-fork : Install ci_mirror script] 2025-10-13 10:26:06.666400 | controller | changed 2025-10-13 10:26:06.687555 | 2025-10-13 10:26:06.687652 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-10-13 10:26:07.530209 | controller | changed: 2025-10-13 10:26:07.530378 | controller | { 2025-10-13 10:26:07.530410 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-10-13 10:26:07.530447 | controller | } 2025-10-13 10:26:07.757221 | controller | changed: 2025-10-13 10:26:07.757305 | controller | { 2025-10-13 10:26:07.757335 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-10-13 10:26:07.757357 | controller | } 2025-10-13 10:26:08.014586 | controller | changed: 2025-10-13 10:26:08.014675 | controller | { 2025-10-13 10:26:08.014703 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com" 2025-10-13 10:26:08.014725 | controller | } 2025-10-13 10:26:08.257888 | controller | changed: 2025-10-13 10:26:08.258001 | controller | { 2025-10-13 10:26:08.258031 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-10-13 10:26:08.258053 | controller | } 2025-10-13 10:26:08.491667 | controller | changed: 2025-10-13 10:26:08.491746 | controller | { 2025-10-13 10:26:08.491772 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-10-13 10:26:08.491792 | controller | } 2025-10-13 10:26:08.721700 | controller | changed: 2025-10-13 10:26:08.721794 | controller | { 2025-10-13 10:26:08.721823 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-10-13 10:26:08.721852 | controller | } 2025-10-13 10:26:08.979560 | controller | changed: 2025-10-13 10:26:08.979660 | controller | { 2025-10-13 10:26:08.979690 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen" 2025-10-13 10:26:08.979713 | controller | } 2025-10-13 10:26:09.192257 | controller | changed: 2025-10-13 10:26:09.192353 | controller | { 2025-10-13 10:26:09.192382 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora" 2025-10-13 10:26:09.192404 | controller | } 2025-10-13 10:26:09.492358 | controller | changed: 2025-10-13 10:26:09.492434 | controller | { 2025-10-13 10:26:09.492459 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-10-13 10:26:09.492479 | controller | } 2025-10-13 10:26:09.652105 | controller | changed: 2025-10-13 10:26:09.652182 | controller | { 2025-10-13 10:26:09.652216 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-10-13 10:26:09.652238 | controller | } 2025-10-13 10:26:09.898180 | controller | changed: 2025-10-13 10:26:09.898268 | controller | { 2025-10-13 10:26:09.898296 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-10-13 10:26:09.898317 | controller | } 2025-10-13 10:26:10.145003 | controller | changed: 2025-10-13 10:26:10.145091 | controller | { 2025-10-13 10:26:10.145119 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-10-13 10:26:10.145143 | controller | } 2025-10-13 10:26:10.359363 | controller | changed: 2025-10-13 10:26:10.359470 | controller | { 2025-10-13 10:26:10.359499 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-10-13 10:26:10.359521 | controller | } 2025-10-13 10:26:10.600610 | controller | changed: 2025-10-13 10:26:10.600695 | controller | { 2025-10-13 10:26:10.600722 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-10-13 10:26:10.600742 | controller | } 2025-10-13 10:26:10.837652 | controller | changed: 2025-10-13 10:26:10.837745 | controller | { 2025-10-13 10:26:10.837772 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-10-13 10:26:10.837794 | controller | } 2025-10-13 10:26:11.075277 | controller | changed: 2025-10-13 10:26:11.075360 | controller | { 2025-10-13 10:26:11.075386 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-10-13 10:26:11.075406 | controller | } 2025-10-13 10:26:11.315022 | controller | changed: 2025-10-13 10:26:11.315177 | controller | { 2025-10-13 10:26:11.315215 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com" 2025-10-13 10:26:11.315240 | controller | } 2025-10-13 10:26:11.553598 | controller | changed: 2025-10-13 10:26:11.553688 | controller | { 2025-10-13 10:26:11.553716 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb" 2025-10-13 10:26:11.553743 | controller | } 2025-10-13 10:26:11.790545 | controller | changed: 2025-10-13 10:26:11.790617 | controller | { 2025-10-13 10:26:11.790655 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-10-13 10:26:11.790679 | controller | } 2025-10-13 10:26:12.051834 | controller | changed: 2025-10-13 10:26:12.051955 | controller | { 2025-10-13 10:26:12.051988 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-10-13 10:26:12.052012 | controller | } 2025-10-13 10:26:12.285675 | controller | changed: 2025-10-13 10:26:12.285760 | controller | { 2025-10-13 10:26:12.285786 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-10-13 10:26:12.285806 | controller | } 2025-10-13 10:26:12.514865 | controller | changed: 2025-10-13 10:26:12.514976 | controller | { 2025-10-13 10:26:12.515003 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-10-13 10:26:12.515024 | controller | } 2025-10-13 10:26:12.761066 | controller | changed: 2025-10-13 10:26:12.761158 | controller | { 2025-10-13 10:26:12.761185 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com" 2025-10-13 10:26:12.761207 | controller | } 2025-10-13 10:26:13.004145 | controller | changed: 2025-10-13 10:26:13.004225 | controller | { 2025-10-13 10:26:13.004252 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-10-13 10:26:13.004272 | controller | } 2025-10-13 10:26:13.235151 | controller | changed: 2025-10-13 10:26:13.235270 | controller | { 2025-10-13 10:26:13.235296 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-10-13 10:26:13.235317 | controller | } 2025-10-13 10:26:13.457753 | controller | changed: 2025-10-13 10:26:13.457829 | controller | { 2025-10-13 10:26:13.457854 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-10-13 10:26:13.457874 | controller | } 2025-10-13 10:26:13.500315 | 2025-10-13 10:26:13.500419 | TASK [Set timezone to UTC] 2025-10-13 10:26:14.459797 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2025-10-13 10:26:14.469499 | 2025-10-13 10:26:14.469569 | TASK [Create nodepool directory] 2025-10-13 10:26:14.748814 | controller | changed 2025-10-13 10:26:14.756115 | 2025-10-13 10:26:14.756185 | TASK [Create nodepool sub_nodes file] 2025-10-13 10:26:15.483092 | controller | changed 2025-10-13 10:26:15.493700 | 2025-10-13 10:26:15.493777 | TASK [Create nodepool sub_nodes_private file] 2025-10-13 10:26:16.234936 | controller | changed 2025-10-13 10:26:16.242322 | 2025-10-13 10:26:16.242411 | LOOP [Populate nodepool sub_nodes file] 2025-10-13 10:26:16.332840 | 2025-10-13 10:26:16.333019 | LOOP [Populate nodepool sub_nodes_private file] 2025-10-13 10:26:16.419158 | 2025-10-13 10:26:16.419317 | TASK [Create nodepool primary file] 2025-10-13 10:26:16.511473 | controller | skipping: Conditional result was False 2025-10-13 10:26:16.517144 | 2025-10-13 10:26:16.517219 | TASK [Create nodepool node_private for this node] 2025-10-13 10:26:17.278017 | controller | changed 2025-10-13 10:26:17.293670 | 2025-10-13 10:26:17.293736 | LOOP [Copy ssh keys to nodepool directory] 2025-10-13 10:26:17.978891 | controller | ok: Item: id_rsa Runtime: 0:00:00.006167 2025-10-13 10:26:17.979095 | 2025-10-13 10:26:18.165492 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.005019 2025-10-13 10:26:18.173563 | 2025-10-13 10:26:18.173700 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2025-10-13 10:26:18.843008 | controller | changed 2025-10-13 10:26:18.856707 | 2025-10-13 10:26:18.856776 | TASK [Validate sudoers config after edits] 2025-10-13 10:26:19.325857 | controller | /etc/sudoers: parsed OK 2025-10-13 10:26:19.325910 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2025-10-13 10:26:19.325919 | controller | /etc/sudoers.d/zuul: parsed OK 2025-10-13 10:26:19.325925 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-10-13 10:26:19.468210 | controller | ok: Runtime: 0:00:00.005473 2025-10-13 10:26:19.474038 | 2025-10-13 10:26:19.474101 | TASK [Show the environment passed in to job shell scripts] 2025-10-13 10:26:19.829111 | controller | SHELL=/bin/bash 2025-10-13 10:26:19.829225 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2025-10-13 10:26:19.829238 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework 2025-10-13 10:26:19.829244 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/02/3402/0297edf39f7cac3f4f79601bfef31d38861e4641 2025-10-13 10:26:19.829250 | controller | PWD=/home/zuul 2025-10-13 10:26:19.829256 | controller | ZUUL_PIPELINE=github-check 2025-10-13 10:26:19.829261 | controller | LOGNAME=zuul 2025-10-13 10:26:19.829267 | controller | XDG_SESSION_TYPE=tty 2025-10-13 10:26:19.829272 | controller | _=/usr/bin/env 2025-10-13 10:26:19.829277 | controller | MOTD_SHOWN=pam 2025-10-13 10:26:19.829283 | controller | HOME=/home/zuul 2025-10-13 10:26:19.829288 | controller | LANG=en_US.UTF-8 2025-10-13 10:26:19.829293 | controller | SSH_CONNECTION=192.168.26.12 60458 192.168.26.252 22 2025-10-13 10:26:19.829299 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET 2025-10-13 10:26:19.829307 | controller | ZUUL_CHANGE_IDS=3402,0297edf39f7cac3f4f79601bfef31d38861e4641 2025-10-13 10:26:19.829312 | controller | WORKSPACE=/home/zuul/workspace 2025-10-13 10:26:19.829318 | controller | XDG_SESSION_CLASS=user 2025-10-13 10:26:19.829323 | controller | SELINUX_ROLE_REQUESTED= 2025-10-13 10:26:19.829328 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-10-13 10:26:19.829334 | controller | USER=zuul 2025-10-13 10:26:19.829339 | controller | ZUUL_VOTING=True 2025-10-13 10:26:19.829344 | controller | BUILD_TIMEOUT=1800000 2025-10-13 10:26:19.829350 | controller | SELINUX_USE_CURRENT_RANGE= 2025-10-13 10:26:19.829355 | controller | SHLVL=1 2025-10-13 10:26:19.829360 | controller | ZUUL_PATCHSET=0297edf39f7cac3f4f79601bfef31d38861e4641 2025-10-13 10:26:19.829365 | controller | XDG_SESSION_ID=1 2025-10-13 10:26:19.829371 | controller | ZUUL_BRANCH=main 2025-10-13 10:26:19.829376 | controller | XDG_RUNTIME_DIR=/run/user/1000 2025-10-13 10:26:19.829381 | controller | SSH_CLIENT=192.168.26.12 60458 22 2025-10-13 10:26:19.829387 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2025-10-13 10:26:19.829392 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2025-10-13 10:26:19.829399 | controller | which_declare=declare -f 2025-10-13 10:26:19.829404 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-10-13 10:26:19.829410 | controller | SELINUX_LEVEL_REQUESTED= 2025-10-13 10:26:19.829415 | controller | ZUUL_CHANGE=3402 2025-10-13 10:26:19.829420 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-10-13 10:26:19.829426 | controller | ZUUL_UUID=cbdd31099e1e422493fdf5a12ee21ac0 2025-10-13 10:26:19.829431 | controller | BASH_FUNC_which%%=() { ( alias; 2025-10-13 10:26:19.829437 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-10-13 10:26:19.829442 | controller | } 2025-10-13 10:26:20.063980 | controller | ok: Runtime: 0:00:00.005862 2025-10-13 10:26:20.069416 | 2025-10-13 10:26:20.069478 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2025-10-13 10:26:20.113390 | controller | skipping: Conditional result was False 2025-10-13 10:26:20.119294 | 2025-10-13 10:26:20.119363 | TASK [Symlink /home/zuul-worker/workspace] 2025-10-13 10:26:20.686071 | controller | skipping: Conditional result was False 2025-10-13 10:26:20.794793 | 2025-10-13 10:26:20.795042 | TASK [Ensure legacy workspace directory] 2025-10-13 10:26:21.045161 | controller | changed 2025-10-13 10:26:21.110784 | 2025-10-13 10:26:21.110869 | PLAY RECAP 2025-10-13 10:26:21.110932 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-13 10:26:21.110963 | 2025-10-13 10:26:21.480463 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-13 10:26:21.481242 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-13 10:26:23.676782 | 2025-10-13 10:26:23.676891 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2025-10-13 10:26:23.797513 | 2025-10-13 10:26:23.797626 | TASK [Create zuul-output directory] 2025-10-13 10:26:24.806939 | controller | changed 2025-10-13 10:26:24.836593 | 2025-10-13 10:26:24.836704 | TASK [Slurp Zuul inventory test] 2025-10-13 10:26:25.690258 | controller -> localhost | ok 2025-10-13 10:26:25.696623 | 2025-10-13 10:26:25.696718 | TASK [Save zuul inventory] 2025-10-13 10:26:27.511801 | controller | changed 2025-10-13 10:26:27.524040 | 2025-10-13 10:26:27.524110 | TASK [Save zuul vars without the change_message] 2025-10-13 10:26:28.709844 | controller | changed 2025-10-13 10:26:28.799685 | 2025-10-13 10:26:28.799766 | PLAY RECAP 2025-10-13 10:26:28.799813 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-13 10:26:28.799837 | 2025-10-13 10:26:29.369447 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-13 10:26:29.370224 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2025-10-13 10:26:32.293252 | 2025-10-13 10:26:32.299031 | PLAY [Run ci/playbooks/molecule-prepare.yml] 2025-10-13 10:26:32.351705 | 2025-10-13 10:26:32.351788 | TASK [Read group_vars] 2025-10-13 10:26:32.396326 | controller | ok 2025-10-13 10:26:32.444632 | 2025-10-13 10:26:32.444742 | TASK [cifmw_helpers : Check directory is available] 2025-10-13 10:26:33.238828 | controller | ok 2025-10-13 10:26:33.262927 | 2025-10-13 10:26:33.263010 | TASK [cifmw_helpers : List available files] 2025-10-13 10:26:33.922065 | controller | skipping: Conditional result was False 2025-10-13 10:26:33.938093 | 2025-10-13 10:26:33.938183 | LOOP [cifmw_helpers : Read vars] 2025-10-13 10:26:33.985569 | 2025-10-13 10:26:33.985831 | LOOP [cifmw_helpers : Call task to parse all files as fact] 2025-10-13 10:26:34.067438 | 2025-10-13 10:26:34.067580 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh] 2025-10-13 10:26:34.120052 | controller | ok 2025-10-13 10:26:34.217850 | 2025-10-13 10:26:34.217971 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-10-13 10:26:34.288068 | controller | skipping: Conditional result was False 2025-10-13 10:26:34.293448 | 2025-10-13 10:26:34.293521 | TASK [mirror-info-fork : Create /etc/ci] 2025-10-13 10:26:34.770185 | controller | ok 2025-10-13 10:26:34.780411 | 2025-10-13 10:26:34.780485 | TASK [mirror-info-fork : Install ci_mirror script] 2025-10-13 10:26:35.667951 | controller | ok 2025-10-13 10:26:35.718782 | 2025-10-13 10:26:35.718889 | TASK [Prepare workspace] 2025-10-13 10:26:35.764266 | controller | ok 2025-10-13 10:26:35.839926 | 2025-10-13 10:26:35.840020 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-10-13 10:26:36.390784 | controller | ok 2025-10-13 10:26:36.402152 | 2025-10-13 10:26:36.402233 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-10-13 10:26:44.490126 | controller | Output suppressed because no_log was given 2025-10-13 10:26:44.522375 | 2025-10-13 10:26:44.522466 | LOOP [Create zuul-output directory] 2025-10-13 10:26:44.805192 | controller | changed: "/home/zuul/ci-framework-data/logs" 2025-10-13 10:26:44.805406 | 2025-10-13 10:26:45.009790 | controller | ok: "/home/zuul/zuul-output/logs" 2025-10-13 10:26:45.046941 | 2025-10-13 10:26:45.047032 | TASK [Install required packages] 2025-10-13 10:27:36.506881 | controller | changed 2025-10-13 10:27:36.515672 | 2025-10-13 10:27:36.515772 | TASK [Install venv] 2025-10-13 10:28:39.676925 | controller | changed 2025-10-13 10:28:39.707794 | 2025-10-13 10:28:39.707963 | PLAY RECAP 2025-10-13 10:28:39.708028 | controller | ok: 8 changed: 4 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-10-13 10:28:39.708058 | 2025-10-13 10:28:39.790706 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2025-10-13 10:28:39.791581 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main] 2025-10-13 10:28:40.319327 | 2025-10-13 10:28:40.319434 | PLAY [Run ci/playbooks/molecule-test.yml] 2025-10-13 10:28:40.339985 | 2025-10-13 10:28:40.340062 | TASK [Gather required facts] 2025-10-13 10:28:40.825616 | controller | ok 2025-10-13 10:28:40.831013 | 2025-10-13 10:28:40.831111 | TASK [Load environment var if instructed to] 2025-10-13 10:28:40.855129 | controller | skipping: Conditional result was False 2025-10-13 10:28:40.860376 | 2025-10-13 10:28:40.860446 | TASK [Ensure group_vars dir exists] 2025-10-13 10:28:41.181606 | controller | ok 2025-10-13 10:28:41.188563 | 2025-10-13 10:28:41.188646 | TASK [Run molecule] 2025-10-13 10:28:42.143745 | controller | INFO Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml 2025-10-13 10:28:42.227369 | controller | INFO Running default > converge 2025-10-13 10:28:42.902222 | controller | 2025-10-13 10:28:42.902280 | controller | PLAY [Converge] **************************************************************** 2025-10-13 10:28:42.902352 | controller | 2025-10-13 10:28:42.902838 | controller | TASK [Gathering Facts] ********************************************************* 2025-10-13 10:28:42.902953 | controller | Monday 13 October 2025 10:28:42 +0000 (0:00:00.010) 0:00:00.010 ******** 2025-10-13 10:28:43.769379 | controller | ok: [instance] 2025-10-13 10:28:43.769444 | controller | 2025-10-13 10:28:43.769483 | controller | TASK [Deploy Local Registry] *************************************************** 2025-10-13 10:28:43.769638 | controller | Monday 13 October 2025 10:28:43 +0000 (0:00:00.867) 0:00:00.877 ******** 2025-10-13 10:28:43.802347 | controller | 2025-10-13 10:28:43.802432 | controller | TASK [Install Podman package] ************************************************** 2025-10-13 10:28:43.802571 | controller | Monday 13 October 2025 10:28:43 +0000 (0:00:00.033) 0:00:00.911 ******** 2025-10-13 10:28:43.831561 | controller | 2025-10-13 10:28:43.831682 | controller | TASK [podman : Ensure podman is installed] ************************************* 2025-10-13 10:28:43.831810 | controller | Monday 13 October 2025 10:28:43 +0000 (0:00:00.029) 0:00:00.940 ******** 2025-10-13 10:28:44.752232 | controller | ok: [instance] 2025-10-13 10:28:44.752288 | controller | 2025-10-13 10:28:44.752409 | controller | TASK [podman : Enable loginctl linger for ansible_user_id] ********************* 2025-10-13 10:28:44.752512 | controller | Monday 13 October 2025 10:28:44 +0000 (0:00:00.920) 0:00:01.860 ******** 2025-10-13 10:28:45.105467 | controller | changed: [instance] 2025-10-13 10:28:45.105525 | controller | 2025-10-13 10:28:45.105648 | controller | TASK [podman : Ensure subordinate UID entry exists for zuul] ******************* 2025-10-13 10:28:45.105766 | controller | Monday 13 October 2025 10:28:45 +0000 (0:00:00.353) 0:00:02.214 ******** 2025-10-13 10:28:45.129787 | controller | skipping: [instance] 2025-10-13 10:28:45.129902 | controller | 2025-10-13 10:28:45.130019 | controller | TASK [podman : Ensure subordinate GID entry exists for zuul] ******************* 2025-10-13 10:28:45.130130 | controller | Monday 13 October 2025 10:28:45 +0000 (0:00:00.024) 0:00:02.238 ******** 2025-10-13 10:28:45.151345 | controller | skipping: [instance] 2025-10-13 10:28:45.151465 | controller | 2025-10-13 10:28:45.151590 | controller | TASK [podman : Run podman system migrate if subuid/subgid files were changed] *** 2025-10-13 10:28:45.151736 | controller | Monday 13 October 2025 10:28:45 +0000 (0:00:00.021) 0:00:02.260 ******** 2025-10-13 10:28:45.178265 | controller | skipping: [instance] 2025-10-13 10:28:45.178386 | controller | 2025-10-13 10:28:45.178511 | controller | TASK [registry_deploy : Deploy the local registry from docker.io/library/registry:2] *** 2025-10-13 10:28:45.178643 | controller | Monday 13 October 2025 10:28:45 +0000 (0:00:00.026) 0:00:02.287 ******** 2025-10-13 10:28:48.904759 | controller | changed: [instance] 2025-10-13 10:28:48.904839 | controller | 2025-10-13 10:28:48.904981 | controller | TASK [registry_deploy : Open port for local registry] ************************** 2025-10-13 10:28:48.905113 | controller | Monday 13 October 2025 10:28:48 +0000 (0:00:03.726) 0:00:06.013 ******** 2025-10-13 10:28:49.566198 | controller | changed: [instance] => (item=nft add table ip filter) 2025-10-13 10:28:49.566378 | controller | changed: [instance] => (item=nft add chain ip filter INPUT { type filter hook input priority 0 \; }) 2025-10-13 10:28:49.566410 | controller | changed: [instance] => (item=nft insert rule ip filter INPUT tcp dport 5001 counter accept) 2025-10-13 10:28:49.566552 | controller | 2025-10-13 10:28:49.566713 | controller | TASK [registry_deploy : Ensure registries.conf.d exists] *********************** 2025-10-13 10:28:49.566810 | controller | Monday 13 October 2025 10:28:49 +0000 (0:00:00.660) 0:00:06.674 ******** 2025-10-13 10:28:49.917889 | controller | ok: [instance] 2025-10-13 10:28:49.917953 | controller | 2025-10-13 10:28:49.918197 | controller | TASK [registry_deploy : Add the local registry to unqualified-search-registries] *** 2025-10-13 10:28:50.264754 | controller | Monday 13 October 2025 10:28:49 +0000 (0:00:00.352) 0:00:07.026 ******** 2025-10-13 10:28:50.264812 | controller | changed: [instance] 2025-10-13 10:28:50.303708 | controller | 2025-10-13 10:28:50.303743 | controller | TASK [Run cifmw_build_push_container multi-arch] ******************************* 2025-10-13 10:28:50.303753 | controller | Monday 13 October 2025 10:28:50 +0000 (0:00:00.346) 0:00:07.373 ******** 2025-10-13 10:28:50.303768 | controller | 2025-10-13 10:28:50.704900 | controller | TASK [build_push_container : Ensure directories are present] ******************* 2025-10-13 10:28:50.704937 | controller | Monday 13 October 2025 10:28:50 +0000 (0:00:00.039) 0:00:07.412 ******** 2025-10-13 10:28:50.704950 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/artifacts/build_push_container/scripts) 2025-10-13 10:28:51.484367 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/artifacts/build_push_container/logs) 2025-10-13 10:28:51.484407 | controller | 2025-10-13 10:28:51.484415 | controller | TASK [podman : Ensure podman is installed] ************************************* 2025-10-13 10:28:51.484422 | controller | Monday 13 October 2025 10:28:50 +0000 (0:00:00.400) 0:00:07.813 ******** 2025-10-13 10:28:51.484432 | controller | ok: [instance] 2025-10-13 10:28:51.735355 | controller | 2025-10-13 10:28:51.735387 | controller | TASK [podman : Enable loginctl linger for ansible_user_id] ********************* 2025-10-13 10:28:51.735395 | controller | Monday 13 October 2025 10:28:51 +0000 (0:00:00.779) 0:00:08.592 ******** 2025-10-13 10:28:51.735405 | controller | changed: [instance] 2025-10-13 10:28:51.763148 | controller | 2025-10-13 10:28:51.763176 | controller | TASK [podman : Ensure subordinate UID entry exists for zuul] ******************* 2025-10-13 10:28:51.763184 | controller | Monday 13 October 2025 10:28:51 +0000 (0:00:00.251) 0:00:08.843 ******** 2025-10-13 10:28:51.763194 | controller | skipping: [instance] 2025-10-13 10:28:51.787543 | controller | 2025-10-13 10:28:51.787571 | controller | TASK [podman : Ensure subordinate GID entry exists for zuul] ******************* 2025-10-13 10:28:51.787578 | controller | Monday 13 October 2025 10:28:51 +0000 (0:00:00.028) 0:00:08.871 ******** 2025-10-13 10:28:51.787588 | controller | skipping: [instance] 2025-10-13 10:28:51.819544 | controller | 2025-10-13 10:28:51.819566 | controller | TASK [podman : Run podman system migrate if subuid/subgid files were changed] *** 2025-10-13 10:28:51.819575 | controller | Monday 13 October 2025 10:28:51 +0000 (0:00:00.024) 0:00:08.896 ******** 2025-10-13 10:28:51.819586 | controller | skipping: [instance] 2025-10-13 10:29:00.075676 | controller | 2025-10-13 10:29:00.075720 | controller | TASK [build_push_container : Install qemu-user-static for multi arch builds] *** 2025-10-13 10:29:00.075734 | controller | Monday 13 October 2025 10:28:51 +0000 (0:00:00.031) 0:00:08.928 ******** 2025-10-13 10:29:00.075750 | controller | Follow script's output here: /home/zuul/ci-framework-data/artifacts/build_push_container/logs/ci_script_000_install_qemu_user_static_for.log 2025-10-13 10:29:00.360473 | controller | changed: [instance] 2025-10-13 10:29:00.360533 | controller | 2025-10-13 10:29:00.360542 | controller | TASK [build_push_container : Ensure manifest doesn't exist] ******************** 2025-10-13 10:29:00.360550 | controller | Monday 13 October 2025 10:29:00 +0000 (0:00:08.255) 0:00:17.183 ******** 2025-10-13 10:29:00.360565 | controller | ok: [instance] 2025-10-13 10:29:00.658932 | controller | 2025-10-13 10:29:00.658989 | controller | TASK [build_push_container : Create manifest] ********************************** 2025-10-13 10:29:00.658998 | controller | Monday 13 October 2025 10:29:00 +0000 (0:00:00.282) 0:00:17.465 ******** 2025-10-13 10:29:00.659013 | controller | changed: [instance] 2025-10-13 10:29:08.271420 | controller | 2025-10-13 10:29:08.271473 | controller | TASK [build_push_container : Build container] ********************************** 2025-10-13 10:29:08.271481 | controller | Monday 13 October 2025 10:29:00 +0000 (0:00:00.300) 0:00:17.766 ******** 2025-10-13 10:29:08.271493 | controller | Follow script's output here: /home/zuul/ci-framework-data/artifacts/build_push_container/logs/ci_script_001_build.log 2025-10-13 10:29:10.347859 | controller | changed: [instance] 2025-10-13 10:29:10.347903 | controller | 2025-10-13 10:29:10.347911 | controller | TASK [build_push_container : Push manifest] ************************************ 2025-10-13 10:29:10.347918 | controller | Monday 13 October 2025 10:29:08 +0000 (0:00:07.612) 0:00:25.379 ******** 2025-10-13 10:29:10.347930 | controller | Follow script's output here: /home/zuul/ci-framework-data/artifacts/build_push_container/logs/ci_script_002_push.log 2025-10-13 10:29:10.387276 | controller | changed: [instance] => (item=c4ee373c848aa16d1f0767117f61426f17f2a9f3) 2025-10-13 10:29:10.387309 | controller | Follow script's output here: /home/zuul/ci-framework-data/artifacts/build_push_container/logs/ci_script_003_push.log 2025-10-13 10:29:10.387317 | controller | changed: [instance] => (item=123-latest) 2025-10-13 10:29:10.387323 | controller | 2025-10-13 10:29:10.387329 | controller | TASK [build_push_container : Push container] *********************************** 2025-10-13 10:29:10.387335 | controller | Monday 13 October 2025 10:29:10 +0000 (0:00:02.076) 0:00:27.455 ******** 2025-10-13 10:29:10.387348 | controller | skipping: [instance] => (item=c4ee373c848aa16d1f0767117f61426f17f2a9f3) 2025-10-13 10:29:10.840371 | controller | skipping: [instance] => (item=123-latest) 2025-10-13 10:29:10.840417 | controller | skipping: [instance] 2025-10-13 10:29:10.840426 | controller | 2025-10-13 10:29:10.840433 | controller | TASK [Request tags from local registry] **************************************** 2025-10-13 10:29:10.840439 | controller | Monday 13 October 2025 10:29:10 +0000 (0:00:00.039) 0:00:27.495 ******** 2025-10-13 10:29:10.840463 | controller | ok: [instance] 2025-10-13 10:29:10.871730 | controller | 2025-10-13 10:29:10.871775 | controller | TASK [Check all tags exist] **************************************************** 2025-10-13 10:29:10.871785 | controller | Monday 13 October 2025 10:29:10 +0000 (0:00:00.453) 0:00:27.948 ******** 2025-10-13 10:29:10.871800 | controller | ok: [instance] => (item=c4ee373c848aa16d1f0767117f61426f17f2a9f3) => changed=false 2025-10-13 10:29:10.871831 | controller | ansible_loop_var: item 2025-10-13 10:29:10.871839 | controller | item: c4ee373c848aa16d1f0767117f61426f17f2a9f3 2025-10-13 10:29:10.871847 | controller | msg: All assertions passed 2025-10-13 10:29:10.871854 | controller | ok: [instance] => (item=123-latest) => changed=false 2025-10-13 10:29:10.871861 | controller | ansible_loop_var: item 2025-10-13 10:29:10.871869 | controller | item: 123-latest 2025-10-13 10:29:10.872152 | controller | msg: All assertions passed 2025-10-13 10:29:10.872182 | controller | 2025-10-13 10:29:11.211216 | controller | TASK [Request manifest from local registry] ************************************ 2025-10-13 10:29:11.211259 | controller | Monday 13 October 2025 10:29:10 +0000 (0:00:00.031) 0:00:27.980 ******** 2025-10-13 10:29:11.211273 | controller | ok: [instance] 2025-10-13 10:29:11.256585 | controller | 2025-10-13 10:29:11.256639 | controller | TASK [Check manifest for multi-arch image] ************************************* 2025-10-13 10:29:11.256648 | controller | Monday 13 October 2025 10:29:11 +0000 (0:00:00.338) 0:00:28.319 ******** 2025-10-13 10:29:11.256659 | controller | ok: [instance] => changed=false 2025-10-13 10:29:11.292490 | controller | msg: All assertions passed 2025-10-13 10:29:11.292512 | controller | 2025-10-13 10:29:11.292521 | controller | TASK [Run cifmw_build_push_container single-arch] ****************************** 2025-10-13 10:29:11.292528 | controller | Monday 13 October 2025 10:29:11 +0000 (0:00:00.046) 0:00:28.365 ******** 2025-10-13 10:29:11.292540 | controller | 2025-10-13 10:29:11.702288 | controller | TASK [build_push_container : Ensure directories are present] ******************* 2025-10-13 10:29:11.702330 | controller | Monday 13 October 2025 10:29:11 +0000 (0:00:00.036) 0:00:28.401 ******** 2025-10-13 10:29:11.702344 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/artifacts/build_push_container/scripts) 2025-10-13 10:29:12.399306 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/artifacts/build_push_container/logs) 2025-10-13 10:29:12.399358 | controller | 2025-10-13 10:29:12.399367 | controller | TASK [podman : Ensure podman is installed] ************************************* 2025-10-13 10:29:12.399374 | controller | Monday 13 October 2025 10:29:11 +0000 (0:00:00.409) 0:00:28.810 ******** 2025-10-13 10:29:12.399387 | controller | ok: [instance] 2025-10-13 10:29:12.634273 | controller | 2025-10-13 10:29:12.634314 | controller | TASK [podman : Enable loginctl linger for ansible_user_id] ********************* 2025-10-13 10:29:12.634322 | controller | Monday 13 October 2025 10:29:12 +0000 (0:00:00.696) 0:00:29.507 ******** 2025-10-13 10:29:12.634333 | controller | changed: [instance] 2025-10-13 10:29:12.659284 | controller | 2025-10-13 10:29:12.659328 | controller | TASK [podman : Ensure subordinate UID entry exists for zuul] ******************* 2025-10-13 10:29:12.659337 | controller | Monday 13 October 2025 10:29:12 +0000 (0:00:00.235) 0:00:29.742 ******** 2025-10-13 10:29:12.659363 | controller | skipping: [instance] 2025-10-13 10:29:12.681785 | controller | 2025-10-13 10:29:12.681830 | controller | TASK [podman : Ensure subordinate GID entry exists for zuul] ******************* 2025-10-13 10:29:12.681838 | controller | Monday 13 October 2025 10:29:12 +0000 (0:00:00.025) 0:00:29.767 ******** 2025-10-13 10:29:12.681850 | controller | skipping: [instance] 2025-10-13 10:29:12.707807 | controller | 2025-10-13 10:29:12.707891 | controller | TASK [podman : Run podman system migrate if subuid/subgid files were changed] *** 2025-10-13 10:29:12.707900 | controller | Monday 13 October 2025 10:29:12 +0000 (0:00:00.022) 0:00:29.790 ******** 2025-10-13 10:29:12.707917 | controller | skipping: [instance] 2025-10-13 10:29:12.731701 | controller | 2025-10-13 10:29:12.731735 | controller | TASK [build_push_container : Install qemu-user-static for multi arch builds] *** 2025-10-13 10:29:12.731743 | controller | Monday 13 October 2025 10:29:12 +0000 (0:00:00.025) 0:00:29.815 ******** 2025-10-13 10:29:12.731753 | controller | skipping: [instance] 2025-10-13 10:29:12.731874 | controller | 2025-10-13 10:29:12.731923 | controller | TASK [build_push_container : Ensure manifest doesn't exist] ******************** 2025-10-13 10:29:12.731939 | controller | Monday 13 October 2025 10:29:12 +0000 (0:00:00.024) 0:00:29.840 ******** 2025-10-13 10:29:12.755448 | controller | skipping: [instance] 2025-10-13 10:29:12.777916 | controller | 2025-10-13 10:29:12.777959 | controller | TASK [build_push_container : Create manifest] ********************************** 2025-10-13 10:29:12.777968 | controller | Monday 13 October 2025 10:29:12 +0000 (0:00:00.023) 0:00:29.863 ******** 2025-10-13 10:29:12.777981 | controller | skipping: [instance] 2025-10-13 10:29:13.995243 | controller | 2025-10-13 10:29:13.995295 | controller | TASK [build_push_container : Build container] ********************************** 2025-10-13 10:29:13.995304 | controller | Monday 13 October 2025 10:29:12 +0000 (0:00:00.022) 0:00:29.886 ******** 2025-10-13 10:29:13.995317 | controller | Follow script's output here: /home/zuul/ci-framework-data/artifacts/build_push_container/logs/ci_script_004_build.log 2025-10-13 10:29:14.035777 | controller | changed: [instance] 2025-10-13 10:29:14.035841 | controller | 2025-10-13 10:29:14.035852 | controller | TASK [build_push_container : Push manifest] ************************************ 2025-10-13 10:29:14.035860 | controller | Monday 13 October 2025 10:29:13 +0000 (0:00:01.216) 0:00:31.103 ******** 2025-10-13 10:29:14.035877 | controller | skipping: [instance] => (item=c4ee373c848aa16d1f0767117f61426f17f2a9f3) 2025-10-13 10:29:14.402209 | controller | skipping: [instance] => (item=123-latest) 2025-10-13 10:29:14.402260 | controller | skipping: [instance] 2025-10-13 10:29:14.402269 | controller | 2025-10-13 10:29:14.402276 | controller | TASK [build_push_container : Push container] *********************************** 2025-10-13 10:29:14.402282 | controller | Monday 13 October 2025 10:29:14 +0000 (0:00:00.040) 0:00:31.143 ******** 2025-10-13 10:29:14.402293 | controller | Follow script's output here: /home/zuul/ci-framework-data/artifacts/build_push_container/logs/ci_script_005_push.log 2025-10-13 10:29:14.746279 | controller | changed: [instance] => (item=c4ee373c848aa16d1f0767117f61426f17f2a9f3) 2025-10-13 10:29:14.746337 | controller | Follow script's output here: /home/zuul/ci-framework-data/artifacts/build_push_container/logs/ci_script_006_push.log 2025-10-13 10:29:14.746346 | controller | changed: [instance] => (item=123-latest) 2025-10-13 10:29:14.746357 | controller | 2025-10-13 10:29:14.746364 | controller | TASK [Request tags from local registry] **************************************** 2025-10-13 10:29:14.746370 | controller | Monday 13 October 2025 10:29:14 +0000 (0:00:00.366) 0:00:31.510 ******** 2025-10-13 10:29:14.746393 | controller | ok: [instance] 2025-10-13 10:29:14.782767 | controller | 2025-10-13 10:29:14.782824 | controller | TASK [Check all tags exist] **************************************************** 2025-10-13 10:29:14.782836 | controller | Monday 13 October 2025 10:29:14 +0000 (0:00:00.344) 0:00:31.854 ******** 2025-10-13 10:29:14.782851 | controller | ok: [instance] => (item=c4ee373c848aa16d1f0767117f61426f17f2a9f3) => changed=false 2025-10-13 10:29:14.782887 | controller | ansible_loop_var: item 2025-10-13 10:29:14.782897 | controller | item: c4ee373c848aa16d1f0767117f61426f17f2a9f3 2025-10-13 10:29:14.782904 | controller | msg: All assertions passed 2025-10-13 10:29:14.782925 | controller | ok: [instance] => (item=123-latest) => changed=false 2025-10-13 10:29:14.782932 | controller | ansible_loop_var: item 2025-10-13 10:29:14.782939 | controller | item: 123-latest 2025-10-13 10:29:14.782946 | controller | msg: All assertions passed 2025-10-13 10:29:14.782952 | controller | 2025-10-13 10:29:14.782963 | controller | TASK [Call cleanup] ************************************************************ 2025-10-13 10:29:14.810985 | controller | Monday 13 October 2025 10:29:14 +0000 (0:00:00.036) 0:00:31.890 ******** 2025-10-13 10:29:14.811049 | controller | 2025-10-13 10:29:15.279701 | controller | TASK [build_push_container : Stop and remove registry container] *************** 2025-10-13 10:29:15.279744 | controller | Monday 13 October 2025 10:29:14 +0000 (0:00:00.028) 0:00:31.919 ******** 2025-10-13 10:29:15.279758 | controller | changed: [instance] 2025-10-13 10:29:15.280004 | controller | 2025-10-13 10:29:15.280019 | controller | TASK [build_push_container : List images created and used by role] ************* 2025-10-13 10:29:15.525693 | controller | Monday 13 October 2025 10:29:15 +0000 (0:00:00.468) 0:00:32.388 ******** 2025-10-13 10:29:15.525753 | controller | changed: [instance] 2025-10-13 10:29:15.560721 | controller | 2025-10-13 10:29:15.560773 | controller | TASK [build_push_container : Remove images created and used by role] *********** 2025-10-13 10:29:15.560782 | controller | Monday 13 October 2025 10:29:15 +0000 (0:00:00.245) 0:00:32.633 ******** 2025-10-13 10:29:15.560796 | controller | skipping: [instance] 2025-10-13 10:29:15.560819 | controller | 2025-10-13 10:29:15.560825 | controller | PLAY RECAP ********************************************************************* 2025-10-13 10:29:15.560831 | controller | instance : ok=28 changed=16 unreachable=0 failed=0 skipped=15 rescued=0 ignored=0 2025-10-13 10:29:15.560837 | controller | 2025-10-13 10:29:15.560843 | controller | Monday 13 October 2025 10:29:15 +0000 (0:00:00.034) 0:00:32.668 ******** 2025-10-13 10:29:15.560855 | controller | =============================================================================== 2025-10-13 10:29:15.560862 | controller | build_push_container : Install qemu-user-static for multi arch builds --- 8.26s 2025-10-13 10:29:15.560867 | controller | build_push_container : Build container ---------------------------------- 7.61s 2025-10-13 10:29:15.560873 | controller | registry_deploy : Deploy the local registry from docker.io/library/registry:2 --- 3.73s 2025-10-13 10:29:15.560881 | controller | build_push_container : Push manifest ------------------------------------ 2.08s 2025-10-13 10:29:15.561650 | controller | build_push_container : Build container ---------------------------------- 1.22s 2025-10-13 10:29:15.561666 | controller | podman : Ensure podman is installed ------------------------------------- 0.92s 2025-10-13 10:29:15.562266 | controller | Gathering Facts --------------------------------------------------------- 0.87s 2025-10-13 10:29:15.562282 | controller | podman : Ensure podman is installed ------------------------------------- 0.78s 2025-10-13 10:29:15.562289 | controller | podman : Ensure podman is installed ------------------------------------- 0.70s 2025-10-13 10:29:15.562302 | controller | registry_deploy : Open port for local registry -------------------------- 0.66s 2025-10-13 10:29:15.562307 | controller | build_push_container : Stop and remove registry container --------------- 0.47s 2025-10-13 10:29:15.562313 | controller | Request tags from local registry ---------------------------------------- 0.45s 2025-10-13 10:29:15.562318 | controller | build_push_container : Ensure directories are present ------------------- 0.41s 2025-10-13 10:29:15.562323 | controller | build_push_container : Ensure directories are present ------------------- 0.40s 2025-10-13 10:29:15.562332 | controller | build_push_container : Push container ----------------------------------- 0.37s 2025-10-13 10:29:15.632817 | controller | podman : Enable loginctl linger for ansible_user_id --------------------- 0.35s 2025-10-13 10:29:15.632870 | controller | registry_deploy : Ensure registries.conf.d exists ----------------------- 0.35s 2025-10-13 10:29:15.632878 | controller | registry_deploy : Add the local registry to unqualified-search-registries --- 0.35s 2025-10-13 10:29:15.632884 | controller | Request tags from local registry ---------------------------------------- 0.34s 2025-10-13 10:29:15.632890 | controller | Request manifest from local registry ------------------------------------ 0.34s 2025-10-13 10:29:15.632912 | controller | INFO Writing /tmp/report.html report. 2025-10-13 10:29:15.754095 | controller | changed 2025-10-13 10:29:15.775701 | 2025-10-13 10:29:15.775774 | PLAY RECAP 2025-10-13 10:29:15.775817 | controller | ok: 3 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2025-10-13 10:29:15.775840 | 2025-10-13 10:29:15.869816 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main] 2025-10-13 10:29:15.870643 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-13 10:29:16.489981 | 2025-10-13 10:29:16.490083 | PLAY [Run ci/playbooks/collect-logs.yml] 2025-10-13 10:29:16.510726 | 2025-10-13 10:29:16.510801 | TASK [Filter out host if needed] 2025-10-13 10:29:16.519240 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-13 10:29:16.523716 | 2025-10-13 10:29:16.523784 | TASK [Ensure file is present] 2025-10-13 10:29:16.856268 | controller | ok 2025-10-13 10:29:16.863008 | 2025-10-13 10:29:16.863076 | TASK [Manage molecule report file] 2025-10-13 10:29:17.387739 | controller | changed 2025-10-13 10:29:17.393320 | 2025-10-13 10:29:17.393388 | TASK [Check if we get ci-framework-data basedir] 2025-10-13 10:29:17.594452 | controller | ok 2025-10-13 10:29:17.599471 | 2025-10-13 10:29:17.599536 | TASK [Create ci-framework-data log directory for zuul] 2025-10-13 10:29:17.922935 | controller | changed 2025-10-13 10:29:17.928381 | 2025-10-13 10:29:17.928447 | TASK [Copy ci-framework interesting files] 2025-10-13 10:29:18.151874 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2025-10-13 10:29:18.455805 | controller | changed 2025-10-13 10:29:18.461009 | 2025-10-13 10:29:18.461092 | TASK [Get SELinux listing] 2025-10-13 10:29:18.987885 | controller | changed 2025-10-13 10:29:18.995168 | 2025-10-13 10:29:18.995266 | TASK [Generate log index] 2025-10-13 10:29:19.734429 | controller | changed 2025-10-13 10:29:19.739482 | 2025-10-13 10:29:19.739573 | TASK [Get some env related data] 2025-10-13 10:29:20.323066 | controller | /home/zuul/.local/bin/ansible 2025-10-13 10:29:21.270608 | controller | changed 2025-10-13 10:29:21.276077 | 2025-10-13 10:29:21.276159 | TASK [Generate list of logs to collect in home directory] 2025-10-13 10:29:21.594349 | controller | ok: All paths examined 2025-10-13 10:29:21.599364 | 2025-10-13 10:29:21.599437 | LOOP [Copy logs from home directory] 2025-10-13 10:29:21.986435 | controller | changed: 2025-10-13 10:29:21.986552 | controller | { 2025-10-13 10:29:21.986582 | controller | "atime": 1760351300.6948926, 2025-10-13 10:29:21.986604 | controller | "ctime": 1760351319.25056, 2025-10-13 10:29:21.986650 | controller | "dev": 64513, 2025-10-13 10:29:21.986675 | controller | "gid": 1000, 2025-10-13 10:29:21.986695 | controller | "gr_name": "zuul", 2025-10-13 10:29:21.986715 | controller | "inode": 4488083, 2025-10-13 10:29:21.986733 | controller | "isblk": false, 2025-10-13 10:29:21.986749 | controller | "ischr": false, 2025-10-13 10:29:21.986766 | controller | "isdir": false, 2025-10-13 10:29:21.986783 | controller | "isfifo": false, 2025-10-13 10:29:21.986799 | controller | "isgid": false, 2025-10-13 10:29:21.986816 | controller | "islnk": false, 2025-10-13 10:29:21.986832 | controller | "isreg": true, 2025-10-13 10:29:21.987078 | controller | "issock": false, 2025-10-13 10:29:21.987098 | controller | "isuid": false, 2025-10-13 10:29:21.987115 | controller | "mode": "0644", 2025-10-13 10:29:21.987131 | controller | "mtime": 1760351319.25056, 2025-10-13 10:29:21.987147 | controller | "nlink": 1, 2025-10-13 10:29:21.987164 | controller | "path": "/home/zuul/ansible.log", 2025-10-13 10:29:21.987181 | controller | "pw_name": "zuul", 2025-10-13 10:29:21.987197 | controller | "rgrp": true, 2025-10-13 10:29:21.987213 | controller | "roth": true, 2025-10-13 10:29:21.987229 | controller | "rusr": true, 2025-10-13 10:29:21.987246 | controller | "size": 6749, 2025-10-13 10:29:21.987262 | controller | "uid": 1000, 2025-10-13 10:29:21.987278 | controller | "wgrp": false, 2025-10-13 10:29:21.987293 | controller | "woth": false, 2025-10-13 10:29:21.987312 | controller | "wusr": true, 2025-10-13 10:29:21.987329 | controller | "xgrp": false, 2025-10-13 10:29:21.987345 | controller | "xoth": false, 2025-10-13 10:29:21.987361 | controller | "xusr": false 2025-10-13 10:29:21.987377 | controller | } 2025-10-13 10:29:21.997528 | 2025-10-13 10:29:21.997652 | TASK [Copy crio stats log file] 2025-10-13 10:29:22.011599 | controller | skipping: Conditional result was False 2025-10-13 10:29:22.017355 | 2025-10-13 10:29:22.017421 | TASK [Get SELinux related data] 2025-10-13 10:29:22.254672 | controller | 2025-10-13 10:29:22.550403 | controller | ERROR 2025-10-13 10:29:22.550544 | controller | { 2025-10-13 10:29:22.550580 | controller | "delta": "0:00:00.011965", 2025-10-13 10:29:22.550606 | controller | "end": "2025-10-13 10:29:22.255871", 2025-10-13 10:29:22.550643 | controller | "msg": "non-zero return code", 2025-10-13 10:29:22.550667 | controller | "rc": 1, 2025-10-13 10:29:22.550687 | controller | "start": "2025-10-13 10:29:22.243906" 2025-10-13 10:29:22.550706 | controller | } 2025-10-13 10:29:22.550731 | controller | ERROR: Ignoring Errors 2025-10-13 10:29:22.556412 | 2025-10-13 10:29:22.556475 | TASK [Create system configuration directory] 2025-10-13 10:29:22.769574 | controller | changed 2025-10-13 10:29:22.774880 | 2025-10-13 10:29:22.774975 | TASK [Get some of the system configurations] 2025-10-13 10:29:23.309293 | controller | changed 2025-10-13 10:29:23.315438 | 2025-10-13 10:29:23.315515 | TASK [Copy generated documentation if available] 2025-10-13 10:29:23.338973 | controller | skipping: Conditional result was False 2025-10-13 10:29:23.345210 | 2025-10-13 10:29:23.345285 | TASK [Copy generated AsciiDoc documentation if available] 2025-10-13 10:29:23.359399 | controller | skipping: Conditional result was False 2025-10-13 10:29:23.366354 | 2025-10-13 10:29:23.366423 | TASK [Compress logs bigger than 2MB] 2025-10-13 10:29:23.893992 | controller | changed 2025-10-13 10:29:23.899927 | 2025-10-13 10:29:23.899999 | TASK [Copy files from workspace on node] 2025-10-13 10:29:23.918520 | controller | ok 2025-10-13 10:29:23.944335 | 2025-10-13 10:29:23.944448 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-13 10:29:23.958558 | controller | skipping: Conditional result was False 2025-10-13 10:29:23.965808 | 2025-10-13 10:29:23.965894 | TASK [fetch-output : Set log path for single node] 2025-10-13 10:29:23.996353 | controller | ok 2025-10-13 10:29:24.001678 | 2025-10-13 10:29:24.001749 | LOOP [fetch-output : Ensure local output dirs] 2025-10-13 10:29:24.215464 | controller -> localhost | ok: "/var/lib/zuul/builds/cbdd31099e1e422493fdf5a12ee21ac0/work/logs" 2025-10-13 10:29:24.215836 | controller -> localhost | changed: All items complete 2025-10-13 10:29:24.215885 | 2025-10-13 10:29:24.412016 | controller -> localhost | changed: "/var/lib/zuul/builds/cbdd31099e1e422493fdf5a12ee21ac0/work/artifacts" 2025-10-13 10:29:24.618175 | controller -> localhost | changed: "/var/lib/zuul/builds/cbdd31099e1e422493fdf5a12ee21ac0/work/docs" 2025-10-13 10:29:24.631982 | 2025-10-13 10:29:24.632090 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-13 10:29:25.217483 | controller | changed: 2025-10-13 10:29:25.217708 | controller | .d..t...... ./ 2025-10-13 10:29:25.217741 | controller | >f+++++++++ README.html 2025-10-13 10:29:25.217764 | controller | >f+++++++++ ansible-execution.log 2025-10-13 10:29:25.217784 | controller | >f+++++++++ ansible.log 2025-10-13 10:29:25.217802 | controller | >f+++++++++ dmesg.log 2025-10-13 10:29:25.217819 | controller | >f+++++++++ installed-pkgs.log 2025-10-13 10:29:25.217839 | controller | >f+++++++++ python.log 2025-10-13 10:29:25.217858 | controller | >f+++++++++ registries.conf 2025-10-13 10:29:25.217876 | controller | >f+++++++++ report.html 2025-10-13 10:29:25.217896 | controller | >f+++++++++ selinux-denials.log 2025-10-13 10:29:25.217938 | controller | >f+++++++++ selinux-listing.log 2025-10-13 10:29:25.217960 | controller | cd+++++++++ ci-framework-data/ 2025-10-13 10:29:25.217978 | controller | cd+++++++++ ci-framework-data/artifacts/ 2025-10-13 10:29:25.217996 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2025-10-13 10:29:25.218014 | controller | cd+++++++++ ci-framework-data/artifacts/build_push_container/ 2025-10-13 10:29:25.218031 | controller | cd+++++++++ ci-framework-data/artifacts/build_push_container/logs/ 2025-10-13 10:29:25.218047 | controller | >f+++++++++ ci-framework-data/artifacts/build_push_container/logs/ci_script_000_install_qemu_user_static_for.log 2025-10-13 10:29:25.218063 | controller | >f+++++++++ ci-framework-data/artifacts/build_push_container/logs/ci_script_001_build.log 2025-10-13 10:29:25.218079 | controller | >f+++++++++ ci-framework-data/artifacts/build_push_container/logs/ci_script_002_push.log 2025-10-13 10:29:25.218094 | controller | >f+++++++++ ci-framework-data/artifacts/build_push_container/logs/ci_script_003_push.log 2025-10-13 10:29:25.218109 | controller | >f+++++++++ ci-framework-data/artifacts/build_push_container/logs/ci_script_004_build.log 2025-10-13 10:29:25.218123 | controller | >f+++++++++ ci-framework-data/artifacts/build_push_container/logs/ci_script_005_push.log 2025-10-13 10:29:25.218138 | controller | >f+++++++++ ci-framework-data/artifacts/build_push_container/logs/ci_script_006_push.log 2025-10-13 10:29:25.218153 | controller | cd+++++++++ ci-framework-data/artifacts/build_push_container/scripts/ 2025-10-13 10:29:25.218168 | controller | >f+++++++++ ci-framework-data/artifacts/build_push_container/scripts/ci_script_000_install_qemu_user_static_for.sh 2025-10-13 10:29:25.218183 | controller | >f+++++++++ ci-framework-data/artifacts/build_push_container/scripts/ci_script_001_build.sh 2025-10-13 10:29:25.218207 | controller | >f+++++++++ ci-framework-data/artifacts/build_push_container/scripts/ci_script_002_push.sh 2025-10-13 10:29:25.218221 | controller | >f+++++++++ ci-framework-data/artifacts/build_push_container/scripts/ci_script_003_push.sh 2025-10-13 10:29:25.218236 | controller | >f+++++++++ ci-framework-data/artifacts/build_push_container/scripts/ci_script_004_build.sh 2025-10-13 10:29:25.218250 | controller | >f+++++++++ ci-framework-data/artifacts/build_push_container/scripts/ci_script_005_push.sh 2025-10-13 10:29:25.218263 | controller | >f+++++++++ ci-framework-data/artifacts/build_push_container/scripts/ci_script_006_push.sh 2025-10-13 10:29:25.218277 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2025-10-13 10:29:25.218292 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2025-10-13 10:29:25.218313 | controller | cd+++++++++ ci-framework-data/logs/ 2025-10-13 10:29:25.218330 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log 2025-10-13 10:29:25.218347 | controller | cd+++++++++ registries.conf.d/ 2025-10-13 10:29:25.218363 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2025-10-13 10:29:25.218378 | controller | >f+++++++++ registries.conf.d/99-local-registry.conf 2025-10-13 10:29:25.218393 | controller | cd+++++++++ system-config/ 2025-10-13 10:29:25.218408 | controller | cd+++++++++ system-config/libvirt/ 2025-10-13 10:29:25.218423 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2025-10-13 10:29:25.218437 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2025-10-13 10:29:25.633892 | controller | changed: .d..t...... ./ 2025-10-13 10:29:26.006036 | controller | changed: .d..t...... ./ 2025-10-13 10:29:26.026216 | 2025-10-13 10:29:26.026301 | TASK [Return artifact to Zuul] 2025-10-13 10:29:26.055351 | controller | ok 2025-10-13 10:29:26.074363 | 2025-10-13 10:29:26.074419 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2025-10-13 10:29:26.074514 | 2025-10-13 10:29:26.074540 | PLAY RECAP 2025-10-13 10:29:26.074577 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1 2025-10-13 10:29:26.074597 | 2025-10-13 10:29:26.149871 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-13 10:29:26.150644 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-13 10:29:26.669707 | 2025-10-13 10:29:26.669814 | PLAY [all] 2025-10-13 10:29:26.688265 | 2025-10-13 10:29:26.688344 | TASK [include_role : fetch-output] 2025-10-13 10:29:26.716831 | controller | ok 2025-10-13 10:29:26.733939 | 2025-10-13 10:29:26.734025 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-13 10:29:26.777565 | controller | skipping: Conditional result was False 2025-10-13 10:29:26.782973 | 2025-10-13 10:29:26.783046 | TASK [fetch-output : Set log path for single node] 2025-10-13 10:29:26.811257 | controller | ok 2025-10-13 10:29:26.816128 | 2025-10-13 10:29:26.816199 | LOOP [fetch-output : Ensure local output dirs] 2025-10-13 10:29:27.155450 | controller -> localhost | ok: "/var/lib/zuul/builds/cbdd31099e1e422493fdf5a12ee21ac0/work/logs" 2025-10-13 10:29:27.376444 | controller -> localhost | ok: "/var/lib/zuul/builds/cbdd31099e1e422493fdf5a12ee21ac0/work/artifacts" 2025-10-13 10:29:27.572362 | controller -> localhost | ok: "/var/lib/zuul/builds/cbdd31099e1e422493fdf5a12ee21ac0/work/docs" 2025-10-13 10:29:27.587284 | 2025-10-13 10:29:27.587460 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-13 10:29:28.136114 | controller | ok 2025-10-13 10:29:28.136305 | controller | ok: All items complete 2025-10-13 10:29:28.136340 | 2025-10-13 10:29:28.529808 | controller | ok 2025-10-13 10:29:28.923162 | controller | ok 2025-10-13 10:29:28.941013 | 2025-10-13 10:29:28.941105 | TASK [include_role : fetch-output-openshift] 2025-10-13 10:29:28.954286 | controller | skipping: Conditional result was False 2025-10-13 10:29:28.960813 | 2025-10-13 10:29:28.960895 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-10-13 10:29:29.331508 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007222 2025-10-13 10:29:29.545612 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007094 2025-10-13 10:29:29.579445 | 2025-10-13 10:29:29.579548 | PLAY [all] 2025-10-13 10:29:29.594904 | 2025-10-13 10:29:29.595049 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-13 10:29:30.020383 | controller | changed 2025-10-13 10:29:30.046080 | 2025-10-13 10:29:30.046170 | PLAY RECAP 2025-10-13 10:29:30.046213 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-10-13 10:29:30.046235 | 2025-10-13 10:29:30.127534 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-13 10:29:30.128322 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-10-13 10:29:30.686286 | 2025-10-13 10:29:30.686404 | PLAY [localhost] 2025-10-13 10:29:30.704978 | 2025-10-13 10:29:30.705090 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-13 10:29:31.019324 | localhost | changed 2025-10-13 10:29:31.024135 | 2025-10-13 10:29:31.024236 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-13 10:29:31.043010 | localhost | ok 2025-10-13 10:29:31.051510 | 2025-10-13 10:29:31.051582 | TASK [add-fileserver : Create SSH private key tempfile] 2025-10-13 10:29:31.363857 | localhost | changed 2025-10-13 10:29:31.369512 | 2025-10-13 10:29:31.369581 | TASK [add-fileserver : Create SSH private key from secret] 2025-10-13 10:29:31.955083 | localhost | changed 2025-10-13 10:29:31.960959 | 2025-10-13 10:29:31.961081 | TASK [add-fileserver : Add fileserver ssh key] 2025-10-13 10:29:32.323271 | localhost | Identity added: /var/lib/zuul/builds/cbdd31099e1e422493fdf5a12ee21ac0/work/tmp/ansible.9thk2_yk (/var/lib/zuul/builds/cbdd31099e1e422493fdf5a12ee21ac0/work/tmp/ansible.9thk2_yk) 2025-10-13 10:29:32.323446 | localhost | ok: Runtime: 0:00:00.007146 2025-10-13 10:29:32.327941 | 2025-10-13 10:29:32.328007 | TASK [add-fileserver : Remove SSH private key from disk] 2025-10-13 10:29:32.558002 | localhost | ok: Runtime: 0:00:00.004755 2025-10-13 10:29:32.563228 | 2025-10-13 10:29:32.563298 | TASK [add-fileserver : Add fileserver to inventory] 2025-10-13 10:29:32.612036 | localhost | changed 2025-10-13 10:29:32.616326 | 2025-10-13 10:29:32.616394 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-10-13 10:29:32.948662 | localhost | changed 2025-10-13 10:29:32.968997 | 2025-10-13 10:29:32.969074 | PLAY [localhost] 2025-10-13 10:29:32.981254 | 2025-10-13 10:29:32.981318 | TASK [Generate bulk log download script] 2025-10-13 10:29:32.999926 | localhost | ok 2025-10-13 10:29:33.015211 | 2025-10-13 10:29:33.015298 | TASK [local-log-download : Check API endpoint is defined] 2025-10-13 10:29:33.043543 | localhost | ok: All assertions passed 2025-10-13 10:29:33.048083 | 2025-10-13 10:29:33.048152 | TASK [local-log-download : Create download script] 2025-10-13 10:29:33.416830 | localhost -> localhost | changed 2025-10-13 10:29:33.425255 | 2025-10-13 10:29:33.425330 | TASK [Register quick-download link] 2025-10-13 10:29:33.442371 | localhost | ok 2025-10-13 10:29:33.476944 | 2025-10-13 10:29:33.477021 | PLAY [logserver.rdoproject.org] 2025-10-13 10:29:33.486516 | 2025-10-13 10:29:33.486575 | TASK [Set zuul-log-path fact] 2025-10-13 10:29:33.502592 | logserver.rdoproject.org | ok 2025-10-13 10:29:33.512632 | 2025-10-13 10:29:33.512699 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-13 10:29:33.528715 | logserver.rdoproject.org | ok 2025-10-13 10:29:33.534257 | 2025-10-13 10:29:33.534321 | TASK [upload-logs : Create log directories] 2025-10-13 10:29:35.323940 | logserver.rdoproject.org | changed 2025-10-13 10:29:35.327449 | 2025-10-13 10:29:35.327524 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-13 10:29:35.555382 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.004321 2025-10-13 10:29:35.560072 | 2025-10-13 10:29:35.560137 | TASK [upload-logs : Upload logs to log server] 2025-10-13 10:29:37.139392 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-10-13 10:29:37.142284 | 2025-10-13 10:29:37.142368 | LOOP [upload-logs : Compress console log and json output] 2025-10-13 10:29:37.185517 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-13 10:29:37.194017 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-13 10:29:37.200685 | 2025-10-13 10:29:37.200774 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-13 10:29:37.239503 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-13 10:29:37.239849 | 2025-10-13 10:29:37.242126 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-13 10:29:37.250890 | 2025-10-13 10:29:37.250985 | LOOP [upload-logs : Upload console log and json output]