2026-08-13 20:19:29.733991 | Job console starting 2026-08-13 20:19:29.741611 | Updating git repos 2026-08-13 20:19:29.766091 | Cloning repos into workspace 2026-08-13 20:19:29.799830 | Restoring repo states 2026-08-13 20:19:29.808354 | Merging changes 2026-08-13 20:19:30.143791 | Checking out repos 2026-08-13 20:19:30.175075 | Preparing playbooks 2026-08-13 20:19:31.236074 | Running Ansible setup 2026-08-13 20:19:35.303543 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-13 20:19:35.890530 | 2026-08-13 20:19:35.890649 | PLAY [localhost] 2026-08-13 20:19:35.898130 | 2026-08-13 20:19:35.898202 | TASK [Gathering Facts] 2026-08-13 20:19:36.752389 | localhost | ok 2026-08-13 20:19:36.765292 | 2026-08-13 20:19:36.765406 | TASK [Setup log path fact] 2026-08-13 20:19:36.790770 | localhost | ok 2026-08-13 20:19:36.807753 | 2026-08-13 20:19:36.807830 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-13 20:19:36.846811 | localhost | ok 2026-08-13 20:19:36.860818 | 2026-08-13 20:19:36.861032 | TASK [emit-job-header : Print job information] 2026-08-13 20:19:36.914882 | # Job Information 2026-08-13 20:19:36.915095 | Ansible Version: 2.16.18 2026-08-13 20:19:36.915172 | Job: ansible-collection-containers-molecule-docker-upgrade-ubuntu-focal 2026-08-13 20:19:36.915221 | Pipeline: check 2026-08-13 20:19:36.915265 | Executor: 2d72f0692154 2026-08-13 20:19:36.915308 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/136 2026-08-13 20:19:36.915356 | Event ID: 6fb16d40-9751-11f1-966c-e4e60fdf76d0 2026-08-13 20:19:36.920337 | 2026-08-13 20:19:36.920399 | LOOP [emit-job-header : Print node information] 2026-08-13 20:19:37.020728 | localhost | ok: 2026-08-13 20:19:37.021018 | localhost | # Node Information 2026-08-13 20:19:37.021080 | localhost | Inventory Hostname: ubuntu-focal 2026-08-13 20:19:37.021118 | localhost | Hostname: np0000189364 2026-08-13 20:19:37.021154 | localhost | Username: zuul 2026-08-13 20:19:37.021192 | localhost | Distro: Ubuntu 20.04 2026-08-13 20:19:37.021227 | localhost | Provider: yul1 2026-08-13 20:19:37.021260 | localhost | Region: ca-ymq-1 2026-08-13 20:19:37.021293 | localhost | Label: ubuntu-focal 2026-08-13 20:19:37.021326 | localhost | Product Name: OpenStack Nova 2026-08-13 20:19:37.021358 | localhost | Interface IP: 199.204.45.61 2026-08-13 20:19:37.031436 | 2026-08-13 20:19:37.031550 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-13 20:19:37.465581 | localhost -> localhost | changed 2026-08-13 20:19:37.470925 | 2026-08-13 20:19:37.470996 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-13 20:19:38.342791 | localhost -> localhost | changed 2026-08-13 20:19:38.352709 | 2026-08-13 20:19:38.352779 | PLAY [all] 2026-08-13 20:19:38.360600 | 2026-08-13 20:19:38.360672 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-13 20:19:38.574453 | ubuntu-focal -> localhost | ok 2026-08-13 20:19:38.585235 | 2026-08-13 20:19:38.585327 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-13 20:19:38.622193 | ubuntu-focal | ok 2026-08-13 20:19:38.637964 | ubuntu-focal | included: /var/lib/zuul/builds/1c7c4ad58e714b2e90587d68d3fdbd85/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-13 20:19:38.643748 | 2026-08-13 20:19:38.643810 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-13 20:19:39.612354 | ubuntu-focal -> localhost | Generating public/private rsa key pair. 2026-08-13 20:19:39.612541 | ubuntu-focal -> localhost | Your identification has been saved in /var/lib/zuul/builds/1c7c4ad58e714b2e90587d68d3fdbd85/work/1c7c4ad58e714b2e90587d68d3fdbd85_id_rsa 2026-08-13 20:19:39.612587 | ubuntu-focal -> localhost | Your public key has been saved in /var/lib/zuul/builds/1c7c4ad58e714b2e90587d68d3fdbd85/work/1c7c4ad58e714b2e90587d68d3fdbd85_id_rsa.pub 2026-08-13 20:19:39.612622 | ubuntu-focal -> localhost | The key fingerprint is: 2026-08-13 20:19:39.612653 | ubuntu-focal -> localhost | SHA256:d1p9dP+HV++pf3JIiRZE3vXbIVs1j4cksiwWLrOjLgo zuul-build-sshkey 2026-08-13 20:19:39.612698 | ubuntu-focal -> localhost | The key's randomart image is: 2026-08-13 20:19:39.612729 | ubuntu-focal -> localhost | +---[RSA 3072]----+ 2026-08-13 20:19:39.612767 | ubuntu-focal -> localhost | | . ..o ..o| 2026-08-13 20:19:39.612800 | ubuntu-focal -> localhost | | . o +.+ +=| 2026-08-13 20:19:39.612830 | ubuntu-focal -> localhost | | o + o...+o*| 2026-08-13 20:19:39.612860 | ubuntu-focal -> localhost | | = . ..+o*| 2026-08-13 20:19:39.612889 | ubuntu-focal -> localhost | | o S . o+.o=| 2026-08-13 20:19:39.612918 | ubuntu-focal -> localhost | | . . . +o oo+| 2026-08-13 20:19:39.612947 | ubuntu-focal -> localhost | |E . .. ...=| 2026-08-13 20:19:39.613062 | ubuntu-focal -> localhost | |. .. oo=| 2026-08-13 20:19:39.613099 | ubuntu-focal -> localhost | |.. .. .o=o| 2026-08-13 20:19:39.613131 | ubuntu-focal -> localhost | +----[SHA256]-----+ 2026-08-13 20:19:39.613201 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.551459 2026-08-13 20:19:39.620422 | 2026-08-13 20:19:39.620512 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-13 20:19:39.652850 | ubuntu-focal | ok 2026-08-13 20:19:39.663203 | ubuntu-focal | included: /var/lib/zuul/builds/1c7c4ad58e714b2e90587d68d3fdbd85/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-13 20:19:39.671393 | 2026-08-13 20:19:39.671452 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-13 20:19:39.696788 | ubuntu-focal | skipping: Conditional result was False 2026-08-13 20:19:39.706859 | 2026-08-13 20:19:39.706929 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-13 20:19:40.186643 | ubuntu-focal | changed 2026-08-13 20:19:40.193617 | 2026-08-13 20:19:40.193708 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-13 20:19:40.371474 | ubuntu-focal | ok 2026-08-13 20:19:40.378451 | 2026-08-13 20:19:40.378546 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-13 20:19:40.829503 | ubuntu-focal | changed 2026-08-13 20:19:40.837685 | 2026-08-13 20:19:40.837800 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-13 20:19:41.258900 | ubuntu-focal | changed 2026-08-13 20:19:41.265712 | 2026-08-13 20:19:41.265820 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-13 20:19:41.291048 | ubuntu-focal | skipping: Conditional result was False 2026-08-13 20:19:41.302308 | 2026-08-13 20:19:41.302423 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-13 20:19:41.663380 | ubuntu-focal -> localhost | changed 2026-08-13 20:19:41.680241 | 2026-08-13 20:19:41.680325 | TASK [add-build-sshkey : Add back temp key] 2026-08-13 20:19:41.967252 | ubuntu-focal -> localhost | Identity added: /var/lib/zuul/builds/1c7c4ad58e714b2e90587d68d3fdbd85/work/1c7c4ad58e714b2e90587d68d3fdbd85_id_rsa (zuul-build-sshkey) 2026-08-13 20:19:41.967540 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.014265 2026-08-13 20:19:41.974607 | 2026-08-13 20:19:41.974673 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-13 20:19:42.292040 | ubuntu-focal | ok 2026-08-13 20:19:42.299214 | 2026-08-13 20:19:42.299317 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-13 20:19:42.336443 | ubuntu-focal | skipping: Conditional result was False 2026-08-13 20:19:42.354743 | 2026-08-13 20:19:42.354920 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-13 20:19:42.681516 | ubuntu-focal | ok 2026-08-13 20:19:42.687332 | 2026-08-13 20:19:42.687402 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-13 20:19:43.349678 | ubuntu-focal | Output suppressed because no_log was given 2026-08-13 20:19:43.376645 | 2026-08-13 20:19:43.377108 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-13 20:19:43.558059 | ubuntu-focal | ok: "logs" 2026-08-13 20:19:43.558429 | ubuntu-focal | ok: All items complete 2026-08-13 20:19:43.558469 | 2026-08-13 20:19:43.773309 | ubuntu-focal | ok: "artifacts" 2026-08-13 20:19:43.861686 | ubuntu-focal | ok: "docs" 2026-08-13 20:19:43.874159 | 2026-08-13 20:19:43.874366 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-13 20:19:44.042443 | ubuntu-focal | changed: "logs" 2026-08-13 20:19:44.188110 | ubuntu-focal | changed: "artifacts" 2026-08-13 20:19:44.328118 | ubuntu-focal | changed: "docs" 2026-08-13 20:19:44.347289 | 2026-08-13 20:19:44.347390 | PLAY RECAP 2026-08-13 20:19:44.347432 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-13 20:19:44.347462 | ubuntu-focal | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-13 20:19:44.347484 | 2026-08-13 20:19:44.491104 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-13 20:19:44.493354 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-13 20:19:45.078810 | 2026-08-13 20:19:45.078923 | PLAY [all] 2026-08-13 20:19:45.090026 | 2026-08-13 20:19:45.090138 | TASK [setup-uv : Extract archive] 2026-08-13 20:19:47.154301 | ubuntu-focal | changed 2026-08-13 20:19:47.159887 | 2026-08-13 20:19:47.159967 | TASK [setup-uv : Print version] 2026-08-13 20:19:47.515813 | ubuntu-focal | uv 0.8.13 2026-08-13 20:19:47.693738 | ubuntu-focal | ok: Runtime: 0:00:00.006027 2026-08-13 20:19:47.705735 | 2026-08-13 20:19:47.705812 | TASK [Install Ansible collection siblings] 2026-08-13 20:19:48.035029 | ubuntu-focal | ok: 2026-08-13 20:19:48.035199 | ubuntu-focal | Skipping ansible.posix: no checked-out sibling 2026-08-13 20:19:48.035239 | ubuntu-focal | Skipping community.general: no checked-out sibling 2026-08-13 20:19:48.037105 | 2026-08-13 20:19:48.037167 | PLAY RECAP 2026-08-13 20:19:48.037223 | ubuntu-focal | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-13 20:19:48.037253 | 2026-08-13 20:19:48.132558 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-13 20:19:48.134910 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-13 20:19:48.686959 | 2026-08-13 20:19:48.687075 | PLAY [all] 2026-08-13 20:19:48.698105 | 2026-08-13 20:19:48.698183 | LOOP [Check inventory directories] 2026-08-13 20:19:48.964425 | ubuntu-focal | ok: "src/github.com/vexxhost/ansible-collection-containers" 2026-08-13 20:19:49.092501 | ubuntu-focal | ok: "src/github.com/vexxhost/ansible-collection-containers/molecule/docker-upgrade/inventory" 2026-08-13 20:19:49.229869 | ubuntu-focal | ok: "src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/docker-upgrade/inventory" 2026-08-13 20:19:49.243821 | 2026-08-13 20:19:49.244142 | LOOP [Copy inventory file for Zuul] 2026-08-13 20:19:49.984695 | ubuntu-focal | changed: 2026-08-13 20:19:49.984858 | ubuntu-focal | { 2026-08-13 20:19:49.984886 | ubuntu-focal | "ansible_loop_var": "item", 2026-08-13 20:19:49.984909 | ubuntu-focal | "changed": false, 2026-08-13 20:19:49.984938 | ubuntu-focal | "failed": false, 2026-08-13 20:19:49.984968 | ubuntu-focal | "invocation": { 2026-08-13 20:19:49.985011 | ubuntu-focal | "module_args": { 2026-08-13 20:19:49.985036 | ubuntu-focal | "checksum_algorithm": "sha1", 2026-08-13 20:19:49.985058 | ubuntu-focal | "follow": true, 2026-08-13 20:19:49.985081 | ubuntu-focal | "get_attributes": true, 2026-08-13 20:19:49.985105 | ubuntu-focal | "get_checksum": true, 2026-08-13 20:19:49.985127 | ubuntu-focal | "get_mime": true, 2026-08-13 20:19:49.985149 | ubuntu-focal | "path": "src/github.com/vexxhost/ansible-collection-containers" 2026-08-13 20:19:49.985171 | ubuntu-focal | } 2026-08-13 20:19:49.985193 | ubuntu-focal | }, 2026-08-13 20:19:49.985214 | ubuntu-focal | "item": "src/github.com/vexxhost/ansible-collection-containers", 2026-08-13 20:19:49.985308 | ubuntu-focal | "stat": { 2026-08-13 20:19:49.985336 | ubuntu-focal | "atime": 1786652383.2818694, 2026-08-13 20:19:49.985356 | ubuntu-focal | "attr_flags": "e", 2026-08-13 20:19:49.985374 | ubuntu-focal | "attributes": [ 2026-08-13 20:19:49.985392 | ubuntu-focal | "extents" 2026-08-13 20:19:49.985409 | ubuntu-focal | ], 2026-08-13 20:19:49.985427 | ubuntu-focal | "block_size": 4096, 2026-08-13 20:19:49.985444 | ubuntu-focal | "blocks": 8, 2026-08-13 20:19:49.985462 | ubuntu-focal | "charset": "binary", 2026-08-13 20:19:49.985481 | ubuntu-focal | "ctime": 1786652383.2818694, 2026-08-13 20:19:49.985499 | ubuntu-focal | "dev": 64513, 2026-08-13 20:19:49.985517 | ubuntu-focal | "device_type": 0, 2026-08-13 20:19:49.985534 | ubuntu-focal | "executable": true, 2026-08-13 20:19:49.985551 | ubuntu-focal | "exists": true, 2026-08-13 20:19:49.985569 | ubuntu-focal | "gid": 1000, 2026-08-13 20:19:49.985586 | ubuntu-focal | "gr_name": "zuul", 2026-08-13 20:19:49.985603 | ubuntu-focal | "inode": 518541, 2026-08-13 20:19:49.985620 | ubuntu-focal | "isblk": false, 2026-08-13 20:19:49.985637 | ubuntu-focal | "ischr": false, 2026-08-13 20:19:49.985655 | ubuntu-focal | "isdir": true, 2026-08-13 20:19:49.985672 | ubuntu-focal | "isfifo": false, 2026-08-13 20:19:49.985689 | ubuntu-focal | "isgid": false, 2026-08-13 20:19:49.985706 | ubuntu-focal | "islnk": false, 2026-08-13 20:19:49.985723 | ubuntu-focal | "isreg": false, 2026-08-13 20:19:49.985740 | ubuntu-focal | "issock": false, 2026-08-13 20:19:49.985757 | ubuntu-focal | "isuid": false, 2026-08-13 20:19:49.985774 | ubuntu-focal | "mimetype": "inode/directory", 2026-08-13 20:19:49.985791 | ubuntu-focal | "mode": "0755", 2026-08-13 20:19:49.985807 | ubuntu-focal | "mtime": 1786652369.8268497, 2026-08-13 20:19:49.985824 | ubuntu-focal | "nlink": 11, 2026-08-13 20:19:49.985841 | ubuntu-focal | "path": "src/github.com/vexxhost/ansible-collection-containers", 2026-08-13 20:19:49.985858 | ubuntu-focal | "pw_name": "zuul", 2026-08-13 20:19:49.985878 | ubuntu-focal | "readable": true, 2026-08-13 20:19:49.985895 | ubuntu-focal | "rgrp": true, 2026-08-13 20:19:49.986118 | ubuntu-focal | "roth": true, 2026-08-13 20:19:49.986148 | ubuntu-focal | "rusr": true, 2026-08-13 20:19:49.986167 | ubuntu-focal | "size": 4096, 2026-08-13 20:19:49.986185 | ubuntu-focal | "uid": 1000, 2026-08-13 20:19:49.986203 | ubuntu-focal | "version": "505004810", 2026-08-13 20:19:49.986221 | ubuntu-focal | "wgrp": false, 2026-08-13 20:19:49.986241 | ubuntu-focal | "woth": false, 2026-08-13 20:19:49.986258 | ubuntu-focal | "writeable": true, 2026-08-13 20:19:49.986276 | ubuntu-focal | "wusr": true, 2026-08-13 20:19:49.986293 | ubuntu-focal | "xgrp": true, 2026-08-13 20:19:49.986309 | ubuntu-focal | "xoth": true, 2026-08-13 20:19:49.986326 | ubuntu-focal | "xusr": true 2026-08-13 20:19:49.986343 | ubuntu-focal | } 2026-08-13 20:19:49.986359 | ubuntu-focal | } 2026-08-13 20:19:49.986398 | ubuntu-focal | ok: All items complete 2026-08-13 20:19:49.986421 | 2026-08-13 20:19:49.987640 | ubuntu-focal | skipping: Conditional result was False 2026-08-13 20:19:49.989034 | ubuntu-focal | skipping: Conditional result was False 2026-08-13 20:19:50.006079 | 2026-08-13 20:19:50.006209 | LOOP [Switch "ansible_host" to private IP] 2026-08-13 20:19:50.312062 | ubuntu-focal | changed: 1 replacements made 2026-08-13 20:19:50.314290 | ubuntu-focal | skipping: Conditional result was False 2026-08-13 20:19:50.314860 | ubuntu-focal | skipping: Conditional result was False 2026-08-13 20:19:50.331028 | 2026-08-13 20:19:50.331159 | TASK [Run Molecule scenario] 2026-08-13 20:19:50.957816 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-08-13 20:19:51.624884 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-08-13 20:19:51.808119 | ubuntu-focal | Using CPython 3.13.7 2026-08-13 20:19:51.808212 | ubuntu-focal | Creating virtual environment at: .venv 2026-08-13 20:19:52.031930 | ubuntu-focal | Downloading cryptography (4.3MiB) 2026-08-13 20:19:52.033056 | ubuntu-focal | Downloading pygments (1.2MiB) 2026-08-13 20:19:52.035929 | ubuntu-focal | Downloading ansible-core (2.3MiB) 2026-08-13 20:19:52.170480 | ubuntu-focal | Downloading cryptography 2026-08-13 20:19:52.206063 | ubuntu-focal | Downloading pygments 2026-08-13 20:19:52.321159 | ubuntu-focal | Downloading ansible-core 2026-08-13 20:19:52.349294 | ubuntu-focal | Installed 36 packages in 27ms 2026-08-13 20:19:53.408511 | ubuntu-focal | INFO Collection 'vexxhost.containers' detected. 2026-08-13 20:19:53.408588 | ubuntu-focal | INFO Scenarios will be used from 'extensions/molecule' 2026-08-13 20:19:54.197619 | ubuntu-focal | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-08-13 20:19:54.197689 | ubuntu-focal | INFO default scenario not found, disabling shared state. 2026-08-13 20:19:54.197709 | ubuntu-focal | INFO [docker-upgrade > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-13 20:19:54.197759 | ubuntu-focal | INFO [docker-upgrade > prerun] Performing prerun with role_name_check=0... 2026-08-13 20:20:05.174229 | ubuntu-focal | INFO [docker-upgrade > dependency] Executing 2026-08-13 20:20:05.174441 | ubuntu-focal | WARNING [docker-upgrade > dependency] Missing roles requirements file: requirements.yml 2026-08-13 20:20:05.174685 | ubuntu-focal | WARNING [docker-upgrade > dependency] Missing collections requirements file: collections.yml 2026-08-13 20:20:05.174824 | ubuntu-focal | WARNING [docker-upgrade > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-13 20:20:05.180237 | ubuntu-focal | INFO [docker-upgrade > cleanup] Executing 2026-08-13 20:20:05.180542 | ubuntu-focal | WARNING [docker-upgrade > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-13 20:20:05.185391 | ubuntu-focal | INFO [docker-upgrade > destroy] Executing 2026-08-13 20:20:05.185426 | ubuntu-focal | WARNING [docker-upgrade > destroy] Skipping, '--destroy=never' requested. 2026-08-13 20:20:05.185440 | ubuntu-focal | INFO [docker-upgrade > destroy] Executed: Successful 2026-08-13 20:20:05.190300 | ubuntu-focal | INFO [docker-upgrade > syntax] Executing 2026-08-13 20:20:05.651876 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-08-13 20:20:05.652098 | ubuntu-focal | [DEPRECATION WARNING]: DEFAULT_MANAGED_STR option. Reason: The `ansible_managed` variable can be set just like any other variable, or a different variable can be used. 2026-08-13 20:20:05.652275 | ubuntu-focal | Alternatives: Set the `ansible_managed` variable, or use any custom variable in templates. This feature will be removed from ansible-core version 2.23. 2026-08-13 20:20:05.652465 | ubuntu-focal | 2026-08-13 20:20:06.078856 | ubuntu-focal | 2026-08-13 20:20:06.079089 | ubuntu-focal | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/docker-upgrade/converge.yml 2026-08-13 20:20:06.143952 | ubuntu-focal | INFO [docker-upgrade > syntax] Executed: Successful 2026-08-13 20:20:06.154361 | ubuntu-focal | INFO [docker-upgrade > create] Executing 2026-08-13 20:20:06.155630 | ubuntu-focal | WARNING [docker-upgrade > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-13 20:20:06.160469 | ubuntu-focal | INFO [docker-upgrade > prepare] Executing 2026-08-13 20:20:06.606315 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-08-13 20:20:06.606459 | ubuntu-focal | [DEPRECATION WARNING]: DEFAULT_MANAGED_STR option. Reason: The `ansible_managed` variable can be set just like any other variable, or a different variable can be used. 2026-08-13 20:20:06.606646 | ubuntu-focal | Alternatives: Set the `ansible_managed` variable, or use any custom variable in templates. This feature will be removed from ansible-core version 2.23. 2026-08-13 20:20:06.606798 | ubuntu-focal | 2026-08-13 20:20:07.105472 | ubuntu-focal | 2026-08-13 20:20:07.105527 | ubuntu-focal | PLAY [Prepare Docker upgrade] ************************************************** 2026-08-13 20:20:07.105552 | ubuntu-focal | 2026-08-13 20:20:07.105632 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-08-13 20:20:07.105717 | ubuntu-focal | Thursday 13 August 2026 20:20:07 +0000 (0:00:00.041) 0:00:00.041 ******* 2026-08-13 20:20:08.236432 | ubuntu-focal | [WARNING]: Host 'ubuntu-focal' is using the discovered Python interpreter at '/usr/bin/python3.8', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.19/reference_appendices/interpreter_discovery.html for more information. 2026-08-13 20:20:08.238732 | ubuntu-focal | ok: [ubuntu-focal] 2026-08-13 20:20:08.238904 | ubuntu-focal | 2026-08-13 20:20:08.239125 | ubuntu-focal | TASK [Update "apt" cache] ****************************************************** 2026-08-13 20:20:08.239312 | ubuntu-focal | Thursday 13 August 2026 20:20:08 +0000 (0:00:01.134) 0:00:01.175 ******* 2026-08-13 20:20:14.329692 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:14.329763 | ubuntu-focal | 2026-08-13 20:20:14.330016 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-13 20:20:14.330206 | ubuntu-focal | Thursday 13 August 2026 20:20:14 +0000 (0:00:06.090) 0:00:07.265 ******* 2026-08-13 20:20:14.754186 | ubuntu-focal | ok: [ubuntu-focal] 2026-08-13 20:20:14.754349 | ubuntu-focal | 2026-08-13 20:20:14.754584 | ubuntu-focal | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-13 20:20:14.754787 | ubuntu-focal | Thursday 13 August 2026 20:20:14 +0000 (0:00:00.424) 0:00:07.690 ******* 2026-08-13 20:20:14.782133 | ubuntu-focal | skipping: [ubuntu-focal] 2026-08-13 20:20:14.782292 | ubuntu-focal | 2026-08-13 20:20:14.782472 | ubuntu-focal | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-13 20:20:14.782644 | ubuntu-focal | Thursday 13 August 2026 20:20:14 +0000 (0:00:00.028) 0:00:07.718 ******* 2026-08-13 20:20:15.138058 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:15.138210 | ubuntu-focal | 2026-08-13 20:20:15.138454 | ubuntu-focal | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-13 20:20:15.138608 | ubuntu-focal | Thursday 13 August 2026 20:20:15 +0000 (0:00:00.355) 0:00:08.074 ******* 2026-08-13 20:20:15.220820 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-08-13 20:20:15.220981 | ubuntu-focal | "msg": "https://github.com/opencontainers/runc/releases/download/v1.5.1/runc.amd64" 2026-08-13 20:20:15.221145 | ubuntu-focal | } 2026-08-13 20:20:15.221293 | ubuntu-focal | 2026-08-13 20:20:15.221481 | ubuntu-focal | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-13 20:20:15.221806 | ubuntu-focal | Thursday 13 August 2026 20:20:15 +0000 (0:00:00.082) 0:00:08.156 ******* 2026-08-13 20:20:16.078673 | ubuntu-focal | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-13 20:20:16.085492 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:16.085695 | ubuntu-focal | 2026-08-13 20:20:16.085935 | ubuntu-focal | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-13 20:20:16.086157 | ubuntu-focal | Thursday 13 August 2026 20:20:16 +0000 (0:00:00.864) 0:00:09.021 ******* 2026-08-13 20:20:16.109574 | ubuntu-focal | skipping: [ubuntu-focal] 2026-08-13 20:20:16.109776 | ubuntu-focal | 2026-08-13 20:20:16.110026 | ubuntu-focal | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-13 20:20:16.110275 | ubuntu-focal | Thursday 13 August 2026 20:20:16 +0000 (0:00:00.024) 0:00:09.046 ******* 2026-08-13 20:20:16.140573 | ubuntu-focal | skipping: [ubuntu-focal] 2026-08-13 20:20:16.140653 | ubuntu-focal | 2026-08-13 20:20:16.140905 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-13 20:20:16.141103 | ubuntu-focal | Thursday 13 August 2026 20:20:16 +0000 (0:00:00.030) 0:00:09.076 ******* 2026-08-13 20:20:16.368373 | ubuntu-focal | ok: [ubuntu-focal] 2026-08-13 20:20:16.368505 | ubuntu-focal | 2026-08-13 20:20:16.368711 | ubuntu-focal | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-13 20:20:16.368902 | ubuntu-focal | Thursday 13 August 2026 20:20:16 +0000 (0:00:00.227) 0:00:09.304 ******* 2026-08-13 20:20:17.263869 | ubuntu-focal | ok: [ubuntu-focal] 2026-08-13 20:20:17.264062 | ubuntu-focal | 2026-08-13 20:20:17.264284 | ubuntu-focal | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-13 20:20:17.264476 | ubuntu-focal | Thursday 13 August 2026 20:20:17 +0000 (0:00:00.895) 0:00:10.200 ******* 2026-08-13 20:20:17.330600 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-08-13 20:20:17.330788 | ubuntu-focal | "msg": "https://github.com/containerd/containerd/releases/download/v1.7.33/containerd-1.7.33-linux-amd64.tar.gz" 2026-08-13 20:20:17.330967 | ubuntu-focal | } 2026-08-13 20:20:17.331132 | ubuntu-focal | 2026-08-13 20:20:17.331367 | ubuntu-focal | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-13 20:20:17.331567 | ubuntu-focal | Thursday 13 August 2026 20:20:17 +0000 (0:00:00.066) 0:00:10.266 ******* 2026-08-13 20:20:18.842346 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:18.842508 | ubuntu-focal | 2026-08-13 20:20:18.842711 | ubuntu-focal | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-13 20:20:18.842901 | ubuntu-focal | Thursday 13 August 2026 20:20:18 +0000 (0:00:01.511) 0:00:11.778 ******* 2026-08-13 20:20:22.812350 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:22.812505 | ubuntu-focal | 2026-08-13 20:20:22.812703 | ubuntu-focal | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-13 20:20:22.812888 | ubuntu-focal | Thursday 13 August 2026 20:20:22 +0000 (0:00:03.969) 0:00:15.747 ******* 2026-08-13 20:20:22.831292 | ubuntu-focal | skipping: [ubuntu-focal] 2026-08-13 20:20:22.831456 | ubuntu-focal | 2026-08-13 20:20:22.831651 | ubuntu-focal | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-13 20:20:22.831821 | ubuntu-focal | Thursday 13 August 2026 20:20:22 +0000 (0:00:00.019) 0:00:15.767 ******* 2026-08-13 20:20:22.846222 | ubuntu-focal | skipping: [ubuntu-focal] 2026-08-13 20:20:22.846373 | ubuntu-focal | 2026-08-13 20:20:22.846549 | ubuntu-focal | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-13 20:20:22.846723 | ubuntu-focal | Thursday 13 August 2026 20:20:22 +0000 (0:00:00.014) 0:00:15.782 ******* 2026-08-13 20:20:22.868386 | ubuntu-focal | skipping: [ubuntu-focal] 2026-08-13 20:20:22.868539 | ubuntu-focal | 2026-08-13 20:20:22.868716 | ubuntu-focal | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-13 20:20:22.868891 | ubuntu-focal | Thursday 13 August 2026 20:20:22 +0000 (0:00:00.022) 0:00:15.804 ******* 2026-08-13 20:20:27.772885 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:27.773041 | ubuntu-focal | 2026-08-13 20:20:27.773286 | ubuntu-focal | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-13 20:20:27.773451 | ubuntu-focal | Thursday 13 August 2026 20:20:27 +0000 (0:00:04.904) 0:00:20.708 ******* 2026-08-13 20:20:28.430736 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:28.430891 | ubuntu-focal | 2026-08-13 20:20:28.431178 | ubuntu-focal | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-13 20:20:28.431277 | ubuntu-focal | Thursday 13 August 2026 20:20:28 +0000 (0:00:00.657) 0:00:21.366 ******* 2026-08-13 20:20:29.513441 | ubuntu-focal | changed: [ubuntu-focal] => (item={'path': '/etc/containerd'}) 2026-08-13 20:20:29.513585 | ubuntu-focal | changed: [ubuntu-focal] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-13 20:20:29.513780 | ubuntu-focal | changed: [ubuntu-focal] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-13 20:20:29.513977 | ubuntu-focal | changed: [ubuntu-focal] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-13 20:20:29.514177 | ubuntu-focal | changed: [ubuntu-focal] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-13 20:20:29.514394 | ubuntu-focal | 2026-08-13 20:20:29.514599 | ubuntu-focal | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-13 20:20:29.514794 | ubuntu-focal | Thursday 13 August 2026 20:20:29 +0000 (0:00:01.082) 0:00:22.449 ******* 2026-08-13 20:20:30.141947 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:30.142090 | ubuntu-focal | 2026-08-13 20:20:30.142273 | ubuntu-focal | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-13 20:20:30.142450 | ubuntu-focal | Thursday 13 August 2026 20:20:30 +0000 (0:00:00.625) 0:00:23.074 ******* 2026-08-13 20:20:30.142602 | ubuntu-focal | 2026-08-13 20:20:30.142777 | ubuntu-focal | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-13 20:20:30.142947 | ubuntu-focal | Thursday 13 August 2026 20:20:30 +0000 (0:00:00.003) 0:00:23.078 ******* 2026-08-13 20:20:31.112606 | ubuntu-focal | ok: [ubuntu-focal] 2026-08-13 20:20:31.112941 | ubuntu-focal | 2026-08-13 20:20:31.113221 | ubuntu-focal | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-13 20:20:31.113471 | ubuntu-focal | Thursday 13 August 2026 20:20:31 +0000 (0:00:00.970) 0:00:24.048 ******* 2026-08-13 20:20:31.588939 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:31.588995 | ubuntu-focal | 2026-08-13 20:20:31.589006 | ubuntu-focal | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-13 20:20:31.589016 | ubuntu-focal | Thursday 13 August 2026 20:20:31 +0000 (0:00:00.475) 0:00:24.524 ******* 2026-08-13 20:20:32.104260 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:32.104328 | ubuntu-focal | 2026-08-13 20:20:32.104648 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-13 20:20:32.104698 | ubuntu-focal | Thursday 13 August 2026 20:20:32 +0000 (0:00:00.516) 0:00:25.040 ******* 2026-08-13 20:20:32.332892 | ubuntu-focal | ok: [ubuntu-focal] 2026-08-13 20:20:32.332926 | ubuntu-focal | 2026-08-13 20:20:32.333152 | ubuntu-focal | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads/docker-24.0.9)] *** 2026-08-13 20:20:32.333196 | ubuntu-focal | Thursday 13 August 2026 20:20:32 +0000 (0:00:00.228) 0:00:25.268 ******* 2026-08-13 20:20:32.571312 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:32.571378 | ubuntu-focal | 2026-08-13 20:20:32.571637 | ubuntu-focal | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-13 20:20:32.571682 | ubuntu-focal | Thursday 13 August 2026 20:20:32 +0000 (0:00:00.238) 0:00:25.507 ******* 2026-08-13 20:20:32.604970 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-08-13 20:20:32.605597 | ubuntu-focal | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-13 20:20:32.605658 | ubuntu-focal | } 2026-08-13 20:20:32.605667 | ubuntu-focal | 2026-08-13 20:20:32.605675 | ubuntu-focal | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-13 20:20:32.605683 | ubuntu-focal | Thursday 13 August 2026 20:20:32 +0000 (0:00:00.033) 0:00:25.541 ******* 2026-08-13 20:20:33.434896 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:33.434962 | ubuntu-focal | 2026-08-13 20:20:33.435211 | ubuntu-focal | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-13 20:20:33.435253 | ubuntu-focal | Thursday 13 August 2026 20:20:33 +0000 (0:00:00.829) 0:00:26.371 ******* 2026-08-13 20:20:37.811019 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:37.811065 | ubuntu-focal | 2026-08-13 20:20:37.811072 | ubuntu-focal | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-13 20:20:37.811078 | ubuntu-focal | Thursday 13 August 2026 20:20:37 +0000 (0:00:04.375) 0:00:30.747 ******* 2026-08-13 20:20:38.725607 | ubuntu-focal | ok: [ubuntu-focal] 2026-08-13 20:20:38.725649 | ubuntu-focal | 2026-08-13 20:20:38.725657 | ubuntu-focal | TASK [vexxhost.containers.docker : Install SELinux packages] ******************* 2026-08-13 20:20:38.725663 | ubuntu-focal | Thursday 13 August 2026 20:20:38 +0000 (0:00:00.914) 0:00:31.661 ******* 2026-08-13 20:20:38.743499 | ubuntu-focal | skipping: [ubuntu-focal] 2026-08-13 20:20:38.743886 | ubuntu-focal | 2026-08-13 20:20:38.743970 | ubuntu-focal | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-13 20:20:38.743979 | ubuntu-focal | Thursday 13 August 2026 20:20:38 +0000 (0:00:00.018) 0:00:31.679 ******* 2026-08-13 20:20:39.123575 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:39.124225 | ubuntu-focal | 2026-08-13 20:20:39.124274 | ubuntu-focal | TASK [vexxhost.containers.docker : Create links to Docker binaries] ************ 2026-08-13 20:20:39.124285 | ubuntu-focal | Thursday 13 August 2026 20:20:39 +0000 (0:00:00.379) 0:00:32.059 ******* 2026-08-13 20:20:39.989448 | ubuntu-focal | changed: [ubuntu-focal] => (item=docker) 2026-08-13 20:20:39.990504 | ubuntu-focal | changed: [ubuntu-focal] => (item=docker-init) 2026-08-13 20:20:39.990562 | ubuntu-focal | changed: [ubuntu-focal] => (item=dockerd) 2026-08-13 20:20:39.990573 | ubuntu-focal | changed: [ubuntu-focal] => (item=docker-proxy) 2026-08-13 20:20:39.990582 | ubuntu-focal | 2026-08-13 20:20:39.990592 | ubuntu-focal | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-13 20:20:39.990601 | ubuntu-focal | Thursday 13 August 2026 20:20:39 +0000 (0:00:00.865) 0:00:32.925 ******* 2026-08-13 20:20:40.476549 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:40.476609 | ubuntu-focal | 2026-08-13 20:20:40.476885 | ubuntu-focal | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-13 20:20:40.476926 | ubuntu-focal | Thursday 13 August 2026 20:20:40 +0000 (0:00:00.487) 0:00:33.412 ******* 2026-08-13 20:20:41.143866 | ubuntu-focal | changed: [ubuntu-focal] => (item={'path': '/etc/docker'}) 2026-08-13 20:20:41.143964 | ubuntu-focal | changed: [ubuntu-focal] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-13 20:20:41.144462 | ubuntu-focal | changed: [ubuntu-focal] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-13 20:20:41.144483 | ubuntu-focal | 2026-08-13 20:20:41.144490 | ubuntu-focal | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-13 20:20:41.144496 | ubuntu-focal | Thursday 13 August 2026 20:20:41 +0000 (0:00:00.667) 0:00:34.080 ******* 2026-08-13 20:20:41.621077 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:41.621576 | ubuntu-focal | 2026-08-13 20:20:41.621600 | ubuntu-focal | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-13 20:20:41.621609 | ubuntu-focal | Thursday 13 August 2026 20:20:41 +0000 (0:00:00.477) 0:00:34.557 ******* 2026-08-13 20:20:42.112803 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:42.113569 | ubuntu-focal | 2026-08-13 20:20:42.113659 | ubuntu-focal | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-13 20:20:42.113667 | ubuntu-focal | Thursday 13 August 2026 20:20:42 +0000 (0:00:00.485) 0:00:35.042 ******* 2026-08-13 20:20:42.113673 | ubuntu-focal | 2026-08-13 20:20:42.113679 | ubuntu-focal | RUNNING HANDLER [vexxhost.containers.docker : Reload Docker systemd units] ***** 2026-08-13 20:20:42.113694 | ubuntu-focal | Thursday 13 August 2026 20:20:42 +0000 (0:00:00.002) 0:00:35.045 ******* 2026-08-13 20:20:42.604890 | ubuntu-focal | ok: [ubuntu-focal] 2026-08-13 20:20:42.605028 | ubuntu-focal | 2026-08-13 20:20:42.605040 | ubuntu-focal | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-13 20:20:42.605209 | ubuntu-focal | Thursday 13 August 2026 20:20:42 +0000 (0:00:00.495) 0:00:35.541 ******* 2026-08-13 20:20:42.633550 | ubuntu-focal | skipping: [ubuntu-focal] 2026-08-13 20:20:42.634210 | ubuntu-focal | 2026-08-13 20:20:42.634297 | ubuntu-focal | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-13 20:20:42.634308 | ubuntu-focal | Thursday 13 August 2026 20:20:42 +0000 (0:00:00.027) 0:00:35.569 ******* 2026-08-13 20:20:44.172060 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:44.172107 | ubuntu-focal | 2026-08-13 20:20:44.172116 | ubuntu-focal | TASK [Stop Docker before establishing legacy binary layout] ******************** 2026-08-13 20:20:44.172123 | ubuntu-focal | Thursday 13 August 2026 20:20:44 +0000 (0:00:01.538) 0:00:37.107 ******* 2026-08-13 20:20:44.519071 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:44.519139 | ubuntu-focal | 2026-08-13 20:20:44.519406 | ubuntu-focal | TASK [Remove versioned Docker binary links] ************************************ 2026-08-13 20:20:44.519451 | ubuntu-focal | Thursday 13 August 2026 20:20:44 +0000 (0:00:00.347) 0:00:37.455 ******* 2026-08-13 20:20:45.363537 | ubuntu-focal | changed: [ubuntu-focal] => (item=docker) 2026-08-13 20:20:45.363586 | ubuntu-focal | changed: [ubuntu-focal] => (item=docker-init) 2026-08-13 20:20:45.363594 | ubuntu-focal | changed: [ubuntu-focal] => (item=dockerd) 2026-08-13 20:20:45.363600 | ubuntu-focal | changed: [ubuntu-focal] => (item=docker-proxy) 2026-08-13 20:20:45.363606 | ubuntu-focal | 2026-08-13 20:20:45.363612 | ubuntu-focal | TASK [Install legacy Docker binaries directly into /usr/bin] ******************* 2026-08-13 20:20:45.363619 | ubuntu-focal | Thursday 13 August 2026 20:20:45 +0000 (0:00:00.841) 0:00:38.296 ******* 2026-08-13 20:20:46.677293 | ubuntu-focal | changed: [ubuntu-focal] => (item=docker) 2026-08-13 20:20:46.677355 | ubuntu-focal | changed: [ubuntu-focal] => (item=docker-init) 2026-08-13 20:20:46.677367 | ubuntu-focal | changed: [ubuntu-focal] => (item=dockerd) 2026-08-13 20:20:46.677377 | ubuntu-focal | changed: [ubuntu-focal] => (item=docker-proxy) 2026-08-13 20:20:46.677387 | ubuntu-focal | 2026-08-13 20:20:46.677396 | ubuntu-focal | TASK [Start Docker from legacy binary layout] ********************************** 2026-08-13 20:20:46.677406 | ubuntu-focal | Thursday 13 August 2026 20:20:46 +0000 (0:00:01.315) 0:00:39.612 ******* 2026-08-13 20:20:47.152689 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:47.152763 | ubuntu-focal | 2026-08-13 20:20:47.152777 | ubuntu-focal | TASK [Create HTTP workload configuration] ************************************** 2026-08-13 20:20:47.152786 | ubuntu-focal | Thursday 13 August 2026 20:20:47 +0000 (0:00:00.476) 0:00:40.088 ******* 2026-08-13 20:20:47.638094 | ubuntu-focal | changed: [ubuntu-focal] 2026-08-13 20:20:47.638147 | ubuntu-focal | 2026-08-13 20:20:47.638158 | ubuntu-focal | TASK [Pull workload images] **************************************************** 2026-08-13 20:20:47.638168 | ubuntu-focal | Thursday 13 August 2026 20:20:47 +0000 (0:00:00.485) 0:00:40.573 ******* 2026-08-13 20:20:52.229019 | ubuntu-focal | ok: [ubuntu-focal] => (item=docker.io/library/busybox:1.36.1) 2026-08-13 20:20:52.229079 | ubuntu-focal | ok: [ubuntu-focal] => (item=docker.io/library/nginx:1.27.5-alpine) 2026-08-13 20:20:52.229091 | ubuntu-focal | 2026-08-13 20:20:52.229100 | ubuntu-focal | TASK [Start counter workload container] **************************************** 2026-08-13 20:20:52.229109 | ubuntu-focal | Thursday 13 August 2026 20:20:52 +0000 (0:00:04.590) 0:00:45.164 ******* 2026-08-13 20:20:52.900991 | ubuntu-focal | [ERROR]: Task failed: Module failed: non-zero return code 2026-08-13 20:20:52.902190 | ubuntu-focal | Origin: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/docker-upgrade/prepare.yml:82:7 2026-08-13 20:20:52.902243 | ubuntu-focal | 2026-08-13 20:20:52.902255 | ubuntu-focal | 80 changed_when: false 2026-08-13 20:20:52.902266 | ubuntu-focal | 81 2026-08-13 20:20:52.902276 | ubuntu-focal | 82 - name: Start counter workload container 2026-08-13 20:20:52.902286 | ubuntu-focal | ^ column 7 2026-08-13 20:20:52.902295 | ubuntu-focal | 2026-08-13 20:20:52.902946 | ubuntu-focal | fatal: [ubuntu-focal]: FAILED! => {"changed": true, "cmd": ["docker", "run", "--detach", "--name", "molecule-upgrade-busybox", "docker.io/library/busybox:1.36.1", "sh", "-c", "while true; do date +%s >> /tmp/ticks; sleep 1; done"], "delta": "0:00:00.456115", "end": "2026-08-13 20:20:52.873181", "msg": "non-zero return code", "rc": 125, "start": "2026-08-13 20:20:52.417066", "stderr": "WARNING: IPv4 forwarding is disabled. Networking will not work.\ndocker: Error response from daemon: failed to create task for container: failed to create shim task: OCI runtime create failed: runc did not terminate successfully: exit status 2: unknown.", "stderr_lines": ["WARNING: IPv4 forwarding is disabled. Networking will not work.", "docker: Error response from daemon: failed to create task for container: failed to create shim task: OCI runtime create failed: runc did not terminate successfully: exit status 2: unknown."], "stdout": "4499797bf97cbe3b30c12168af59ef8b75d110c89b31d7b189fcdc3ed14bb404", "stdout_lines": ["4499797bf97cbe3b30c12168af59ef8b75d110c89b31d7b189fcdc3ed14bb404"]} 2026-08-13 20:20:52.905351 | ubuntu-focal | 2026-08-13 20:20:52.905555 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-08-13 20:20:52.908154 | ubuntu-focal | ubuntu-focal : ok=38 changed=26 unreachable=0 failed=1 skipped=8 rescued=0 ignored=0 2026-08-13 20:20:52.908201 | ubuntu-focal | 2026-08-13 20:20:52.908217 | ubuntu-focal | 2026-08-13 20:20:52.908229 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-08-13 20:20:52.908243 | ubuntu-focal | Thursday 13 August 2026 20:20:52 +0000 (0:00:00.677) 0:00:45.841 ******* 2026-08-13 20:20:52.908257 | ubuntu-focal | =============================================================================== 2026-08-13 20:20:52.908271 | ubuntu-focal | Update "apt" cache ------------------------------------------------------ 6.09s 2026-08-13 20:20:52.908285 | ubuntu-focal | vexxhost.containers.containerd : Install AppArmor packages -------------- 4.90s 2026-08-13 20:20:52.908299 | ubuntu-focal | Pull workload images ---------------------------------------------------- 4.59s 2026-08-13 20:20:52.908313 | ubuntu-focal | vexxhost.containers.download_artifact : Extract archive ----------------- 4.38s 2026-08-13 20:20:52.908327 | ubuntu-focal | vexxhost.containers.download_artifact : Extract archive ----------------- 3.97s 2026-08-13 20:20:52.908341 | ubuntu-focal | vexxhost.containers.docker : Enable and start service ------------------- 1.54s 2026-08-13 20:20:52.908356 | ubuntu-focal | vexxhost.containers.download_artifact : Download item ------------------- 1.51s 2026-08-13 20:20:52.908370 | ubuntu-focal | Install legacy Docker binaries directly into /usr/bin ------------------- 1.32s 2026-08-13 20:20:52.909315 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.13s 2026-08-13 20:20:52.909327 | ubuntu-focal | vexxhost.containers.containerd : Create folders for configuration ------- 1.08s 2026-08-13 20:20:52.909332 | ubuntu-focal | vexxhost.containers.containerd : Reload systemd ------------------------- 0.97s 2026-08-13 20:20:52.909336 | ubuntu-focal | vexxhost.containers.docker : Install AppArmor packages ------------------ 0.91s 2026-08-13 20:20:52.909340 | ubuntu-focal | vexxhost.containers.package : Update state for tar ---------------------- 0.90s 2026-08-13 20:20:52.909344 | ubuntu-focal | vexxhost.containers.docker : Create links to Docker binaries ------------ 0.87s 2026-08-13 20:20:52.909348 | ubuntu-focal | vexxhost.containers.download_artifact : Download item ------------------- 0.86s 2026-08-13 20:20:52.909352 | ubuntu-focal | Remove versioned Docker binary links ------------------------------------ 0.84s 2026-08-13 20:20:52.909356 | ubuntu-focal | vexxhost.containers.download_artifact : Download item ------------------- 0.83s 2026-08-13 20:20:52.909360 | ubuntu-focal | Start counter workload container ---------------------------------------- 0.68s 2026-08-13 20:20:52.909365 | ubuntu-focal | vexxhost.containers.docker : Create folders for configuration ----------- 0.67s 2026-08-13 20:20:52.909369 | ubuntu-focal | vexxhost.containers.containerd : Create systemd service file for containerd --- 0.66s 2026-08-13 20:20:53.007453 | ubuntu-focal | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.QUTN.docker-upgrade/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/ansible-collection-containers/inventory.yaml /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/docker-upgrade/prepare.yml 2026-08-13 20:20:53.007692 | ubuntu-focal | ERROR [docker-upgrade > prepare] Executed: Failed 2026-08-13 20:20:53.007870 | ubuntu-focal | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.QUTN.docker-upgrade/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/ansible-collection-containers/inventory.yaml /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/docker-upgrade/prepare.yml 2026-08-13 20:20:53.714112 | ubuntu-focal | ERROR 2026-08-13 20:20:53.714303 | ubuntu-focal | { 2026-08-13 20:20:53.714353 | ubuntu-focal | "delta": "0:01:02.451731", 2026-08-13 20:20:53.714395 | ubuntu-focal | "end": "2026-08-13 20:20:53.085129", 2026-08-13 20:20:53.714428 | ubuntu-focal | "msg": "non-zero return code", 2026-08-13 20:20:53.714453 | ubuntu-focal | "rc": 2, 2026-08-13 20:20:53.714479 | ubuntu-focal | "start": "2026-08-13 20:19:50.633398" 2026-08-13 20:20:53.714504 | ubuntu-focal | } failure 2026-08-13 20:20:53.722864 | 2026-08-13 20:20:53.722941 | PLAY RECAP 2026-08-13 20:20:53.722987 | ubuntu-focal | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-13 20:20:53.723008 | 2026-08-13 20:20:53.851599 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-13 20:20:53.853600 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-13 20:20:54.555155 | 2026-08-13 20:20:54.555310 | PLAY [all] 2026-08-13 20:20:54.567704 | 2026-08-13 20:20:54.567787 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-13 20:20:54.614494 | ubuntu-focal | skipping: Conditional result was False 2026-08-13 20:20:54.626174 | 2026-08-13 20:20:54.626563 | TASK [fetch-output : Set log path for single node] 2026-08-13 20:20:54.662446 | ubuntu-focal | ok 2026-08-13 20:20:54.667561 | 2026-08-13 20:20:54.667632 | LOOP [fetch-output : Ensure local output dirs] 2026-08-13 20:20:55.069380 | ubuntu-focal -> localhost | ok: "/var/lib/zuul/builds/1c7c4ad58e714b2e90587d68d3fdbd85/work/logs" 2026-08-13 20:20:55.280296 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/1c7c4ad58e714b2e90587d68d3fdbd85/work/artifacts" 2026-08-13 20:20:55.487033 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/1c7c4ad58e714b2e90587d68d3fdbd85/work/docs" 2026-08-13 20:20:55.502303 | 2026-08-13 20:20:55.502416 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-13 20:20:56.075666 | ubuntu-focal | ok 2026-08-13 20:20:56.075951 | ubuntu-focal | changed: All items complete 2026-08-13 20:20:56.076020 | 2026-08-13 20:20:56.495950 | ubuntu-focal | changed: .d..t...... ./ 2026-08-13 20:20:56.888504 | ubuntu-focal | changed: .d..t...... ./ 2026-08-13 20:20:56.906839 | 2026-08-13 20:20:56.907018 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-13 20:20:57.307918 | ubuntu-focal -> localhost | ok: Item: artifacts Runtime: 0:00:00.006991 2026-08-13 20:20:57.544163 | ubuntu-focal -> localhost | ok: Item: docs Runtime: 0:00:00.008511 2026-08-13 20:20:57.564541 | 2026-08-13 20:20:57.565021 | PLAY [all] 2026-08-13 20:20:57.571230 | 2026-08-13 20:20:57.571315 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-13 20:20:57.944175 | ubuntu-focal | changed 2026-08-13 20:20:57.949845 | 2026-08-13 20:20:57.949892 | PLAY RECAP 2026-08-13 20:20:57.949933 | ubuntu-focal | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-13 20:20:57.949955 | 2026-08-13 20:20:58.047868 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-13 20:20:58.049013 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-13 20:20:58.612813 | 2026-08-13 20:20:58.613247 | PLAY [localhost] 2026-08-13 20:20:58.623736 | 2026-08-13 20:20:58.623808 | TASK [Generate Zuul manifest] 2026-08-13 20:20:58.643027 | localhost | ok 2026-08-13 20:20:58.659942 | 2026-08-13 20:20:58.660024 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-13 20:20:59.049796 | localhost | changed 2026-08-13 20:20:59.061183 | 2026-08-13 20:20:59.061257 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-13 20:20:59.092598 | localhost | ok 2026-08-13 20:20:59.100307 | 2026-08-13 20:20:59.100373 | TASK [Upload logs] 2026-08-13 20:20:59.121148 | localhost | ok 2026-08-13 20:20:59.177980 | 2026-08-13 20:20:59.178084 | TASK [Set zuul-log-path fact] 2026-08-13 20:20:59.198015 | localhost | ok 2026-08-13 20:20:59.211898 | 2026-08-13 20:20:59.211965 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-13 20:20:59.243110 | localhost | ok 2026-08-13 20:20:59.250562 | 2026-08-13 20:20:59.250628 | TASK [upload-logs : Create log directories] 2026-08-13 20:20:59.669410 | localhost | changed 2026-08-13 20:20:59.677221 | 2026-08-13 20:20:59.677302 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-13 20:21:00.057060 | localhost -> localhost | ok: Runtime: 0:00:00.005085 2026-08-13 20:21:00.063505 | 2026-08-13 20:21:00.063580 | TASK [upload-logs : Upload logs to log server] 2026-08-13 20:21:00.494796 | localhost | Output suppressed because no_log was given 2026-08-13 20:21:00.500571 | 2026-08-13 20:21:00.500671 | LOOP [upload-logs : Compress console log and json output] 2026-08-13 20:21:00.544234 | localhost | skipping: Conditional result was False 2026-08-13 20:21:00.551869 | localhost | skipping: Conditional result was False 2026-08-13 20:21:00.568033 | 2026-08-13 20:21:00.568219 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-13 20:21:00.608467 | localhost | skipping: Conditional result was False 2026-08-13 20:21:00.608983 | 2026-08-13 20:21:00.612686 | localhost | skipping: Conditional result was False 2026-08-13 20:21:00.623712 | 2026-08-13 20:21:00.623974 | LOOP [upload-logs : Upload console log and json output]