2024-01-04 18:35:24.192423 | Job console starting... 2024-01-04 18:35:28.324413 | Running Ansible setup... 2024-01-04 18:35:33.298942 | PRE-RUN START: [trusted : github.com/openstack-charmers/zosci-config/playbooks/base/pre.yaml@master] 2024-01-04 18:35:36.140682 | 2024-01-04 18:35:36.140882 | PLAY [all] 2024-01-04 18:35:36.167720 | 2024-01-04 18:35:36.167897 | TASK [Gathering Facts] 2024-01-04 18:35:37.588751 | focal-medium | ok 2024-01-04 18:35:37.639268 | 2024-01-04 18:35:37.639508 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2024-01-04 18:35:38.137163 | focal-medium | ok 2024-01-04 18:35:38.182343 | 2024-01-04 18:35:38.182792 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2024-01-04 18:35:38.302652 | focal-medium | ok 2024-01-04 18:35:38.367910 | focal-medium | included: /var/lib/zuul/builds/6720072d572c4215a3d18461c72c93ec/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2024-01-04 18:35:38.383007 | 2024-01-04 18:35:38.383218 | TASK [add-build-sshkey : Create Temp SSH key] 2024-01-04 18:35:39.605654 | focal-medium | ok: Runtime: 0:00:00.489747 2024-01-04 18:35:39.629463 | 2024-01-04 18:35:39.629748 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2024-01-04 18:35:39.741729 | focal-medium | ok 2024-01-04 18:35:39.780929 | focal-medium | included: /var/lib/zuul/builds/6720072d572c4215a3d18461c72c93ec/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2024-01-04 18:35:39.801629 | 2024-01-04 18:35:39.801928 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2024-01-04 18:35:39.854681 | focal-medium | skipping: Conditional result was False 2024-01-04 18:35:39.880025 | 2024-01-04 18:35:39.880270 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2024-01-04 18:35:40.713580 | focal-medium | changed 2024-01-04 18:35:40.737553 | 2024-01-04 18:35:40.737808 | TASK [add-build-sshkey : Make sure user has a .ssh] 2024-01-04 18:35:41.387805 | focal-medium | ok 2024-01-04 18:35:41.422159 | 2024-01-04 18:35:41.422512 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2024-01-04 18:35:42.562817 | focal-medium | changed 2024-01-04 18:35:42.593631 | 2024-01-04 18:35:42.593917 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2024-01-04 18:35:43.375384 | focal-medium | changed 2024-01-04 18:35:43.399894 | 2024-01-04 18:35:43.400148 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2024-01-04 18:35:43.516405 | focal-medium | skipping: Conditional result was False 2024-01-04 18:35:43.556600 | 2024-01-04 18:35:43.557006 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2024-01-04 18:35:44.158437 | focal-medium | changed 2024-01-04 18:35:44.192433 | 2024-01-04 18:35:44.192704 | TASK [add-build-sshkey : Add back temp key] 2024-01-04 18:35:44.528778 | focal-medium | ok: Runtime: 0:00:00.012730 2024-01-04 18:35:44.555825 | 2024-01-04 18:35:44.556081 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2024-01-04 18:35:45.165881 | focal-medium | ok 2024-01-04 18:35:45.196263 | 2024-01-04 18:35:45.196504 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2024-01-04 18:35:45.313950 | focal-medium | skipping: Conditional result was False 2024-01-04 18:35:45.344312 | 2024-01-04 18:35:45.344718 | TASK [prepare-workspace : Start zuul_console daemon.] 2024-01-04 18:35:46.073396 | focal-medium | ok 2024-01-04 18:35:46.099360 | 2024-01-04 18:35:46.099602 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2024-01-04 18:35:47.991604 | focal-medium | Output suppressed because no_log was given 2024-01-04 18:35:48.025380 | 2024-01-04 18:35:48.025689 | TASK [prepare-package-environment : Stop unattended-upgrades service] 2024-01-04 18:35:49.097398 | focal-medium | changed 2024-01-04 18:35:49.134139 | 2024-01-04 18:35:49.134438 | TASK [prepare-package-environment : Wait for apt lock] 2024-01-04 18:35:49.725640 | focal-medium | ok: Runtime: 0:00:00.081855 2024-01-04 18:35:49.748764 | 2024-01-04 18:35:49.748994 | TASK [prepare-package-environment : Remove unattended-upgrades] 2024-01-04 18:36:44.931853 | focal-medium | changed 2024-01-04 18:36:44.968202 | 2024-01-04 18:36:44.968935 | TASK [prepare-package-environment : Wait for apt lock] 2024-01-04 18:36:45.672078 | focal-medium | ok: Runtime: 0:00:00.075728 2024-01-04 18:36:45.698337 | 2024-01-04 18:36:45.698602 | TASK [prepare-package-environment : apt-get update] 2024-01-04 18:36:59.156375 | focal-medium | changed 2024-01-04 18:36:59.198146 | 2024-01-04 18:36:59.198543 | TASK [prepare-package-environment : Wait for apt lock] 2024-01-04 18:36:59.786725 | focal-medium | ok: Runtime: 0:00:00.079089 2024-01-04 18:36:59.827890 | 2024-01-04 18:36:59.828146 | TASK [prepare-package-environment : apt install dist-upgrade] 2024-01-04 18:38:32.759357 | focal-medium | changed: 2024-01-04 18:38:32.760338 | focal-medium | Reading package lists... 2024-01-04 18:38:32.760428 | focal-medium | Building dependency tree... 2024-01-04 18:38:32.760481 | focal-medium | Reading state information... 2024-01-04 18:38:32.760525 | focal-medium | Calculating upgrade... 2024-01-04 18:38:32.760567 | focal-medium | The following NEW packages will be installed: 2024-01-04 18:38:32.760651 | focal-medium | linux-headers-5.4.0-169 linux-headers-5.4.0-169-generic 2024-01-04 18:38:32.760699 | focal-medium | linux-image-5.4.0-169-generic linux-modules-5.4.0-169-generic 2024-01-04 18:38:32.760740 | focal-medium | ubuntu-pro-client-l10n 2024-01-04 18:38:32.760779 | focal-medium | The following packages will be upgraded: 2024-01-04 18:38:32.760818 | focal-medium | apparmor apt apt-utils bind9-dnsutils bind9-host bind9-libs cloud-init curl 2024-01-04 18:38:32.760858 | focal-medium | distro-info-data gawk grub-efi-amd64-bin grub-efi-amd64-signed kpartx 2024-01-04 18:38:32.760924 | focal-medium | krb5-locales libapparmor1 libapt-pkg6.0 libc-bin libc6 libcurl3-gnutls 2024-01-04 18:38:32.761009 | focal-medium | libcurl4 libelf1 libgnutls30 libgssapi-krb5-2 libk5crypto3 libkrb5-3 2024-01-04 18:38:32.761057 | focal-medium | libkrb5support0 libnetplan0 libnghttp2-14 libperl5.30 libprocps8 2024-01-04 18:38:32.761098 | focal-medium | libpython3.8 libpython3.8-minimal libpython3.8-stdlib libsqlite3-0 libssh-4 2024-01-04 18:38:32.761139 | focal-medium | libssl1.1 libx11-6 libx11-data linux-headers-generic linux-headers-virtual 2024-01-04 18:38:32.761179 | focal-medium | linux-image-virtual linux-virtual locales mokutil multipath-tools netplan.io 2024-01-04 18:38:32.761219 | focal-medium | open-vm-tools openssh-client openssh-server openssh-sftp-server openssl perl 2024-01-04 18:38:32.761259 | focal-medium | perl-base perl-modules-5.30 procps python3-cryptography 2024-01-04 18:38:32.761298 | focal-medium | python3-update-manager python3-urllib3 python3.8 python3.8-minimal rsync 2024-01-04 18:38:32.761337 | focal-medium | sosreport tar ubuntu-advantage-tools update-manager-core vim vim-common 2024-01-04 18:38:32.761376 | focal-medium | vim-runtime vim-tiny xxd 2024-01-04 18:38:32.761416 | focal-medium | 70 upgraded, 5 newly installed, 0 to remove and 0 not upgraded. 2024-01-04 18:38:32.761455 | focal-medium | Need to get 85.2 MB of archives. 2024-01-04 18:38:32.761536 | focal-medium | After this operation, 179 MB of additional disk space will be used. 2024-01-04 18:38:32.761589 | focal-medium | Get:1 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libperl5.30 amd64 5.30.0-9ubuntu0.5 [3941 kB] 2024-01-04 18:38:32.761631 | focal-medium | Get:2 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 perl amd64 5.30.0-9ubuntu0.5 [224 kB] 2024-01-04 18:38:32.761696 | focal-medium | Get:3 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 perl-base amd64 5.30.0-9ubuntu0.5 [1514 kB] 2024-01-04 18:38:32.761745 | focal-medium | Get:4 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 perl-modules-5.30 all 5.30.0-9ubuntu0.5 [2739 kB] 2024-01-04 18:38:32.761822 | focal-medium | Get:5 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libc6 amd64 2.31-0ubuntu9.14 [2725 kB] 2024-01-04 18:38:32.761872 | focal-medium | Get:6 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 tar amd64 1.30+dfsg-7ubuntu0.20.04.4 [240 kB] 2024-01-04 18:38:32.761972 | focal-medium | Get:7 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 locales all 2.31-0ubuntu9.14 [3871 kB] 2024-01-04 18:38:32.762030 | focal-medium | Get:8 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libc-bin amd64 2.31-0ubuntu9.14 [635 kB] 2024-01-04 18:38:32.762070 | focal-medium | Get:9 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libapt-pkg6.0 amd64 2.0.10 [843 kB] 2024-01-04 18:38:32.762110 | focal-medium | Get:10 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 apt amd64 2.0.10 [1280 kB] 2024-01-04 18:38:32.762148 | focal-medium | Get:11 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 apt-utils amd64 2.0.10 [213 kB] 2024-01-04 18:38:32.762186 | focal-medium | Get:12 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libgnutls30 amd64 3.6.13-2ubuntu1.9 [828 kB] 2024-01-04 18:38:32.762225 | focal-medium | Get:13 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libpython3.8 amd64 3.8.10-0ubuntu1~20.04.9 [1625 kB] 2024-01-04 18:38:32.762264 | focal-medium | Get:14 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libssl1.1 amd64 1.1.1f-1ubuntu2.20 [1321 kB] 2024-01-04 18:38:32.762304 | focal-medium | Get:15 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 python3.8 amd64 3.8.10-0ubuntu1~20.04.9 [387 kB] 2024-01-04 18:38:32.762342 | focal-medium | Get:16 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libpython3.8-stdlib amd64 3.8.10-0ubuntu1~20.04.9 [1674 kB] 2024-01-04 18:38:32.762381 | focal-medium | Get:17 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 python3.8-minimal amd64 3.8.10-0ubuntu1~20.04.9 [1890 kB] 2024-01-04 18:38:32.762420 | focal-medium | Get:18 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libpython3.8-minimal amd64 3.8.10-0ubuntu1~20.04.9 [718 kB] 2024-01-04 18:38:32.762460 | focal-medium | Get:19 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libsqlite3-0 amd64 3.31.1-4ubuntu0.6 [549 kB] 2024-01-04 18:38:32.762499 | focal-medium | Get:20 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 rsync amd64 3.1.3-8ubuntu0.7 [322 kB] 2024-01-04 18:38:32.762538 | focal-medium | Get:21 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 gawk amd64 1:5.0.1+dfsg-1ubuntu0.1 [415 kB] 2024-01-04 18:38:32.762577 | focal-medium | Get:22 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libprocps8 amd64 2:3.3.16-1ubuntu2.4 [33.1 kB] 2024-01-04 18:38:32.762616 | focal-medium | Get:23 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 procps amd64 2:3.3.16-1ubuntu2.4 [232 kB] 2024-01-04 18:38:32.762653 | focal-medium | Get:24 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 open-vm-tools amd64 2:11.3.0-2ubuntu0~ubuntu20.04.7 [649 kB] 2024-01-04 18:38:32.762754 | focal-medium | Get:25 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 distro-info-data all 0.43ubuntu1.15 [4956 B] 2024-01-04 18:38:32.762807 | focal-medium | Get:26 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libapparmor1 amd64 2.13.3-7ubuntu5.3 [35.4 kB] 2024-01-04 18:38:32.762848 | focal-medium | Get:27 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libelf1 amd64 0.176-1.1ubuntu0.1 [44.2 kB] 2024-01-04 18:38:32.762888 | focal-medium | Get:28 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 netplan.io amd64 0.104-0ubuntu2~20.04.4 [88.2 kB] 2024-01-04 18:38:32.763043 | focal-medium | Get:29 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libnetplan0 amd64 0.104-0ubuntu2~20.04.4 [82.2 kB] 2024-01-04 18:38:32.763115 | focal-medium | Get:30 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 openssl amd64 1.1.1f-1ubuntu2.20 [620 kB] 2024-01-04 18:38:32.763160 | focal-medium | Get:31 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 ubuntu-advantage-tools amd64 30~20.04 [203 kB] 2024-01-04 18:38:32.763421 | focal-medium | Get:32 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 ubuntu-pro-client-l10n amd64 30~20.04 [18.4 kB] 2024-01-04 18:38:32.763486 | focal-medium | Get:33 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 vim amd64 2:8.1.2269-1ubuntu5.21 [1243 kB] 2024-01-04 18:38:32.763546 | focal-medium | Get:34 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 vim-tiny amd64 2:8.1.2269-1ubuntu5.21 [582 kB] 2024-01-04 18:38:32.763613 | focal-medium | Get:35 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 vim-runtime all 2:8.1.2269-1ubuntu5.21 [5878 kB] 2024-01-04 18:38:32.763657 | focal-medium | Get:36 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 xxd amd64 2:8.1.2269-1ubuntu5.21 [53.2 kB] 2024-01-04 18:38:32.763697 | focal-medium | Get:37 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 vim-common all 2:8.1.2269-1ubuntu5.21 [88.2 kB] 2024-01-04 18:38:32.763736 | focal-medium | Get:38 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 apparmor amd64 2.13.3-7ubuntu5.3 [502 kB] 2024-01-04 18:38:32.763775 | focal-medium | Get:39 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libgssapi-krb5-2 amd64 1.17-6ubuntu4.4 [121 kB] 2024-01-04 18:38:32.763814 | focal-medium | Get:40 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libkrb5-3 amd64 1.17-6ubuntu4.4 [330 kB] 2024-01-04 18:38:32.763852 | focal-medium | Get:41 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libkrb5support0 amd64 1.17-6ubuntu4.4 [31.0 kB] 2024-01-04 18:38:32.763891 | focal-medium | Get:42 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libk5crypto3 amd64 1.17-6ubuntu4.4 [79.9 kB] 2024-01-04 18:38:32.763930 | focal-medium | Get:43 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 bind9-dnsutils amd64 1:9.16.1-0ubuntu2.16 [134 kB] 2024-01-04 18:38:32.763976 | focal-medium | Get:44 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 bind9-libs amd64 1:9.16.1-0ubuntu2.16 [1108 kB] 2024-01-04 18:38:32.764068 | focal-medium | Get:45 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 bind9-host amd64 1:9.16.1-0ubuntu2.16 [43.0 kB] 2024-01-04 18:38:32.764151 | focal-medium | Get:46 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 krb5-locales all 1.17-6ubuntu4.4 [11.5 kB] 2024-01-04 18:38:32.764199 | focal-medium | Get:47 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libx11-data all 2:1.6.9-2ubuntu1.6 [114 kB] 2024-01-04 18:38:32.764239 | focal-medium | Get:48 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libx11-6 amd64 2:1.6.9-2ubuntu1.6 [577 kB] 2024-01-04 18:38:32.764279 | focal-medium | Get:49 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 openssh-sftp-server amd64 1:8.2p1-4ubuntu0.11 [51.7 kB] 2024-01-04 18:38:32.764318 | focal-medium | Get:50 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 openssh-server amd64 1:8.2p1-4ubuntu0.11 [378 kB] 2024-01-04 18:38:32.764357 | focal-medium | Get:51 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 openssh-client amd64 1:8.2p1-4ubuntu0.11 [670 kB] 2024-01-04 18:38:32.764395 | focal-medium | Get:52 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 python3-update-manager all 1:20.04.10.18 [38.3 kB] 2024-01-04 18:38:32.764433 | focal-medium | Get:53 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 update-manager-core all 1:20.04.10.18 [11.6 kB] 2024-01-04 18:38:32.764483 | focal-medium | Get:54 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libnghttp2-14 amd64 1.40.0-1ubuntu0.2 [79.4 kB] 2024-01-04 18:38:32.764527 | focal-medium | Get:55 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libssh-4 amd64 0.9.3-2ubuntu2.4 [171 kB] 2024-01-04 18:38:32.764566 | focal-medium | Get:56 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 curl amd64 7.68.0-1ubuntu2.21 [161 kB] 2024-01-04 18:38:32.764669 | focal-medium | Get:57 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libcurl4 amd64 7.68.0-1ubuntu2.21 [235 kB] 2024-01-04 18:38:32.764723 | focal-medium | Get:58 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 grub-efi-amd64-signed amd64 1.187.6~20.04.1+2.06-2ubuntu14.4 [1343 kB] 2024-01-04 18:38:32.764764 | focal-medium | Get:59 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 grub-efi-amd64-bin amd64 2.06-2ubuntu14.4 [1592 kB] 2024-01-04 18:38:32.764803 | focal-medium | Get:60 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 libcurl3-gnutls amd64 7.68.0-1ubuntu2.21 [232 kB] 2024-01-04 18:38:32.764843 | focal-medium | Get:61 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 linux-headers-5.4.0-169 all 5.4.0-169.187 [11.0 MB] 2024-01-04 18:38:32.764882 | focal-medium | Get:62 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 linux-headers-5.4.0-169-generic amd64 5.4.0-169.187 [1374 kB] 2024-01-04 18:38:32.764963 | focal-medium | Get:63 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 linux-modules-5.4.0-169-generic amd64 5.4.0-169.187 [15.0 MB] 2024-01-04 18:38:32.765019 | focal-medium | Get:64 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 linux-image-5.4.0-169-generic amd64 5.4.0-169.187 [10.5 MB] 2024-01-04 18:38:32.765060 | focal-medium | Get:65 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 linux-virtual amd64 5.4.0.169.167 [1876 B] 2024-01-04 18:38:32.765132 | focal-medium | Get:66 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 linux-image-virtual amd64 5.4.0.169.167 [2496 B] 2024-01-04 18:38:32.765185 | focal-medium | Get:67 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 linux-headers-virtual amd64 5.4.0.169.167 [1840 B] 2024-01-04 18:38:32.765226 | focal-medium | Get:68 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 linux-headers-generic amd64 5.4.0.169.167 [2392 B] 2024-01-04 18:38:32.765266 | focal-medium | Get:69 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 mokutil amd64 0.6.0-2~20.04.2 [26.6 kB] 2024-01-04 18:38:32.765305 | focal-medium | Get:70 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 python3-cryptography amd64 2.8-3ubuntu0.2 [211 kB] 2024-01-04 18:38:32.765345 | focal-medium | Get:71 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 python3-urllib3 all 1.25.8-2ubuntu0.3 [88.7 kB] 2024-01-04 18:38:32.765385 | focal-medium | Get:72 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 sosreport amd64 4.5.6-0ubuntu1~20.04.2 [329 kB] 2024-01-04 18:38:32.765423 | focal-medium | Get:73 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 cloud-init all 23.3.3-0ubuntu0~20.04.1 [546 kB] 2024-01-04 18:38:32.765462 | focal-medium | Get:74 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 kpartx amd64 0.8.3-1ubuntu2.3 [28.2 kB] 2024-01-04 18:38:32.765529 | focal-medium | Get:75 http://nova.clouds.archive.ubuntu.com/ubuntu focal-updates/main amd64 multipath-tools amd64 0.8.3-1ubuntu2.3 [289 kB] 2024-01-04 18:38:32.765577 | focal-medium | Preconfiguring packages ... 2024-01-04 18:38:32.765617 | focal-medium | Fetched 85.2 MB in 3s (32.1 MB/s) 2024-01-04 18:38:32.765659 | focal-medium | (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 64024 files and directories currently installed.) 2024-01-04 18:38:32.765746 | focal-medium | Preparing to unpack .../libperl5.30_5.30.0-9ubuntu0.5_amd64.deb ... 2024-01-04 18:38:32.765797 | focal-medium | Unpacking libperl5.30:amd64 (5.30.0-9ubuntu0.5) over (5.30.0-9ubuntu0.4) ... 2024-01-04 18:38:32.765837 | focal-medium | Preparing to unpack .../perl_5.30.0-9ubuntu0.5_amd64.deb ... 2024-01-04 18:38:32.765878 | focal-medium | Unpacking perl (5.30.0-9ubuntu0.5) over (5.30.0-9ubuntu0.4) ... 2024-01-04 18:38:32.765918 | focal-medium | Preparing to unpack .../perl-base_5.30.0-9ubuntu0.5_amd64.deb ... 2024-01-04 18:38:32.765956 | focal-medium | Unpacking perl-base (5.30.0-9ubuntu0.5) over (5.30.0-9ubuntu0.4) ... 2024-01-04 18:38:32.765995 | focal-medium | Setting up perl-base (5.30.0-9ubuntu0.5) ... 2024-01-04 18:38:32.766035 | focal-medium | (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 64024 files and directories currently installed.) 2024-01-04 18:38:32.766075 | focal-medium | Preparing to unpack .../perl-modules-5.30_5.30.0-9ubuntu0.5_all.deb ... 2024-01-04 18:38:32.766114 | focal-medium | Unpacking perl-modules-5.30 (5.30.0-9ubuntu0.5) over (5.30.0-9ubuntu0.4) ... 2024-01-04 18:38:32.766153 | focal-medium | Preparing to unpack .../libc6_2.31-0ubuntu9.14_amd64.deb ... 2024-01-04 18:38:32.766190 | focal-medium | Unpacking libc6:amd64 (2.31-0ubuntu9.14) over (2.31-0ubuntu9.9) ... 2024-01-04 18:38:32.766228 | focal-medium | Setting up libc6:amd64 (2.31-0ubuntu9.14) ... 2024-01-04 18:38:32.766267 | focal-medium | (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 64024 files and directories currently installed.) 2024-01-04 18:38:32.766307 | focal-medium | Preparing to unpack .../tar_1.30+dfsg-7ubuntu0.20.04.4_amd64.deb ... 2024-01-04 18:38:32.766346 | focal-medium | Unpacking tar (1.30+dfsg-7ubuntu0.20.04.4) over (1.30+dfsg-7ubuntu0.20.04.3) ... 2024-01-04 18:38:32.766384 | focal-medium | Setting up tar (1.30+dfsg-7ubuntu0.20.04.4) ... 2024-01-04 18:38:32.766422 | focal-medium | (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 64024 files and directories currently installed.) 2024-01-04 18:38:32.766471 | focal-medium | Preparing to unpack .../locales_2.31-0ubuntu9.14_all.deb ... 2024-01-04 18:38:32.766514 | focal-medium | Unpacking locales (2.31-0ubuntu9.14) over (2.31-0ubuntu9.9) ... 2024-01-04 18:38:32.766554 | focal-medium | Preparing to unpack .../libc-bin_2.31-0ubuntu9.14_amd64.deb ... 2024-01-04 18:38:32.766593 | focal-medium | Unpacking libc-bin (2.31-0ubuntu9.14) over (2.31-0ubuntu9.9) ... 2024-01-04 18:38:32.766632 | focal-medium | Setting up libc-bin (2.31-0ubuntu9.14) ... 2024-01-04 18:38:32.766672 | focal-medium | (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 64024 files and directories currently installed.) 2024-01-04 18:38:32.766713 | focal-medium | Preparing to unpack .../libapt-pkg6.0_2.0.10_amd64.deb ... 2024-01-04 18:38:32.766757 | focal-medium | Unpacking libapt-pkg6.0:amd64 (2.0.10) over (2.0.9) ... 2024-01-04 18:38:32.766794 | focal-medium | Setting up libapt-pkg6.0:amd64 (2.0.10) ... 2024-01-04 18:38:32.766833 | focal-medium | (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 64024 files and directories currently installed.) 2024-01-04 18:38:32.766873 | focal-medium | Preparing to unpack .../archives/apt_2.0.10_amd64.deb ... 2024-01-04 18:38:32.766912 | focal-medium | Unpacking apt (2.0.10) over (2.0.9) ... 2024-01-04 18:38:32.766950 | focal-medium | Setting up apt (2.0.10) ... 2024-01-04 18:38:32.766988 | focal-medium | (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 64022 files and directories currently installed.) 2024-01-04 18:38:32.767027 | focal-medium | Preparing to unpack .../apt-utils_2.0.10_amd64.deb ... 2024-01-04 18:38:32.767134 | focal-medium | Unpacking apt-utils (2.0.10) over (2.0.9) ... 2024-01-04 18:38:32.767187 | focal-medium | Preparing to unpack .../libgnutls30_3.6.13-2ubuntu1.9_amd64.deb ... 2024-01-04 18:38:32.767227 | focal-medium | Unpacking libgnutls30:amd64 (3.6.13-2ubuntu1.9) over (3.6.13-2ubuntu1.8) ... 2024-01-04 18:38:32.767270 | focal-medium | Setting up libgnutls30:amd64 (3.6.13-2ubuntu1.9) ... 2024-01-04 18:38:32.767309 | focal-medium | (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 64022 files and directories currently installed.) 2024-01-04 18:38:32.767361 | focal-medium | Preparing to unpack .../00-libpython3.8_3.8.10-0ubuntu1~20.04.9_amd64.deb ... 2024-01-04 18:38:32.767404 | focal-medium | Unpacking libpython3.8:amd64 (3.8.10-0ubuntu1~20.04.9) over (3.8.10-0ubuntu1~20.04.8) ... 2024-01-04 18:38:32.767443 | focal-medium | Preparing to unpack .../01-libssl1.1_1.1.1f-1ubuntu2.20_amd64.deb ... 2024-01-04 18:38:32.767482 | focal-medium | Unpacking libssl1.1:amd64 (1.1.1f-1ubuntu2.20) over (1.1.1f-1ubuntu2.19) ... 2024-01-04 18:38:32.767520 | focal-medium | Preparing to unpack .../02-python3.8_3.8.10-0ubuntu1~20.04.9_amd64.deb ... 2024-01-04 18:38:32.767557 | focal-medium | Unpacking python3.8 (3.8.10-0ubuntu1~20.04.9) over (3.8.10-0ubuntu1~20.04.8) ... 2024-01-04 18:38:32.767594 | focal-medium | Preparing to unpack .../03-libpython3.8-stdlib_3.8.10-0ubuntu1~20.04.9_amd64.deb ... 2024-01-04 18:38:32.767632 | focal-medium | Unpacking libpython3.8-stdlib:amd64 (3.8.10-0ubuntu1~20.04.9) over (3.8.10-0ubuntu1~20.04.8) ... 2024-01-04 18:38:32.767669 | focal-medium | Preparing to unpack .../04-python3.8-minimal_3.8.10-0ubuntu1~20.04.9_amd64.deb ... 2024-01-04 18:38:32.767707 | focal-medium | Unpacking python3.8-minimal (3.8.10-0ubuntu1~20.04.9) over (3.8.10-0ubuntu1~20.04.8) ... 2024-01-04 18:38:32.767745 | focal-medium | Preparing to unpack .../05-libpython3.8-minimal_3.8.10-0ubuntu1~20.04.9_amd64.deb ... 2024-01-04 18:38:32.767782 | focal-medium | Unpacking libpython3.8-minimal:amd64 (3.8.10-0ubuntu1~20.04.9) over (3.8.10-0ubuntu1~20.04.8) ... 2024-01-04 18:38:32.767820 | focal-medium | Preparing to unpack .../06-libsqlite3-0_3.31.1-4ubuntu0.6_amd64.deb ... 2024-01-04 18:38:32.767858 | focal-medium | Unpacking libsqlite3-0:amd64 (3.31.1-4ubuntu0.6) over (3.31.1-4ubuntu0.5) ... 2024-01-04 18:38:32.767896 | focal-medium | Preparing to unpack .../07-rsync_3.1.3-8ubuntu0.7_amd64.deb ... 2024-01-04 18:38:32.767934 | focal-medium | Unpacking rsync (3.1.3-8ubuntu0.7) over (3.1.3-8ubuntu0.5) ... 2024-01-04 18:38:32.767973 | focal-medium | Preparing to unpack .../08-gawk_1%3a5.0.1+dfsg-1ubuntu0.1_amd64.deb ... 2024-01-04 18:38:32.768011 | focal-medium | Unpacking gawk (1:5.0.1+dfsg-1ubuntu0.1) over (1:5.0.1+dfsg-1) ... 2024-01-04 18:38:32.768049 | focal-medium | Preparing to unpack .../09-libprocps8_2%3a3.3.16-1ubuntu2.4_amd64.deb ... 2024-01-04 18:38:32.768088 | focal-medium | Unpacking libprocps8:amd64 (2:3.3.16-1ubuntu2.4) over (2:3.3.16-1ubuntu2.3) ... 2024-01-04 18:38:32.768190 | focal-medium | Preparing to unpack .../10-procps_2%3a3.3.16-1ubuntu2.4_amd64.deb ... 2024-01-04 18:38:32.768253 | focal-medium | Unpacking procps (2:3.3.16-1ubuntu2.4) over (2:3.3.16-1ubuntu2.3) ... 2024-01-04 18:38:32.768293 | focal-medium | Preparing to unpack .../11-open-vm-tools_2%3a11.3.0-2ubuntu0~ubuntu20.04.7_amd64.deb ... 2024-01-04 18:38:32.768331 | focal-medium | Unpacking open-vm-tools (2:11.3.0-2ubuntu0~ubuntu20.04.7) over (2:11.3.0-2ubuntu0~ubuntu20.04.5) ... 2024-01-04 18:38:32.768371 | focal-medium | Preparing to unpack .../12-distro-info-data_0.43ubuntu1.15_all.deb ... 2024-01-04 18:38:32.768410 | focal-medium | Unpacking distro-info-data (0.43ubuntu1.15) over (0.43ubuntu1.13) ... 2024-01-04 18:38:32.768447 | focal-medium | Preparing to unpack .../13-libapparmor1_2.13.3-7ubuntu5.3_amd64.deb ... 2024-01-04 18:38:32.768484 | focal-medium | Unpacking libapparmor1:amd64 (2.13.3-7ubuntu5.3) over (2.13.3-7ubuntu5.2) ... 2024-01-04 18:38:32.768521 | focal-medium | Preparing to unpack .../14-libelf1_0.176-1.1ubuntu0.1_amd64.deb ... 2024-01-04 18:38:32.768559 | focal-medium | Unpacking libelf1:amd64 (0.176-1.1ubuntu0.1) over (0.176-1.1build1) ... 2024-01-04 18:38:32.768637 | focal-medium | Preparing to unpack .../15-netplan.io_0.104-0ubuntu2~20.04.4_amd64.deb ... 2024-01-04 18:38:32.768685 | focal-medium | Unpacking netplan.io (0.104-0ubuntu2~20.04.4) over (0.104-0ubuntu2~20.04.2) ... 2024-01-04 18:38:32.768724 | focal-medium | Preparing to unpack .../16-libnetplan0_0.104-0ubuntu2~20.04.4_amd64.deb ... 2024-01-04 18:38:32.768773 | focal-medium | Unpacking libnetplan0:amd64 (0.104-0ubuntu2~20.04.4) over (0.104-0ubuntu2~20.04.2) ... 2024-01-04 18:38:32.768817 | focal-medium | Preparing to unpack .../17-openssl_1.1.1f-1ubuntu2.20_amd64.deb ... 2024-01-04 18:38:32.768857 | focal-medium | Unpacking openssl (1.1.1f-1ubuntu2.20) over (1.1.1f-1ubuntu2.19) ... 2024-01-04 18:38:32.768899 | focal-medium | Preparing to unpack .../18-ubuntu-advantage-tools_30~20.04_amd64.deb ... 2024-01-04 18:38:32.768990 | focal-medium | Unpacking ubuntu-advantage-tools (30~20.04) over (28.1~20.04) ... 2024-01-04 18:38:32.769042 | focal-medium | Selecting previously unselected package ubuntu-pro-client-l10n. 2024-01-04 18:38:32.769082 | focal-medium | Preparing to unpack .../19-ubuntu-pro-client-l10n_30~20.04_amd64.deb ... 2024-01-04 18:38:32.769120 | focal-medium | Unpacking ubuntu-pro-client-l10n (30~20.04) ... 2024-01-04 18:38:32.769159 | focal-medium | Preparing to unpack .../20-vim_2%3a8.1.2269-1ubuntu5.21_amd64.deb ... 2024-01-04 18:38:32.769197 | focal-medium | Unpacking vim (2:8.1.2269-1ubuntu5.21) over (2:8.1.2269-1ubuntu5.17) ... 2024-01-04 18:38:32.769235 | focal-medium | Preparing to unpack .../21-vim-tiny_2%3a8.1.2269-1ubuntu5.21_amd64.deb ... 2024-01-04 18:38:32.769273 | focal-medium | Unpacking vim-tiny (2:8.1.2269-1ubuntu5.21) over (2:8.1.2269-1ubuntu5.17) ... 2024-01-04 18:38:32.769311 | focal-medium | Preparing to unpack .../22-vim-runtime_2%3a8.1.2269-1ubuntu5.21_all.deb ... 2024-01-04 18:38:32.769349 | focal-medium | Unpacking vim-runtime (2:8.1.2269-1ubuntu5.21) over (2:8.1.2269-1ubuntu5.17) ... 2024-01-04 18:38:32.769388 | focal-medium | Preparing to unpack .../23-xxd_2%3a8.1.2269-1ubuntu5.21_amd64.deb ... 2024-01-04 18:38:32.769426 | focal-medium | Unpacking xxd (2:8.1.2269-1ubuntu5.21) over (2:8.1.2269-1ubuntu5.17) ... 2024-01-04 18:38:32.769464 | focal-medium | Preparing to unpack .../24-vim-common_2%3a8.1.2269-1ubuntu5.21_all.deb ... 2024-01-04 18:38:32.769544 | focal-medium | Unpacking vim-common (2:8.1.2269-1ubuntu5.21) over (2:8.1.2269-1ubuntu5.17) ... 2024-01-04 18:38:32.769590 | focal-medium | Preparing to unpack .../25-apparmor_2.13.3-7ubuntu5.3_amd64.deb ... 2024-01-04 18:38:32.769631 | focal-medium | Unpacking apparmor (2.13.3-7ubuntu5.3) over (2.13.3-7ubuntu5.2) ... 2024-01-04 18:38:32.769669 | focal-medium | Preparing to unpack .../26-libgssapi-krb5-2_1.17-6ubuntu4.4_amd64.deb ... 2024-01-04 18:38:32.769708 | focal-medium | Unpacking libgssapi-krb5-2:amd64 (1.17-6ubuntu4.4) over (1.17-6ubuntu4.3) ... 2024-01-04 18:38:32.769748 | focal-medium | Preparing to unpack .../27-libkrb5-3_1.17-6ubuntu4.4_amd64.deb ... 2024-01-04 18:38:32.769786 | focal-medium | Unpacking libkrb5-3:amd64 (1.17-6ubuntu4.4) over (1.17-6ubuntu4.3) ... 2024-01-04 18:38:32.769825 | focal-medium | Preparing to unpack .../28-libkrb5support0_1.17-6ubuntu4.4_amd64.deb ... 2024-01-04 18:38:32.769864 | focal-medium | Unpacking libkrb5support0:amd64 (1.17-6ubuntu4.4) over (1.17-6ubuntu4.3) ... 2024-01-04 18:38:32.769903 | focal-medium | Preparing to unpack .../29-libk5crypto3_1.17-6ubuntu4.4_amd64.deb ... 2024-01-04 18:38:32.769948 | focal-medium | Unpacking libk5crypto3:amd64 (1.17-6ubuntu4.4) over (1.17-6ubuntu4.3) ... 2024-01-04 18:38:32.770231 | focal-medium | Preparing to unpack .../30-bind9-dnsutils_1%3a9.16.1-0ubuntu2.16_amd64.deb ... 2024-01-04 18:38:32.770280 | focal-medium | Unpacking bind9-dnsutils (1:9.16.1-0ubuntu2.16) over (1:9.16.1-0ubuntu2.15) ... 2024-01-04 18:38:32.770323 | focal-medium | Preparing to unpack .../31-bind9-libs_1%3a9.16.1-0ubuntu2.16_amd64.deb ... 2024-01-04 18:38:32.770364 | focal-medium | Unpacking bind9-libs:amd64 (1:9.16.1-0ubuntu2.16) over (1:9.16.1-0ubuntu2.15) ... 2024-01-04 18:38:32.770404 | focal-medium | Preparing to unpack .../32-bind9-host_1%3a9.16.1-0ubuntu2.16_amd64.deb ... 2024-01-04 18:38:32.770444 | focal-medium | Unpacking bind9-host (1:9.16.1-0ubuntu2.16) over (1:9.16.1-0ubuntu2.15) ... 2024-01-04 18:38:32.770482 | focal-medium | Preparing to unpack .../33-krb5-locales_1.17-6ubuntu4.4_all.deb ... 2024-01-04 18:38:32.770534 | focal-medium | Unpacking krb5-locales (1.17-6ubuntu4.4) over (1.17-6ubuntu4.3) ... 2024-01-04 18:38:32.770578 | focal-medium | Preparing to unpack .../34-libx11-data_2%3a1.6.9-2ubuntu1.6_all.deb ... 2024-01-04 18:38:32.770617 | focal-medium | Unpacking libx11-data (2:1.6.9-2ubuntu1.6) over (2:1.6.9-2ubuntu1.5) ... 2024-01-04 18:38:32.770656 | focal-medium | Preparing to unpack .../35-libx11-6_2%3a1.6.9-2ubuntu1.6_amd64.deb ... 2024-01-04 18:38:32.770695 | focal-medium | Unpacking libx11-6:amd64 (2:1.6.9-2ubuntu1.6) over (2:1.6.9-2ubuntu1.5) ... 2024-01-04 18:38:32.770732 | focal-medium | Preparing to unpack .../36-openssh-sftp-server_1%3a8.2p1-4ubuntu0.11_amd64.deb ... 2024-01-04 18:38:32.770770 | focal-medium | Unpacking openssh-sftp-server (1:8.2p1-4ubuntu0.11) over (1:8.2p1-4ubuntu0.9) ... 2024-01-04 18:38:32.770808 | focal-medium | Preparing to unpack .../37-openssh-server_1%3a8.2p1-4ubuntu0.11_amd64.deb ... 2024-01-04 18:38:32.770846 | focal-medium | Unpacking openssh-server (1:8.2p1-4ubuntu0.11) over (1:8.2p1-4ubuntu0.9) ... 2024-01-04 18:38:32.770884 | focal-medium | Preparing to unpack .../38-openssh-client_1%3a8.2p1-4ubuntu0.11_amd64.deb ... 2024-01-04 18:38:32.770921 | focal-medium | Unpacking openssh-client (1:8.2p1-4ubuntu0.11) over (1:8.2p1-4ubuntu0.9) ... 2024-01-04 18:38:32.770958 | focal-medium | Preparing to unpack .../39-python3-update-manager_1%3a20.04.10.18_all.deb ... 2024-01-04 18:38:32.770995 | focal-medium | Unpacking python3-update-manager (1:20.04.10.18) over (1:20.04.10.11) ... 2024-01-04 18:38:32.771032 | focal-medium | Preparing to unpack .../40-update-manager-core_1%3a20.04.10.18_all.deb ... 2024-01-04 18:38:32.771069 | focal-medium | Unpacking update-manager-core (1:20.04.10.18) over (1:20.04.10.11) ... 2024-01-04 18:38:32.771106 | focal-medium | Preparing to unpack .../41-libnghttp2-14_1.40.0-1ubuntu0.2_amd64.deb ... 2024-01-04 18:38:32.771143 | focal-medium | Unpacking libnghttp2-14:amd64 (1.40.0-1ubuntu0.2) over (1.40.0-1ubuntu0.1) ... 2024-01-04 18:38:32.771180 | focal-medium | Preparing to unpack .../42-libssh-4_0.9.3-2ubuntu2.4_amd64.deb ... 2024-01-04 18:38:32.771217 | focal-medium | Unpacking libssh-4:amd64 (0.9.3-2ubuntu2.4) over (0.9.3-2ubuntu2.3) ... 2024-01-04 18:38:32.771253 | focal-medium | Preparing to unpack .../43-curl_7.68.0-1ubuntu2.21_amd64.deb ... 2024-01-04 18:38:32.771290 | focal-medium | Unpacking curl (7.68.0-1ubuntu2.21) over (7.68.0-1ubuntu2.19) ... 2024-01-04 18:38:32.771327 | focal-medium | Preparing to unpack .../44-libcurl4_7.68.0-1ubuntu2.21_amd64.deb ... 2024-01-04 18:38:32.771364 | focal-medium | Unpacking libcurl4:amd64 (7.68.0-1ubuntu2.21) over (7.68.0-1ubuntu2.19) ... 2024-01-04 18:38:32.771402 | focal-medium | Preparing to unpack .../45-grub-efi-amd64-signed_1.187.6~20.04.1+2.06-2ubuntu14.4_amd64.deb ... 2024-01-04 18:38:32.771440 | focal-medium | Unpacking grub-efi-amd64-signed (1.187.6~20.04.1+2.06-2ubuntu14.4) over (1.187.3~20.04.1+2.06-2ubuntu14.1) ... 2024-01-04 18:38:32.771478 | focal-medium | Preparing to unpack .../46-grub-efi-amd64-bin_2.06-2ubuntu14.4_amd64.deb ... 2024-01-04 18:38:32.771516 | focal-medium | Unpacking grub-efi-amd64-bin (2.06-2ubuntu14.4) over (2.06-2ubuntu14.1) ... 2024-01-04 18:38:32.771553 | focal-medium | Preparing to unpack .../47-libcurl3-gnutls_7.68.0-1ubuntu2.21_amd64.deb ... 2024-01-04 18:38:32.771596 | focal-medium | Unpacking libcurl3-gnutls:amd64 (7.68.0-1ubuntu2.21) over (7.68.0-1ubuntu2.19) ... 2024-01-04 18:38:32.771633 | focal-medium | Selecting previously unselected package linux-headers-5.4.0-169. 2024-01-04 18:38:32.771669 | focal-medium | Preparing to unpack .../48-linux-headers-5.4.0-169_5.4.0-169.187_all.deb ... 2024-01-04 18:38:32.771706 | focal-medium | Unpacking linux-headers-5.4.0-169 (5.4.0-169.187) ... 2024-01-04 18:38:32.771743 | focal-medium | Selecting previously unselected package linux-headers-5.4.0-169-generic. 2024-01-04 18:38:32.771780 | focal-medium | Preparing to unpack .../49-linux-headers-5.4.0-169-generic_5.4.0-169.187_amd64.deb ... 2024-01-04 18:38:32.771825 | focal-medium | Unpacking linux-headers-5.4.0-169-generic (5.4.0-169.187) ... 2024-01-04 18:38:32.771867 | focal-medium | Selecting previously unselected package linux-modules-5.4.0-169-generic. 2024-01-04 18:38:32.771905 | focal-medium | Preparing to unpack .../50-linux-modules-5.4.0-169-generic_5.4.0-169.187_amd64.deb ... 2024-01-04 18:38:32.771943 | focal-medium | Unpacking linux-modules-5.4.0-169-generic (5.4.0-169.187) ... 2024-01-04 18:38:32.771981 | focal-medium | Selecting previously unselected package linux-image-5.4.0-169-generic. 2024-01-04 18:38:32.772018 | focal-medium | Preparing to unpack .../51-linux-image-5.4.0-169-generic_5.4.0-169.187_amd64.deb ... 2024-01-04 18:38:32.772055 | focal-medium | Unpacking linux-image-5.4.0-169-generic (5.4.0-169.187) ... 2024-01-04 18:38:32.772091 | focal-medium | Preparing to unpack .../52-linux-virtual_5.4.0.169.167_amd64.deb ... 2024-01-04 18:38:32.772128 | focal-medium | Unpacking linux-virtual (5.4.0.169.167) over (5.4.0.156.152) ... 2024-01-04 18:38:32.772164 | focal-medium | Preparing to unpack .../53-linux-image-virtual_5.4.0.169.167_amd64.deb ... 2024-01-04 18:38:32.772249 | focal-medium | Unpacking linux-image-virtual (5.4.0.169.167) over (5.4.0.156.152) ... 2024-01-04 18:38:32.772315 | focal-medium | Preparing to unpack .../54-linux-headers-virtual_5.4.0.169.167_amd64.deb ... 2024-01-04 18:38:32.772358 | focal-medium | Unpacking linux-headers-virtual (5.4.0.169.167) over (5.4.0.156.152) ... 2024-01-04 18:38:32.772397 | focal-medium | Preparing to unpack .../55-linux-headers-generic_5.4.0.169.167_amd64.deb ... 2024-01-04 18:38:32.772435 | focal-medium | Unpacking linux-headers-generic (5.4.0.169.167) over (5.4.0.156.152) ... 2024-01-04 18:38:32.772473 | focal-medium | Preparing to unpack .../56-mokutil_0.6.0-2~20.04.2_amd64.deb ... 2024-01-04 18:38:32.772511 | focal-medium | Unpacking mokutil (0.6.0-2~20.04.2) over (0.6.0-2~20.04.1) ... 2024-01-04 18:38:32.772549 | focal-medium | Preparing to unpack .../57-python3-cryptography_2.8-3ubuntu0.2_amd64.deb ... 2024-01-04 18:38:32.772605 | focal-medium | Unpacking python3-cryptography (2.8-3ubuntu0.2) over (2.8-3ubuntu0.1) ... 2024-01-04 18:38:32.772651 | focal-medium | Preparing to unpack .../58-python3-urllib3_1.25.8-2ubuntu0.3_all.deb ... 2024-01-04 18:38:32.772689 | focal-medium | Unpacking python3-urllib3 (1.25.8-2ubuntu0.3) over (1.25.8-2ubuntu0.2) ... 2024-01-04 18:38:32.772727 | focal-medium | Preparing to unpack .../59-sosreport_4.5.6-0ubuntu1~20.04.2_amd64.deb ... 2024-01-04 18:38:32.772765 | focal-medium | Unpacking sosreport (4.5.6-0ubuntu1~20.04.2) over (4.5.6-0ubuntu1~20.04.1) ... 2024-01-04 18:38:32.772803 | focal-medium | Preparing to unpack .../60-cloud-init_23.3.3-0ubuntu0~20.04.1_all.deb ... 2024-01-04 18:38:32.772841 | focal-medium | Unpacking cloud-init (23.3.3-0ubuntu0~20.04.1) over (23.2.2-0ubuntu0~20.04.1) ... 2024-01-04 18:38:32.772879 | focal-medium | Preparing to unpack .../61-kpartx_0.8.3-1ubuntu2.3_amd64.deb ... 2024-01-04 18:38:32.772917 | focal-medium | Unpacking kpartx (0.8.3-1ubuntu2.3) over (0.8.3-1ubuntu2.1) ... 2024-01-04 18:38:32.772955 | focal-medium | Preparing to unpack .../62-multipath-tools_0.8.3-1ubuntu2.3_amd64.deb ... 2024-01-04 18:38:32.773059 | focal-medium | Warning: Stopping multipath-tools.service, but it can still be activated by: 2024-01-04 18:38:32.773107 | focal-medium | multipathd.socket 2024-01-04 18:38:32.773147 | focal-medium | Unpacking multipath-tools (0.8.3-1ubuntu2.3) over (0.8.3-1ubuntu2.1) ... 2024-01-04 18:38:32.773186 | focal-medium | Setting up libapparmor1:amd64 (2.13.3-7ubuntu5.3) ... 2024-01-04 18:38:32.773332 | focal-medium | Setting up apt-utils (2.0.10) ... 2024-01-04 18:38:32.773396 | focal-medium | Setting up perl-modules-5.30 (5.30.0-9ubuntu0.5) ... 2024-01-04 18:38:32.773673 | focal-medium | Setting up gawk (1:5.0.1+dfsg-1ubuntu0.1) ... 2024-01-04 18:38:32.773735 | focal-medium | Setting up distro-info-data (0.43ubuntu1.15) ... 2024-01-04 18:38:32.773778 | focal-medium | Setting up libssl1.1:amd64 (1.1.1f-1ubuntu2.20) ... 2024-01-04 18:38:32.773848 | focal-medium | Setting up libsqlite3-0:amd64 (3.31.1-4ubuntu0.6) ... 2024-01-04 18:38:32.773901 | focal-medium | Setting up libnghttp2-14:amd64 (1.40.0-1ubuntu0.2) ... 2024-01-04 18:38:32.773942 | focal-medium | Setting up libnetplan0:amd64 (0.104-0ubuntu2~20.04.4) ... 2024-01-04 18:38:32.773983 | focal-medium | Setting up krb5-locales (1.17-6ubuntu4.4) ... 2024-01-04 18:38:32.774021 | focal-medium | Setting up linux-headers-5.4.0-169 (5.4.0-169.187) ... 2024-01-04 18:38:32.774060 | focal-medium | Setting up locales (2.31-0ubuntu9.14) ... 2024-01-04 18:38:32.774098 | focal-medium | Generating locales (this might take a while)... 2024-01-04 18:38:32.774135 | focal-medium | en_US.UTF-8... done 2024-01-04 18:38:32.774173 | focal-medium | Generation complete. 2024-01-04 18:38:32.774211 | focal-medium | Setting up xxd (2:8.1.2269-1ubuntu5.21) ... 2024-01-04 18:38:32.774248 | focal-medium | Setting up netplan.io (0.104-0ubuntu2~20.04.4) ... 2024-01-04 18:38:32.774286 | focal-medium | Setting up libkrb5support0:amd64 (1.17-6ubuntu4.4) ... 2024-01-04 18:38:32.774323 | focal-medium | Setting up apparmor (2.13.3-7ubuntu5.3) ... 2024-01-04 18:38:32.774360 | focal-medium | Reloading AppArmor profiles 2024-01-04 18:38:32.774397 | focal-medium | Skipping profile in /etc/apparmor.d/disable: usr.sbin.rsyslogd 2024-01-04 18:38:32.774435 | focal-medium | Setting up vim-common (2:8.1.2269-1ubuntu5.21) ... 2024-01-04 18:38:32.774473 | focal-medium | Setting up libx11-data (2:1.6.9-2ubuntu1.6) ... 2024-01-04 18:38:32.774510 | focal-medium | Setting up python3-cryptography (2.8-3ubuntu0.2) ... 2024-01-04 18:38:32.774548 | focal-medium | Setting up libk5crypto3:amd64 (1.17-6ubuntu4.4) ... 2024-01-04 18:38:32.774609 | focal-medium | Setting up sosreport (4.5.6-0ubuntu1~20.04.2) ... 2024-01-04 18:38:32.774670 | focal-medium | Setting up python3-urllib3 (1.25.8-2ubuntu0.3) ... 2024-01-04 18:38:32.774712 | focal-medium | Setting up open-vm-tools (2:11.3.0-2ubuntu0~ubuntu20.04.7) ... 2024-01-04 18:38:32.774751 | focal-medium | Setting up python3-update-manager (1:20.04.10.18) ... 2024-01-04 18:38:32.774793 | focal-medium | Setting up kpartx (0.8.3-1ubuntu2.3) ... 2024-01-04 18:38:32.774831 | focal-medium | Setting up libperl5.30:amd64 (5.30.0-9ubuntu0.5) ... 2024-01-04 18:38:32.774868 | focal-medium | Setting up libx11-6:amd64 (2:1.6.9-2ubuntu1.6) ... 2024-01-04 18:38:32.774904 | focal-medium | Setting up libkrb5-3:amd64 (1.17-6ubuntu4.4) ... 2024-01-04 18:38:32.774942 | focal-medium | Setting up ubuntu-advantage-tools (30~20.04) ... 2024-01-04 18:38:32.774979 | focal-medium | Removing obsolete conffile /etc/ubuntu-advantage/help_data.yaml ... 2024-01-04 18:38:32.775017 | focal-medium | Setting up vim-runtime (2:8.1.2269-1ubuntu5.21) ... 2024-01-04 18:38:32.775055 | focal-medium | Setting up linux-modules-5.4.0-169-generic (5.4.0-169.187) ... 2024-01-04 18:38:32.775092 | focal-medium | Setting up grub-efi-amd64-bin (2.06-2ubuntu14.4) ... 2024-01-04 18:38:32.775130 | focal-medium | Setting up openssl (1.1.1f-1ubuntu2.20) ... 2024-01-04 18:38:32.775168 | focal-medium | Setting up libelf1:amd64 (0.176-1.1ubuntu0.1) ... 2024-01-04 18:38:32.775205 | focal-medium | Setting up libprocps8:amd64 (2:3.3.16-1ubuntu2.4) ... 2024-01-04 18:38:32.775243 | focal-medium | Setting up rsync (3.1.3-8ubuntu0.7) ... 2024-01-04 18:38:32.775280 | focal-medium | Setting up ubuntu-pro-client-l10n (30~20.04) ... 2024-01-04 18:38:32.775317 | focal-medium | Setting up libpython3.8-minimal:amd64 (3.8.10-0ubuntu1~20.04.9) ... 2024-01-04 18:38:32.775354 | focal-medium | Setting up mokutil (0.6.0-2~20.04.2) ... 2024-01-04 18:38:32.775396 | focal-medium | Setting up grub-efi-amd64-signed (1.187.6~20.04.1+2.06-2ubuntu14.4) ... 2024-01-04 18:38:32.775434 | focal-medium | Trying to migrate /boot/efi into esp config 2024-01-04 18:38:32.775471 | focal-medium | Unknown device "/dev/disk/by-id/*": No such file or directory 2024-01-04 18:38:32.775508 | focal-medium | Installing grub to /boot/efi. 2024-01-04 18:38:32.775545 | focal-medium | Installing for x86_64-efi platform. 2024-01-04 18:38:32.775593 | focal-medium | grub-install: warning: EFI variables are not supported on this system.. 2024-01-04 18:38:32.775635 | focal-medium | Installation finished. No error reported. 2024-01-04 18:38:32.775673 | focal-medium | Setting up linux-image-5.4.0-169-generic (5.4.0-169.187) ... 2024-01-04 18:38:32.775710 | focal-medium | I: /boot/vmlinuz is now a symlink to vmlinuz-5.4.0-169-generic 2024-01-04 18:38:32.775746 | focal-medium | I: /boot/initrd.img is now a symlink to initrd.img-5.4.0-169-generic 2024-01-04 18:38:32.775782 | focal-medium | Setting up vim-tiny (2:8.1.2269-1ubuntu5.21) ... 2024-01-04 18:38:32.775819 | focal-medium | Setting up multipath-tools (0.8.3-1ubuntu2.3) ... 2024-01-04 18:38:32.775855 | focal-medium | Job failed. See "journalctl -xe" for details. 2024-01-04 18:38:32.775892 | focal-medium | Removing obsolete conffile /etc/init.d/multipath-tools ... 2024-01-04 18:38:32.775932 | focal-medium | Setting up perl (5.30.0-9ubuntu0.5) ... 2024-01-04 18:38:32.776032 | focal-medium | Setting up libgssapi-krb5-2:amd64 (1.17-6ubuntu4.4) ... 2024-01-04 18:38:32.776121 | focal-medium | Setting up libssh-4:amd64 (0.9.3-2ubuntu2.4) ... 2024-01-04 18:38:32.776172 | focal-medium | Setting up update-manager-core (1:20.04.10.18) ... 2024-01-04 18:38:32.776214 | focal-medium | Setting up python3.8-minimal (3.8.10-0ubuntu1~20.04.9) ... 2024-01-04 18:38:32.776253 | focal-medium | Setting up procps (2:3.3.16-1ubuntu2.4) ... 2024-01-04 18:38:32.776292 | focal-medium | Setting up libcurl4:amd64 (7.68.0-1ubuntu2.21) ... 2024-01-04 18:38:32.776330 | focal-medium | Setting up curl (7.68.0-1ubuntu2.21) ... 2024-01-04 18:38:32.776368 | focal-medium | Setting up linux-headers-5.4.0-169-generic (5.4.0-169.187) ... 2024-01-04 18:38:32.776406 | focal-medium | Setting up linux-image-virtual (5.4.0.169.167) ... 2024-01-04 18:38:32.776443 | focal-medium | Setting up libpython3.8-stdlib:amd64 (3.8.10-0ubuntu1~20.04.9) ... 2024-01-04 18:38:32.776481 | focal-medium | Setting up python3.8 (3.8.10-0ubuntu1~20.04.9) ... 2024-01-04 18:38:32.776519 | focal-medium | Setting up cloud-init (23.3.3-0ubuntu0~20.04.1) ... 2024-01-04 18:38:32.776556 | focal-medium | Installing new version of config file /etc/cloud/cloud.cfg ... 2024-01-04 18:38:32.776626 | focal-medium | Setting up bind9-libs:amd64 (1:9.16.1-0ubuntu2.16) ... 2024-01-04 18:38:32.776677 | focal-medium | Setting up openssh-client (1:8.2p1-4ubuntu0.11) ... 2024-01-04 18:38:32.776717 | focal-medium | Setting up libcurl3-gnutls:amd64 (7.68.0-1ubuntu2.21) ... 2024-01-04 18:38:32.776755 | focal-medium | Setting up linux-headers-generic (5.4.0.169.167) ... 2024-01-04 18:38:32.776793 | focal-medium | Setting up libpython3.8:amd64 (3.8.10-0ubuntu1~20.04.9) ... 2024-01-04 18:38:32.776832 | focal-medium | Setting up bind9-host (1:9.16.1-0ubuntu2.16) ... 2024-01-04 18:38:32.776871 | focal-medium | Setting up openssh-sftp-server (1:8.2p1-4ubuntu0.11) ... 2024-01-04 18:38:32.776909 | focal-medium | Setting up vim (2:8.1.2269-1ubuntu5.21) ... 2024-01-04 18:38:32.776946 | focal-medium | Setting up linux-headers-virtual (5.4.0.169.167) ... 2024-01-04 18:38:32.776984 | focal-medium | Setting up openssh-server (1:8.2p1-4ubuntu0.11) ... 2024-01-04 18:38:32.777021 | focal-medium | rescue-ssh.target is a disabled or a static unit, not starting it. 2024-01-04 18:38:32.777060 | focal-medium | Setting up linux-virtual (5.4.0.169.167) ... 2024-01-04 18:38:32.777098 | focal-medium | Setting up bind9-dnsutils (1:9.16.1-0ubuntu2.16) ... 2024-01-04 18:38:32.777136 | focal-medium | Processing triggers for libc-bin (2.31-0ubuntu9.14) ... 2024-01-04 18:38:32.777174 | focal-medium | Processing triggers for rsyslog (8.2001.0-1ubuntu1.3) ... 2024-01-04 18:38:32.777212 | focal-medium | Processing triggers for ufw (0.36-6ubuntu1.1) ... 2024-01-04 18:38:32.777249 | focal-medium | Processing triggers for systemd (245.4-4ubuntu3.22) ... 2024-01-04 18:38:32.777287 | focal-medium | Processing triggers for man-db (2.9.1-1) ... 2024-01-04 18:38:32.777431 | focal-medium | Processing triggers for dbus (1.12.16-2ubuntu2.3) ... 2024-01-04 18:38:32.777557 | focal-medium | Processing triggers for mime-support (3.64ubuntu1) ... 2024-01-04 18:38:32.777618 | focal-medium | Processing triggers for linux-image-5.4.0-169-generic (5.4.0-169.187) ... 2024-01-04 18:38:32.777661 | focal-medium | /etc/kernel/postinst.d/initramfs-tools: 2024-01-04 18:38:32.777702 | focal-medium | update-initramfs: Generating /boot/initrd.img-5.4.0-169-generic 2024-01-04 18:38:32.777742 | focal-medium | /etc/kernel/postinst.d/zz-update-grub: 2024-01-04 18:38:32.777781 | focal-medium | Sourcing file `/etc/default/grub' 2024-01-04 18:38:32.777820 | focal-medium | Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg' 2024-01-04 18:38:32.777859 | focal-medium | Sourcing file `/etc/default/grub.d/init-select.cfg' 2024-01-04 18:38:32.777897 | focal-medium | Generating grub configuration file ... 2024-01-04 18:38:32.777936 | focal-medium | Found linux image: /boot/vmlinuz-5.4.0-169-generic 2024-01-04 18:38:32.777974 | focal-medium | Found initrd image: /boot/initrd.img-5.4.0-169-generic 2024-01-04 18:38:32.778012 | focal-medium | Found linux image: /boot/vmlinuz-5.4.0-156-generic 2024-01-04 18:38:32.778080 | focal-medium | Found initrd image: /boot/initrd.img-5.4.0-156-generic 2024-01-04 18:38:32.778129 | focal-medium | done 2024-01-04 18:38:32.851674 | 2024-01-04 18:38:32.851952 | TASK [validate-host : Define zuul_info_dir fact] 2024-01-04 18:38:33.013579 | focal-medium | ok 2024-01-04 18:38:33.045278 | 2024-01-04 18:38:33.045889 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2024-01-04 18:38:33.411358 | focal-medium | changed 2024-01-04 18:38:33.442034 | 2024-01-04 18:38:33.442423 | TASK [validate-host : Collect information about the host] 2024-01-04 18:38:34.490613 | focal-medium | ok 2024-01-04 18:38:34.547731 | 2024-01-04 18:38:34.548047 | TASK [validate-host : Sanitize hostname] 2024-01-04 18:38:34.671628 | focal-medium | ok 2024-01-04 18:38:34.696062 | 2024-01-04 18:38:34.696252 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2024-01-04 18:38:35.481097 | focal-medium | changed 2024-01-04 18:38:35.508492 | 2024-01-04 18:38:35.508832 | TASK [validate-host : Collect information about zuul worker] 2024-01-04 18:38:36.161787 | focal-medium | ok 2024-01-04 18:38:36.191266 | 2024-01-04 18:38:36.191516 | TASK [validate-host : Write out all zuul information for each host] 2024-01-04 18:38:36.979061 | focal-medium | changed 2024-01-04 18:38:37.000250 | 2024-01-04 18:38:37.000472 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2024-01-04 18:38:37.956342 | 2024-01-04 18:38:37.956698 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2024-01-04 18:38:38.871591 | 2024-01-04 18:38:38.871950 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2024-01-04 18:38:39.265608 | focal-medium | ok 2024-01-04 18:38:39.300850 | 2024-01-04 18:38:39.301189 | TASK [log-inventory : Copy ansible inventory to logs dir] 2024-01-04 18:38:40.312210 | focal-medium | changed 2024-01-04 18:38:40.338499 | 2024-01-04 18:38:40.338758 | TASK [ensure-python : Validate python_version value] 2024-01-04 18:38:40.456781 | focal-medium | skipping: Conditional result was False 2024-01-04 18:38:40.496125 | 2024-01-04 18:38:40.496496 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2024-01-04 18:38:40.616394 | focal-medium | skipping: Conditional result was False 2024-01-04 18:38:40.651832 | 2024-01-04 18:38:40.652162 | TASK [ensure-python : Pull in venv package] 2024-01-04 18:38:40.752212 | focal-medium | skipping: Conditional result was False 2024-01-04 18:38:40.780109 | 2024-01-04 18:38:40.780366 | TASK [ensure-python : Set default RPM package name] 2024-01-04 18:38:40.890613 | focal-medium | skipping: Conditional result was False 2024-01-04 18:38:40.923884 | 2024-01-04 18:38:40.924131 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9 and Python 3.9] 2024-01-04 18:38:41.028976 | focal-medium | skipping: Conditional result was False 2024-01-04 18:38:41.060039 | 2024-01-04 18:38:41.060288 | TASK [ensure-python : Install RPM package] 2024-01-04 18:38:41.155853 | focal-medium | skipping: Conditional result was False 2024-01-04 18:38:41.185266 | 2024-01-04 18:38:41.185518 | TASK [ensure-python : Install python using pyenv] 2024-01-04 18:38:41.282641 | focal-medium | skipping: Conditional result was False 2024-01-04 18:38:41.310799 | 2024-01-04 18:38:41.311019 | TASK [ensure-python : Activate python using stow] 2024-01-04 18:38:41.397797 | focal-medium | skipping: Conditional result was False 2024-01-04 18:38:41.436861 | 2024-01-04 18:38:41.437269 | TASK [Install pip] 2024-01-04 18:38:41.522318 | focal-medium | ok 2024-01-04 18:38:41.621042 | 2024-01-04 18:38:41.621410 | TASK [ensure-pip : Check if pip is installed] 2024-01-04 18:38:42.184532 | focal-medium | ok: Runtime: 0:00:00.007797 2024-01-04 18:38:42.211396 | 2024-01-04 18:38:42.211657 | LOOP [ensure-pip : Install pip from packages] 2024-01-04 18:38:42.429290 | focal-medium | included: /var/lib/zuul/builds/6720072d572c4215a3d18461c72c93ec/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2024-01-04 18:38:42.450837 | 2024-01-04 18:38:42.451080 | TASK [ensure-pip : Update package lists] 2024-01-04 18:38:45.060470 | focal-medium | changed 2024-01-04 18:38:45.091643 | 2024-01-04 18:38:45.091974 | TASK [ensure-pip : Install Python 3 pip] 2024-01-04 18:39:25.182621 | focal-medium | changed 2024-01-04 18:39:25.218155 | 2024-01-04 18:39:25.218445 | TASK [ensure-pip : Install Python 2 pip] 2024-01-04 18:39:25.266732 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:25.301954 | 2024-01-04 18:39:25.302387 | TASK [ensure-pip : Ensure setuptools] 2024-01-04 18:39:25.457061 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:25.481743 | 2024-01-04 18:39:25.481971 | TASK [ensure-pip : Check for ensurepip module] 2024-01-04 18:39:25.881532 | focal-medium | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2024-01-04 18:39:25.881681 | focal-medium | [--altinstall] [--default-pip] 2024-01-04 18:39:25.881700 | focal-medium | 2024-01-04 18:39:25.881724 | focal-medium | optional arguments: 2024-01-04 18:39:25.881797 | focal-medium | -h, --help show this help message and exit 2024-01-04 18:39:25.881833 | focal-medium | --version Show the version of pip that is bundled with this Python. 2024-01-04 18:39:25.881857 | focal-medium | -v, --verbose Give more output. Option is additive, and can be used up to 3 2024-01-04 18:39:25.881869 | focal-medium | times. 2024-01-04 18:39:25.881882 | focal-medium | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2024-01-04 18:39:25.881893 | focal-medium | --user Install using the user scheme. 2024-01-04 18:39:25.881905 | focal-medium | --root ROOT Install everything relative to this alternate root directory. 2024-01-04 18:39:25.881916 | focal-medium | --altinstall Make an alternate install, installing only the X.Y versioned 2024-01-04 18:39:25.881927 | focal-medium | scripts (Default: pipX, pipX.Y, easy_install-X.Y). 2024-01-04 18:39:25.881938 | focal-medium | --default-pip Make a default pip install, installing the unqualified pip 2024-01-04 18:39:25.881950 | focal-medium | and easy_install in addition to the versioned scripts. 2024-01-04 18:39:26.022994 | focal-medium | ok: Runtime: 0:00:00.067973 2024-01-04 18:39:26.059919 | 2024-01-04 18:39:26.060210 | TASK [ensure-pip : Ensure python3-venv] 2024-01-04 18:39:26.169684 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:26.197058 | 2024-01-04 18:39:26.197304 | TASK [ensure-pip : Install pip from source] 2024-01-04 18:39:26.241819 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:26.273708 | 2024-01-04 18:39:26.273981 | TASK [ensure-pip : Probe for venv python full path] 2024-01-04 18:39:26.586949 | focal-medium | /usr/bin/python3 2024-01-04 18:39:26.831376 | focal-medium | ok: Runtime: 0:00:00.005330 2024-01-04 18:39:26.874846 | 2024-01-04 18:39:26.875372 | TASK [ensure-pip : Set host default] 2024-01-04 18:39:27.014535 | focal-medium | ok 2024-01-04 18:39:27.052248 | 2024-01-04 18:39:27.052605 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2024-01-04 18:39:27.187491 | focal-medium | ok 2024-01-04 18:39:27.216358 | 2024-01-04 18:39:27.216667 | TASK [ensure-tox : Check if tox is installed] 2024-01-04 18:39:27.764608 | focal-medium | ok: Runtime: 0:00:00.007224 2024-01-04 18:39:27.801722 | 2024-01-04 18:39:27.802152 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2024-01-04 18:39:27.900982 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:27.935396 | 2024-01-04 18:39:27.935706 | TASK [ensure-tox : Create local venv] 2024-01-04 18:39:30.980879 | focal-medium | ok: Runtime: 0:00:02.594526 2024-01-04 18:39:31.013202 | 2024-01-04 18:39:31.013506 | TASK [ensure-tox : Install tox to local venv] 2024-01-04 18:39:33.134968 | focal-medium | Collecting tox 2024-01-04 18:39:33.474311 | focal-medium | Downloading tox-4.11.4-py3-none-any.whl (153 kB) 2024-01-04 18:39:33.866138 | focal-medium | Collecting platformdirs>=3.10 2024-01-04 18:39:33.951735 | focal-medium | Downloading platformdirs-4.1.0-py3-none-any.whl (17 kB) 2024-01-04 18:39:34.190738 | focal-medium | Collecting virtualenv>=20.24.3 2024-01-04 18:39:34.277368 | focal-medium | Downloading virtualenv-20.25.0-py3-none-any.whl (3.8 MB) 2024-01-04 18:39:34.844950 | focal-medium | Collecting tomli>=2.0.1; python_version < "3.11" 2024-01-04 18:39:34.931841 | focal-medium | Downloading tomli-2.0.1-py3-none-any.whl (12 kB) 2024-01-04 18:39:34.994609 | focal-medium | Collecting pluggy>=1.3 2024-01-04 18:39:35.082112 | focal-medium | Downloading pluggy-1.3.0-py3-none-any.whl (18 kB) 2024-01-04 18:39:35.136443 | focal-medium | Collecting pyproject-api>=1.6.1 2024-01-04 18:39:35.222203 | focal-medium | Downloading pyproject_api-1.6.1-py3-none-any.whl (12 kB) 2024-01-04 18:39:35.295085 | focal-medium | Collecting colorama>=0.4.6 2024-01-04 18:39:35.380285 | focal-medium | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2024-01-04 18:39:35.449669 | focal-medium | Collecting filelock>=3.12.3 2024-01-04 18:39:35.535899 | focal-medium | Downloading filelock-3.13.1-py3-none-any.whl (11 kB) 2024-01-04 18:39:35.619868 | focal-medium | Collecting packaging>=23.1 2024-01-04 18:39:35.705926 | focal-medium | Downloading packaging-23.2-py3-none-any.whl (53 kB) 2024-01-04 18:39:35.772463 | focal-medium | Collecting cachetools>=5.3.1 2024-01-04 18:39:35.857308 | focal-medium | Downloading cachetools-5.3.2-py3-none-any.whl (9.3 kB) 2024-01-04 18:39:35.901534 | focal-medium | Collecting chardet>=5.2 2024-01-04 18:39:35.987593 | focal-medium | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2024-01-04 18:39:36.057254 | focal-medium | Collecting distlib<1,>=0.3.7 2024-01-04 18:39:36.144253 | focal-medium | Downloading distlib-0.3.8-py2.py3-none-any.whl (468 kB) 2024-01-04 18:39:36.352296 | focal-medium | Installing collected packages: platformdirs, distlib, filelock, virtualenv, tomli, pluggy, packaging, pyproject-api, colorama, cachetools, chardet, tox 2024-01-04 18:39:37.359467 | focal-medium | Successfully installed cachetools-5.3.2 chardet-5.2.0 colorama-0.4.6 distlib-0.3.8 filelock-3.13.1 packaging-23.2 platformdirs-4.1.0 pluggy-1.3.0 pyproject-api-1.6.1 tomli-2.0.1 tox-4.11.4 virtualenv-20.25.0 2024-01-04 18:39:37.577444 | focal-medium | ok: Runtime: 0:00:06.036580 2024-01-04 18:39:37.610625 | 2024-01-04 18:39:37.610884 | TASK [ensure-tox : Export installed tox_executable path] 2024-01-04 18:39:37.762980 | focal-medium | ok 2024-01-04 18:39:37.785033 | 2024-01-04 18:39:37.785226 | TASK [ensure-tox : Output tox version] 2024-01-04 18:39:38.424404 | focal-medium | ROOT: No tox.ini or setup.cfg or pyproject.toml found, assuming empty tox.ini at /home/ubuntu 2024-01-04 18:39:38.448971 | focal-medium | 4.11.4 from /home/ubuntu/.local/tox/lib/python3.8/site-packages/tox/__init__.py 2024-01-04 18:39:38.842950 | focal-medium | ok: Runtime: 0:00:00.352652 2024-01-04 18:39:38.871143 | 2024-01-04 18:39:38.871366 | TASK [ensure-tox : Make global symlink] 2024-01-04 18:39:38.915264 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:38.935229 | 2024-01-04 18:39:38.935419 | PLAY RECAP 2024-01-04 18:39:38.935527 | focal-medium | ok: 45 changed: 28 unreachable: 0 failed: 0 skipped: 17 rescued: 0 ignored: 0 2024-01-04 18:39:38.935593 | 2024-01-04 18:39:39.267232 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/openstack-charmers/zosci-config/playbooks/base/pre.yaml@master] 2024-01-04 18:39:39.267817 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2024-01-04 18:39:41.847899 | 2024-01-04 18:39:41.848125 | PLAY [all] 2024-01-04 18:39:41.880322 | 2024-01-04 18:39:41.880499 | TASK [Install binary dependencies] 2024-01-04 18:39:42.029756 | focal-medium | ok 2024-01-04 18:39:42.166354 | 2024-01-04 18:39:42.166572 | TASK [bindep : Include find tasks] 2024-01-04 18:39:42.274589 | focal-medium | ok 2024-01-04 18:39:42.313631 | focal-medium | included: /var/lib/zuul/builds/6720072d572c4215a3d18461c72c93ec/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2024-01-04 18:39:42.336367 | 2024-01-04 18:39:42.336573 | TASK [Look for bindep.txt] 2024-01-04 18:39:42.990259 | focal-medium | ok 2024-01-04 18:39:43.015174 | 2024-01-04 18:39:43.015392 | TASK [Define bindep_file fact] 2024-01-04 18:39:43.124338 | focal-medium | ok 2024-01-04 18:39:43.148423 | 2024-01-04 18:39:43.148712 | TASK [bindep : Look for other-requirements.txt] 2024-01-04 18:39:43.248058 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:43.277699 | 2024-01-04 18:39:43.277911 | TASK [Define bindep_file fact] 2024-01-04 18:39:43.376411 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:43.402712 | 2024-01-04 18:39:43.402965 | TASK [Look for bindep fallback file] 2024-01-04 18:39:43.497083 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:43.523637 | 2024-01-04 18:39:43.523887 | TASK [Define bindep_file fact] 2024-01-04 18:39:43.625284 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:43.650688 | 2024-01-04 18:39:43.650920 | TASK [Include bindep tasks] 2024-01-04 18:39:43.750573 | focal-medium | ok 2024-01-04 18:39:43.784279 | focal-medium | included: /var/lib/zuul/builds/6720072d572c4215a3d18461c72c93ec/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find-bindep.yaml 2024-01-04 18:39:43.810263 | 2024-01-04 18:39:43.810574 | TASK [Look for bindep command] 2024-01-04 18:39:43.936298 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:43.963190 | 2024-01-04 18:39:43.963392 | TASK [Check for system bindep] 2024-01-04 18:39:45.002939 | focal-medium | ok: Runtime: 0:00:00.005237 2024-01-04 18:39:45.033558 | 2024-01-04 18:39:45.033779 | TASK [Define bindep_command fact] 2024-01-04 18:39:45.146346 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:45.178460 | 2024-01-04 18:39:45.178740 | TASK [bindep : Include install tasks] 2024-01-04 18:39:45.306849 | focal-medium | ok 2024-01-04 18:39:45.381726 | focal-medium | included: /var/lib/zuul/builds/6720072d572c4215a3d18461c72c93ec/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/install.yaml 2024-01-04 18:39:45.398646 | 2024-01-04 18:39:45.398809 | TASK [Create temp dir for bindep] 2024-01-04 18:39:45.982298 | focal-medium | changed 2024-01-04 18:39:46.013739 | 2024-01-04 18:39:46.014159 | TASK [Ensure we have pip dependencies] 2024-01-04 18:39:46.073077 | focal-medium | ok 2024-01-04 18:39:46.139513 | 2024-01-04 18:39:46.139745 | TASK [ensure-pip : Check if pip is installed] 2024-01-04 18:39:46.530040 | focal-medium | /usr/bin/pip3 2024-01-04 18:39:46.583450 | focal-medium | usage: __main__.py [-h] {unpack,pack,convert,version,help} ... 2024-01-04 18:39:46.583599 | focal-medium | 2024-01-04 18:39:46.583619 | focal-medium | positional arguments: 2024-01-04 18:39:46.583663 | focal-medium | {unpack,pack,convert,version,help} 2024-01-04 18:39:46.583693 | focal-medium | commands 2024-01-04 18:39:46.583724 | focal-medium | unpack Unpack wheel 2024-01-04 18:39:46.583744 | focal-medium | pack Repack wheel 2024-01-04 18:39:46.583758 | focal-medium | convert Convert egg or wininst to wheel 2024-01-04 18:39:46.583767 | focal-medium | version Print version and exit 2024-01-04 18:39:46.583776 | focal-medium | help Show this help 2024-01-04 18:39:46.583785 | focal-medium | 2024-01-04 18:39:46.583793 | focal-medium | optional arguments: 2024-01-04 18:39:46.583802 | focal-medium | -h, --help show this help message and exit 2024-01-04 18:39:46.682416 | focal-medium | ok: Runtime: 0:00:00.067107 2024-01-04 18:39:46.711309 | 2024-01-04 18:39:46.711540 | LOOP [ensure-pip : Install pip from packages] 2024-01-04 18:39:46.841048 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:46.869591 | 2024-01-04 18:39:46.869834 | TASK [ensure-pip : Ensure setuptools] 2024-01-04 18:39:46.975554 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:47.000550 | 2024-01-04 18:39:47.000811 | TASK [ensure-pip : Check for ensurepip module] 2024-01-04 18:39:47.440946 | focal-medium | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2024-01-04 18:39:47.441158 | focal-medium | [--altinstall] [--default-pip] 2024-01-04 18:39:47.441216 | focal-medium | 2024-01-04 18:39:47.441235 | focal-medium | optional arguments: 2024-01-04 18:39:47.441254 | focal-medium | -h, --help show this help message and exit 2024-01-04 18:39:47.441265 | focal-medium | --version Show the version of pip that is bundled with this Python. 2024-01-04 18:39:47.441282 | focal-medium | -v, --verbose Give more output. Option is additive, and can be used up to 3 2024-01-04 18:39:47.441297 | focal-medium | times. 2024-01-04 18:39:47.441312 | focal-medium | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2024-01-04 18:39:47.441323 | focal-medium | --user Install using the user scheme. 2024-01-04 18:39:47.441335 | focal-medium | --root ROOT Install everything relative to this alternate root directory. 2024-01-04 18:39:47.441346 | focal-medium | --altinstall Make an alternate install, installing only the X.Y versioned 2024-01-04 18:39:47.441369 | focal-medium | scripts (Default: pipX, pipX.Y, easy_install-X.Y). 2024-01-04 18:39:47.441382 | focal-medium | --default-pip Make a default pip install, installing the unqualified pip 2024-01-04 18:39:47.441392 | focal-medium | and easy_install in addition to the versioned scripts. 2024-01-04 18:39:47.549876 | focal-medium | ok: Runtime: 0:00:00.061184 2024-01-04 18:39:47.576898 | 2024-01-04 18:39:47.577108 | TASK [ensure-pip : Ensure python3-venv] 2024-01-04 18:39:47.707141 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:47.735260 | 2024-01-04 18:39:47.735581 | TASK [ensure-pip : Install pip from source] 2024-01-04 18:39:47.778192 | focal-medium | skipping: Conditional result was False 2024-01-04 18:39:47.821086 | 2024-01-04 18:39:47.821475 | TASK [ensure-pip : Probe for venv python full path] 2024-01-04 18:39:48.138166 | focal-medium | /usr/bin/python3 2024-01-04 18:39:48.400469 | focal-medium | ok: Runtime: 0:00:00.005233 2024-01-04 18:39:48.439416 | 2024-01-04 18:39:48.439772 | TASK [ensure-pip : Set host default] 2024-01-04 18:39:48.564351 | focal-medium | ok 2024-01-04 18:39:48.588144 | 2024-01-04 18:39:48.588344 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2024-01-04 18:39:48.701656 | focal-medium | ok 2024-01-04 18:39:48.723964 | 2024-01-04 18:39:48.724160 | TASK [Install bindep into temporary venv] 2024-01-04 18:39:55.394192 | focal-medium | changed 2024-01-04 18:39:55.431949 | 2024-01-04 18:39:55.432503 | TASK [Define bindep_command] 2024-01-04 18:39:55.575724 | focal-medium | ok 2024-01-04 18:39:55.598563 | 2024-01-04 18:39:55.598826 | LOOP [bindep : Include package tasks] 2024-01-04 18:39:55.762852 | focal-medium | included: /var/lib/zuul/builds/6720072d572c4215a3d18461c72c93ec/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/packages.yaml 2024-01-04 18:39:55.782421 | 2024-01-04 18:39:55.782657 | TASK [Define bindep_run fact] 2024-01-04 18:39:55.940001 | focal-medium | ok 2024-01-04 18:39:55.967011 | 2024-01-04 18:39:55.967286 | TASK [Get list of packages to install from bindep] 2024-01-04 18:39:57.162084 | focal-medium | libffi-dev 2024-01-04 18:39:57.162224 | focal-medium | libpq-dev 2024-01-04 18:39:57.162253 | focal-medium | libxml2-dev 2024-01-04 18:39:57.162270 | focal-medium | libxslt1-dev 2024-01-04 18:39:57.514636 | focal-medium | ok: Runtime: 0:00:01.148678 2024-01-04 18:39:57.541767 | 2024-01-04 18:39:57.542066 | TASK [Install distro packages from bindep] 2024-01-04 18:40:07.030734 | focal-medium | changed 2024-01-04 18:40:07.075315 | 2024-01-04 18:40:07.075566 | TASK [bindep : Check that packages are installed] 2024-01-04 18:40:09.257208 | focal-medium | ok: Runtime: 0:00:01.224399 2024-01-04 18:40:09.285982 | 2024-01-04 18:40:09.286232 | TASK [bindep : Fail if we cannot install all packages] 2024-01-04 18:40:09.384128 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:09.428018 | 2024-01-04 18:40:09.428522 | TASK [Run test-setup role] 2024-01-04 18:40:09.507825 | focal-medium | ok 2024-01-04 18:40:09.560179 | 2024-01-04 18:40:09.560500 | TASK [Check if project's tools/test-setup.sh exists] 2024-01-04 18:40:09.924614 | focal-medium | ok 2024-01-04 18:40:09.949339 | 2024-01-04 18:40:09.949625 | TASK [Run tools/test-setup.sh] 2024-01-04 18:40:10.104774 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:10.122886 | 2024-01-04 18:40:10.123077 | TASK [Remove bindep temp dir] 2024-01-04 18:40:21.011363 | focal-medium | ok 2024-01-04 18:40:21.044510 | 2024-01-04 18:40:21.044896 | PLAY RECAP 2024-01-04 18:40:21.045140 | focal-medium | ok: 21 changed: 6 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2024-01-04 18:40:21.045280 | 2024-01-04 18:40:21.389207 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2024-01-04 18:40:21.389670 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2024-01-04 18:40:24.408731 | 2024-01-04 18:40:24.408993 | PLAY [all] 2024-01-04 18:40:24.445204 | 2024-01-04 18:40:24.445428 | TASK [ensure-python : Validate python_version value] 2024-01-04 18:40:24.546778 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:24.585594 | 2024-01-04 18:40:24.585859 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2024-01-04 18:40:24.698757 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:24.725556 | 2024-01-04 18:40:24.725793 | TASK [ensure-python : Pull in venv package] 2024-01-04 18:40:24.888276 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:24.921995 | 2024-01-04 18:40:24.922258 | TASK [ensure-python : Set default RPM package name] 2024-01-04 18:40:25.022474 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:25.056264 | 2024-01-04 18:40:25.056663 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9 and Python 3.9] 2024-01-04 18:40:25.171094 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:25.214981 | 2024-01-04 18:40:25.215317 | TASK [ensure-python : Install RPM package] 2024-01-04 18:40:25.317089 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:25.348571 | 2024-01-04 18:40:25.348927 | TASK [ensure-python : Install python using pyenv] 2024-01-04 18:40:25.456626 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:25.495814 | 2024-01-04 18:40:25.496132 | TASK [ensure-python : Activate python using stow] 2024-01-04 18:40:25.612980 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:25.639401 | 2024-01-04 18:40:25.639724 | TASK [Install pip] 2024-01-04 18:40:25.699196 | focal-medium | ok 2024-01-04 18:40:25.764249 | 2024-01-04 18:40:25.764512 | TASK [ensure-pip : Check if pip is installed] 2024-01-04 18:40:26.435257 | focal-medium | /usr/bin/pip3 2024-01-04 18:40:26.517590 | focal-medium | usage: __main__.py [-h] {unpack,pack,convert,version,help} ... 2024-01-04 18:40:26.517647 | focal-medium | 2024-01-04 18:40:26.517657 | focal-medium | positional arguments: 2024-01-04 18:40:26.517671 | focal-medium | {unpack,pack,convert,version,help} 2024-01-04 18:40:26.517679 | focal-medium | commands 2024-01-04 18:40:26.517689 | focal-medium | unpack Unpack wheel 2024-01-04 18:40:26.517695 | focal-medium | pack Repack wheel 2024-01-04 18:40:26.517701 | focal-medium | convert Convert egg or wininst to wheel 2024-01-04 18:40:26.517707 | focal-medium | version Print version and exit 2024-01-04 18:40:26.517713 | focal-medium | help Show this help 2024-01-04 18:40:26.517719 | focal-medium | 2024-01-04 18:40:26.517725 | focal-medium | optional arguments: 2024-01-04 18:40:26.517731 | focal-medium | -h, --help show this help message and exit 2024-01-04 18:40:26.811330 | focal-medium | ok: Runtime: 0:00:00.098086 2024-01-04 18:40:26.841517 | 2024-01-04 18:40:26.841745 | LOOP [ensure-pip : Install pip from packages] 2024-01-04 18:40:26.988949 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:27.020961 | 2024-01-04 18:40:27.021229 | TASK [ensure-pip : Ensure setuptools] 2024-01-04 18:40:27.121589 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:27.149563 | 2024-01-04 18:40:27.149774 | TASK [ensure-pip : Check for ensurepip module] 2024-01-04 18:40:27.555521 | focal-medium | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2024-01-04 18:40:27.555677 | focal-medium | [--altinstall] [--default-pip] 2024-01-04 18:40:27.555703 | focal-medium | 2024-01-04 18:40:27.555726 | focal-medium | optional arguments: 2024-01-04 18:40:27.555808 | focal-medium | -h, --help show this help message and exit 2024-01-04 18:40:27.555828 | focal-medium | --version Show the version of pip that is bundled with this Python. 2024-01-04 18:40:27.555846 | focal-medium | -v, --verbose Give more output. Option is additive, and can be used up to 3 2024-01-04 18:40:27.555858 | focal-medium | times. 2024-01-04 18:40:27.555871 | focal-medium | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2024-01-04 18:40:27.555883 | focal-medium | --user Install using the user scheme. 2024-01-04 18:40:27.555895 | focal-medium | --root ROOT Install everything relative to this alternate root directory. 2024-01-04 18:40:27.555906 | focal-medium | --altinstall Make an alternate install, installing only the X.Y versioned 2024-01-04 18:40:27.555918 | focal-medium | scripts (Default: pipX, pipX.Y, easy_install-X.Y). 2024-01-04 18:40:27.555929 | focal-medium | --default-pip Make a default pip install, installing the unqualified pip 2024-01-04 18:40:27.555941 | focal-medium | and easy_install in addition to the versioned scripts. 2024-01-04 18:40:27.722840 | focal-medium | ok: Runtime: 0:00:00.056478 2024-01-04 18:40:27.756111 | 2024-01-04 18:40:27.756349 | TASK [ensure-pip : Ensure python3-venv] 2024-01-04 18:40:27.907503 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:27.938502 | 2024-01-04 18:40:27.938732 | TASK [ensure-pip : Install pip from source] 2024-01-04 18:40:27.987173 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:28.015349 | 2024-01-04 18:40:28.015592 | TASK [ensure-pip : Probe for venv python full path] 2024-01-04 18:40:28.334987 | focal-medium | /usr/bin/python3 2024-01-04 18:40:28.561833 | focal-medium | ok: Runtime: 0:00:00.005843 2024-01-04 18:40:28.592793 | 2024-01-04 18:40:28.592991 | TASK [ensure-pip : Set host default] 2024-01-04 18:40:28.714168 | focal-medium | ok 2024-01-04 18:40:28.740084 | 2024-01-04 18:40:28.740308 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2024-01-04 18:40:28.882671 | focal-medium | ok 2024-01-04 18:40:28.904763 | 2024-01-04 18:40:28.904945 | TASK [ensure-tox : Check if tox is installed] 2024-01-04 18:40:29.306912 | focal-medium | /home/ubuntu/.local/tox/bin/tox 2024-01-04 18:40:29.306986 | focal-medium | /home/ubuntu/.local/tox/bin/tox 2024-01-04 18:40:29.475244 | focal-medium | ok: Runtime: 0:00:00.004017 2024-01-04 18:40:29.516683 | 2024-01-04 18:40:29.517039 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2024-01-04 18:40:29.643489 | focal-medium | ok 2024-01-04 18:40:29.669559 | 2024-01-04 18:40:29.669906 | TASK [ensure-tox : Create local venv] 2024-01-04 18:40:29.864715 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:29.893136 | 2024-01-04 18:40:29.893387 | TASK [ensure-tox : Install tox to local venv] 2024-01-04 18:40:30.033326 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:30.060685 | 2024-01-04 18:40:30.060933 | TASK [ensure-tox : Export installed tox_executable path] 2024-01-04 18:40:30.157363 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:30.204227 | 2024-01-04 18:40:30.204636 | TASK [ensure-tox : Output tox version] 2024-01-04 18:40:30.972054 | focal-medium | ROOT: No tox.ini or setup.cfg or pyproject.toml found, assuming empty tox.ini at /home/ubuntu 2024-01-04 18:40:30.997201 | focal-medium | 4.11.4 from /home/ubuntu/.local/tox/lib/python3.8/site-packages/tox/__init__.py 2024-01-04 18:40:41.460858 | focal-medium | ok: Runtime: 0:00:00.380516 2024-01-04 18:40:41.495875 | 2024-01-04 18:40:41.496185 | TASK [ensure-tox : Make global symlink] 2024-01-04 18:40:41.545851 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:41.565583 | 2024-01-04 18:40:41.565814 | PLAY RECAP 2024-01-04 18:40:41.565939 | focal-medium | ok: 8 changed: 5 unreachable: 0 failed: 0 skipped: 16 rescued: 0 ignored: 0 2024-01-04 18:40:41.566013 | 2024-01-04 18:40:41.898526 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2024-01-04 18:40:41.899346 | RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2024-01-04 18:40:44.583086 | 2024-01-04 18:40:44.583374 | PLAY [all] 2024-01-04 18:40:44.614900 | 2024-01-04 18:40:44.615098 | TASK [revoke-sudo : Check if zuul is sudoer] 2024-01-04 18:40:45.153933 | focal-medium | ok: Runtime: 0:00:00.021861 2024-01-04 18:40:45.191528 | 2024-01-04 18:40:45.191730 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2024-01-04 18:40:45.733126 | focal-medium | ok: Runtime: 0:00:00.004751 2024-01-04 18:40:45.763845 | 2024-01-04 18:40:45.764077 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2024-01-04 18:40:46.171727 | focal-medium | sudo: a password is required 2024-01-04 18:40:46.313785 | focal-medium | ok: Runtime: 0:00:00.015724 2024-01-04 18:40:46.339825 | 2024-01-04 18:40:46.340081 | TASK [tox : Check to see if the constraints file exists] 2024-01-04 18:40:46.456463 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:46.485996 | 2024-01-04 18:40:46.486199 | TASK [tox : Fail if constraints file is missing] 2024-01-04 18:40:46.603815 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:46.636482 | 2024-01-04 18:40:46.636786 | TASK [tox : Record file location] 2024-01-04 18:40:46.736260 | focal-medium | skipping: Conditional result was False 2024-01-04 18:40:46.761767 | 2024-01-04 18:40:46.762017 | TASK [Install tox siblings] 2024-01-04 18:40:46.820312 | focal-medium | ok 2024-01-04 18:40:46.854820 | focal-medium | included: /var/lib/zuul/builds/6720072d572c4215a3d18461c72c93ec/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/tox/tasks/siblings.yaml 2024-01-04 18:40:46.866515 | 2024-01-04 18:40:46.866804 | TASK [Run tox without tests] 2024-01-04 18:40:47.500431 | focal-medium | ROOT: 207 D setup logging to DEBUG on pid 31099 [tox/report.py:219] 2024-01-04 18:40:47.607506 | focal-medium | pep8: 314 D created app data folder /home/ubuntu/.local/share/virtualenv [virtualenv/app_data/__init__.py:40] 2024-01-04 18:40:47.615140 | focal-medium | pep8: 321 I find interpreter for spec PythonSpec(major=3) [virtualenv/discovery/builtin.py:58] 2024-01-04 18:40:47.615290 | focal-medium | pep8: 322 D discover exe for PythonInfo(spec=CPython3.8.10.final.0-64, exe=/home/ubuntu/.local/tox/bin/python3, platform=linux, version='3.8.10 (default, Nov 22 2023, 10:22:35) \n[GCC 9.4.0]', encoding_fs_io=utf-8-utf-8) in /usr [virtualenv/discovery/py_info.py:441] 2024-01-04 18:40:47.616149 | focal-medium | pep8: 322 D filesystem is case-sensitive [virtualenv/info.py:26] 2024-01-04 18:40:47.617667 | focal-medium | pep8: 324 D get interpreter info via cmd: /usr/bin/python3.8 /home/ubuntu/.local/tox/lib/python3.8/site-packages/virtualenv/discovery/py_info.py 7F5bKi6EMlIKvzFH2nlnCP1mJdYCUnh4 9ZfSCoaQR8gXXtuiWVoUfQtFA3cPBA80 [virtualenv/discovery/cached_py_info.py:111] 2024-01-04 18:40:47.702335 | focal-medium | pep8: 408 D wrote python info of %s at (PosixPath('/usr/bin/python3.8'), PosixPath('/home/ubuntu/.local/share/virtualenv/py_info/1/df0893f56f349688326838aaeea0de204df53a132722cbd565e54b24a8fec5f6.json')) [virtualenv/app_data/via_disk_folder.py:151] 2024-01-04 18:40:47.703633 | focal-medium | pep8: 409 I proposed PythonInfo(spec=CPython3.8.10.final.0-64, system=/usr/bin/python3.8, exe=/home/ubuntu/.local/tox/bin/python3, platform=linux, version='3.8.10 (default, Nov 22 2023, 10:22:35) \n[GCC 9.4.0]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:65] 2024-01-04 18:40:47.703827 | focal-medium | pep8: 410 D accepted PythonInfo(spec=CPython3.8.10.final.0-64, system=/usr/bin/python3.8, exe=/home/ubuntu/.local/tox/bin/python3, platform=linux, version='3.8.10 (default, Nov 22 2023, 10:22:35) \n[GCC 9.4.0]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:67] 2024-01-04 18:40:47.749477 | focal-medium | pep8: 455 I create virtual environment via CPython3Posix(dest=/home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8, clear=False, no_vcs_ignore=False, global=False) [virtualenv/run/session.py:50] 2024-01-04 18:40:47.749770 | focal-medium | pep8: 456 D create folder /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/bin [virtualenv/util/path/_sync.py:12] 2024-01-04 18:40:47.749943 | focal-medium | pep8: 456 D create folder /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages [virtualenv/util/path/_sync.py:12] 2024-01-04 18:40:47.750363 | focal-medium | pep8: 457 D write /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:32] 2024-01-04 18:40:47.750408 | focal-medium | pep8: 457 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:47.750534 | focal-medium | pep8: 457 D implementation = CPython [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:47.750602 | focal-medium | pep8: 457 D version_info = 3.8.10.final.0 [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:47.750694 | focal-medium | pep8: 457 D virtualenv = 20.25.0 [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:47.750772 | focal-medium | pep8: 457 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:47.750832 | focal-medium | pep8: 457 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:47.750912 | focal-medium | pep8: 457 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:47.750958 | focal-medium | pep8: 457 D base-executable = /usr/bin/python3.8 [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:47.751400 | focal-medium | pep8: 458 D symlink /usr/bin/python3.8 to /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/bin/python [virtualenv/util/path/_sync.py:32] 2024-01-04 18:40:47.751882 | focal-medium | pep8: 458 D create virtualenv import hook file /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages/_virtualenv.pth [virtualenv/create/via_global_ref/api.py:91] 2024-01-04 18:40:47.752025 | focal-medium | pep8: 458 D create /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages/_virtualenv.py [virtualenv/create/via_global_ref/api.py:94] 2024-01-04 18:40:47.752498 | focal-medium | pep8: 459 D ============================== target debug ============================== [virtualenv/run/session.py:52] 2024-01-04 18:40:47.752924 | focal-medium | pep8: 459 D debug via /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/bin/python /home/ubuntu/.local/tox/lib/python3.8/site-packages/virtualenv/create/debug.py [virtualenv/create/creator.py:200] 2024-01-04 18:40:47.800991 | focal-medium | pep8: 459 D { 2024-01-04 18:40:47.801194 | focal-medium | "sys": { 2024-01-04 18:40:47.801232 | focal-medium | "executable": "/home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/bin/python", 2024-01-04 18:40:47.801246 | focal-medium | "_base_executable": "/home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/bin/python", 2024-01-04 18:40:47.801257 | focal-medium | "prefix": "/home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8", 2024-01-04 18:40:47.801278 | focal-medium | "base_prefix": "/usr", 2024-01-04 18:40:47.801291 | focal-medium | "real_prefix": null, 2024-01-04 18:40:47.801302 | focal-medium | "exec_prefix": "/home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8", 2024-01-04 18:40:47.801313 | focal-medium | "base_exec_prefix": "/usr", 2024-01-04 18:40:47.801330 | focal-medium | "path": [ 2024-01-04 18:40:47.801398 | focal-medium | "/usr/lib/python38.zip", 2024-01-04 18:40:47.801448 | focal-medium | "/usr/lib/python3.8", 2024-01-04 18:40:47.801475 | focal-medium | "/usr/lib/python3.8/lib-dynload", 2024-01-04 18:40:47.801498 | focal-medium | "/home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages" 2024-01-04 18:40:47.801524 | focal-medium | ], 2024-01-04 18:40:47.801548 | focal-medium | "meta_path": [ 2024-01-04 18:40:47.801573 | focal-medium | "", 2024-01-04 18:40:47.801594 | focal-medium | "", 2024-01-04 18:40:47.801610 | focal-medium | "", 2024-01-04 18:40:47.801621 | focal-medium | "" 2024-01-04 18:40:47.801642 | focal-medium | ], 2024-01-04 18:40:47.801691 | focal-medium | "fs_encoding": "utf-8", 2024-01-04 18:40:47.801722 | focal-medium | "io_encoding": "utf-8" 2024-01-04 18:40:47.801747 | focal-medium | }, 2024-01-04 18:40:47.801770 | focal-medium | "version": "3.8.10 (default, Nov 22 2023, 10:22:35) \n[GCC 9.4.0]", 2024-01-04 18:40:47.801782 | focal-medium | "makefile_filename": "/usr/lib/python3.8/config-3.8-x86_64-linux-gnu/Makefile", 2024-01-04 18:40:47.801793 | focal-medium | "os": "", 2024-01-04 18:40:47.801803 | focal-medium | "site": "", 2024-01-04 18:40:47.801814 | focal-medium | "datetime": "", 2024-01-04 18:40:47.801824 | focal-medium | "math": "", 2024-01-04 18:40:47.801835 | focal-medium | "json": "" 2024-01-04 18:40:47.801845 | focal-medium | } [virtualenv/run/session.py:53] 2024-01-04 18:40:47.802539 | focal-medium | pep8: 508 I add seed packages via FromAppData(download=False, pip=bundle, setuptools=bundle, wheel=bundle, via=copy, app_data_dir=/home/ubuntu/.local/share/virtualenv) [virtualenv/run/session.py:57] 2024-01-04 18:40:47.806781 | focal-medium | pep8: 513 D install pip from wheel /home/ubuntu/.local/tox/lib/python3.8/site-packages/virtualenv/seed/wheels/embed/pip-23.3.1-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:49] 2024-01-04 18:40:47.808242 | focal-medium | pep8: 513 D install setuptools from wheel /home/ubuntu/.local/tox/lib/python3.8/site-packages/virtualenv/seed/wheels/embed/setuptools-69.0.2-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:49] 2024-01-04 18:40:47.809044 | focal-medium | pep8: 514 D install wheel from wheel /home/ubuntu/.local/tox/lib/python3.8/site-packages/virtualenv/seed/wheels/embed/wheel-0.42.0-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:49] 2024-01-04 18:40:47.811320 | focal-medium | pep8: 518 D build install image for setuptools-69.0.2-py3-none-any.whl to /home/ubuntu/.local/share/virtualenv/wheel/3.8/image/1/CopyPipInstall/setuptools-69.0.2-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:47] 2024-01-04 18:40:47.811951 | focal-medium | pep8: 518 D build install image for wheel-0.42.0-py3-none-any.whl to /home/ubuntu/.local/share/virtualenv/wheel/3.8/image/1/CopyPipInstall/wheel-0.42.0-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:47] 2024-01-04 18:40:47.815359 | focal-medium | pep8: 522 D build install image for pip-23.3.1-py3-none-any.whl to /home/ubuntu/.local/share/virtualenv/wheel/3.8/image/1/CopyPipInstall/pip-23.3.1-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:47] 2024-01-04 18:40:47.884069 | focal-medium | pep8: 590 D copy /home/ubuntu/.local/share/virtualenv/wheel/3.8/image/1/CopyPipInstall/wheel-0.42.0-py3-none-any/wheel-0.42.0.virtualenv to /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages/wheel-0.42.0.virtualenv [virtualenv/util/path/_sync.py:40] 2024-01-04 18:40:47.885328 | focal-medium | pep8: 592 D copy directory /home/ubuntu/.local/share/virtualenv/wheel/3.8/image/1/CopyPipInstall/wheel-0.42.0-py3-none-any/wheel to /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages/wheel [virtualenv/util/path/_sync.py:40] 2024-01-04 18:40:47.914297 | focal-medium | pep8: 620 D copy directory /home/ubuntu/.local/share/virtualenv/wheel/3.8/image/1/CopyPipInstall/wheel-0.42.0-py3-none-any/wheel-0.42.0.dist-info to /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages/wheel-0.42.0.dist-info [virtualenv/util/path/_sync.py:40] 2024-01-04 18:40:47.924165 | focal-medium | pep8: 630 D generated console scripts wheel3 wheel3.8 wheel wheel-3.8 [virtualenv/seed/embed/via_app_data/pip_install/base.py:43] 2024-01-04 18:40:48.009396 | focal-medium | pep8: 716 D copy directory /home/ubuntu/.local/share/virtualenv/wheel/3.8/image/1/CopyPipInstall/setuptools-69.0.2-py3-none-any/setuptools-69.0.2.dist-info to /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages/setuptools-69.0.2.dist-info [virtualenv/util/path/_sync.py:40] 2024-01-04 18:40:48.012442 | focal-medium | pep8: 719 D copy /home/ubuntu/.local/share/virtualenv/wheel/3.8/image/1/CopyPipInstall/setuptools-69.0.2-py3-none-any/distutils-precedence.pth to /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages/distutils-precedence.pth [virtualenv/util/path/_sync.py:40] 2024-01-04 18:40:48.013417 | focal-medium | pep8: 720 D copy directory /home/ubuntu/.local/share/virtualenv/wheel/3.8/image/1/CopyPipInstall/setuptools-69.0.2-py3-none-any/_distutils_hack to /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages/_distutils_hack [virtualenv/util/path/_sync.py:40] 2024-01-04 18:40:48.014783 | focal-medium | pep8: 721 D copy /home/ubuntu/.local/share/virtualenv/wheel/3.8/image/1/CopyPipInstall/setuptools-69.0.2-py3-none-any/setuptools-69.0.2.virtualenv to /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages/setuptools-69.0.2.virtualenv [virtualenv/util/path/_sync.py:40] 2024-01-04 18:40:48.015601 | focal-medium | pep8: 722 D copy directory /home/ubuntu/.local/share/virtualenv/wheel/3.8/image/1/CopyPipInstall/setuptools-69.0.2-py3-none-any/pkg_resources to /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages/pkg_resources [virtualenv/util/path/_sync.py:40] 2024-01-04 18:40:48.035621 | focal-medium | pep8: 742 D copy directory /home/ubuntu/.local/share/virtualenv/wheel/3.8/image/1/CopyPipInstall/setuptools-69.0.2-py3-none-any/setuptools to /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages/setuptools [virtualenv/util/path/_sync.py:40] 2024-01-04 18:40:48.112783 | focal-medium | pep8: 819 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:43] 2024-01-04 18:40:48.148518 | focal-medium | pep8: 855 D copy /home/ubuntu/.local/share/virtualenv/wheel/3.8/image/1/CopyPipInstall/pip-23.3.1-py3-none-any/pip-23.3.1.virtualenv to /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages/pip-23.3.1.virtualenv [virtualenv/util/path/_sync.py:40] 2024-01-04 18:40:48.148862 | focal-medium | pep8: 855 D copy directory /home/ubuntu/.local/share/virtualenv/wheel/3.8/image/1/CopyPipInstall/pip-23.3.1-py3-none-any/pip to /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages/pip [virtualenv/util/path/_sync.py:40] 2024-01-04 18:40:48.247610 | focal-medium | pep8: 954 D copy directory /home/ubuntu/.local/share/virtualenv/wheel/3.8/image/1/CopyPipInstall/pip-23.3.1-py3-none-any/pip-23.3.1.dist-info to /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/lib/python3.8/site-packages/pip-23.3.1.dist-info [virtualenv/util/path/_sync.py:40] 2024-01-04 18:40:48.249715 | focal-medium | pep8: 956 D generated console scripts pip-3.8 pip3.8 pip pip3 [virtualenv/seed/embed/via_app_data/pip_install/base.py:43] 2024-01-04 18:40:48.250231 | focal-medium | pep8: 956 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python [virtualenv/run/session.py:63] 2024-01-04 18:40:48.254421 | focal-medium | pep8: 961 D write /home/ubuntu/src/review.opendev.org/openstack/charm-vault/.tox/pep8/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:32] 2024-01-04 18:40:48.254578 | focal-medium | pep8: 961 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:48.254757 | focal-medium | pep8: 961 D implementation = CPython [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:48.255060 | focal-medium | pep8: 961 D version_info = 3.8.10.final.0 [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:48.255263 | focal-medium | pep8: 962 D virtualenv = 20.25.0 [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:48.255521 | focal-medium | pep8: 962 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:48.255739 | focal-medium | pep8: 962 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:48.255816 | focal-medium | pep8: 962 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:48.255972 | focal-medium | pep8: 962 D base-executable = /usr/bin/python3.8 [virtualenv/create/pyenv_cfg.py:36] 2024-01-04 18:40:48.263423 | focal-medium | pep8: 970 W install_deps> python -I -m pip install flake8==3.9.2 git+https://github.com/juju/charm-tools.git [tox/tox_env/api.py:427] 2024-01-04 18:40:49.534124 | focal-medium | Collecting git+https://github.com/juju/charm-tools.git 2024-01-04 18:40:49.534620 | focal-medium | Cloning https://github.com/juju/charm-tools.git to /tmp/pip-req-build-f2f21y91 2024-01-04 18:40:49.551629 | focal-medium | Running command git clone --filter=blob:none --quiet https://github.com/juju/charm-tools.git /tmp/pip-req-build-f2f21y91 2024-01-04 18:40:52.644205 | focal-medium | Resolved https://github.com/juju/charm-tools.git to commit 52eb3a685dc4637a8d010654c97f05d83bec0cce 2024-01-04 18:40:52.653984 | focal-medium | Preparing metadata (setup.py): started 2024-01-04 18:40:53.065247 | focal-medium | Preparing metadata (setup.py): finished with status 'done' 2024-01-04 18:40:53.159787 | focal-medium | Collecting flake8==3.9.2 2024-01-04 18:40:53.514092 | focal-medium | Downloading flake8-3.9.2-py2.py3-none-any.whl (73 kB) 2024-01-04 18:40:53.625806 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 73.1/73.1 kB 628.7 kB/s eta 0:00:00 2024-01-04 18:40:53.679437 | focal-medium | Collecting pyflakes<2.4.0,>=2.3.0 (from flake8==3.9.2) 2024-01-04 18:40:53.765847 | focal-medium | Downloading pyflakes-2.3.1-py2.py3-none-any.whl (68 kB) 2024-01-04 18:40:53.860903 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 68.8/68.8 kB 673.2 kB/s eta 0:00:00 2024-01-04 18:40:53.893350 | focal-medium | Collecting pycodestyle<2.8.0,>=2.7.0 (from flake8==3.9.2) 2024-01-04 18:40:53.979484 | focal-medium | Downloading pycodestyle-2.7.0-py2.py3-none-any.whl (41 kB) 2024-01-04 18:40:54.002991 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 41.7/41.7 kB 2.2 MB/s eta 0:00:00 2024-01-04 18:40:54.030408 | focal-medium | Collecting mccabe<0.7.0,>=0.6.0 (from flake8==3.9.2) 2024-01-04 18:40:54.116445 | focal-medium | Downloading mccabe-0.6.1-py2.py3-none-any.whl (8.6 kB) 2024-01-04 18:40:54.306073 | focal-medium | Collecting cheetah3<4.0,>=3.0.0 (from charm-tools==0.0.0) 2024-01-04 18:40:54.401687 | focal-medium | Downloading Cheetah3-3.2.6.post1-cp38-cp38-manylinux1_x86_64.whl (677 kB) 2024-01-04 18:40:54.619138 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 677.9/677.9 kB 3.2 MB/s eta 0:00:00 2024-01-04 18:40:54.697735 | focal-medium | Collecting pyyaml!=5.4.0,!=5.4.1,!=6.0,<7.0,>=5.0 (from charm-tools==0.0.0) 2024-01-04 18:40:54.784129 | focal-medium | Downloading PyYAML-6.0.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (2.1 kB) 2024-01-04 18:40:54.908474 | focal-medium | Collecting requests<3.0.0,>=2.0.0 (from charm-tools==0.0.0) 2024-01-04 18:40:54.997598 | focal-medium | Downloading requests-2.31.0-py3-none-any.whl.metadata (4.6 kB) 2024-01-04 18:40:55.030784 | focal-medium | Collecting blessings<2.0 (from charm-tools==0.0.0) 2024-01-04 18:40:55.118161 | focal-medium | Downloading blessings-1.7-py3-none-any.whl (18 kB) 2024-01-04 18:40:55.171139 | focal-medium | Collecting otherstuf<=1.1.0 (from charm-tools==0.0.0) 2024-01-04 18:40:55.259251 | focal-medium | Downloading otherstuf-1.1.0-py2.py3-none-any.whl (7.3 kB) 2024-01-04 18:40:55.352874 | focal-medium | Collecting path.py<13,>=10.5 (from charm-tools==0.0.0) 2024-01-04 18:40:55.442891 | focal-medium | Downloading path.py-12.5.0-py3-none-any.whl (2.3 kB) 2024-01-04 18:40:55.548405 | focal-medium | Collecting pip<23,>=1.5.4 (from charm-tools==0.0.0) 2024-01-04 18:40:55.637721 | focal-medium | Downloading pip-22.3.1-py3-none-any.whl (2.1 MB) 2024-01-04 18:40:55.775691 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.1/2.1 MB 15.5 MB/s eta 0:00:00 2024-01-04 18:40:55.846575 | focal-medium | Collecting jujubundlelib<0.6 (from charm-tools==0.0.0) 2024-01-04 18:40:55.935062 | focal-medium | Downloading jujubundlelib-0.5.7.tar.gz (30 kB) 2024-01-04 18:40:55.957663 | focal-medium | Preparing metadata (setup.py): started 2024-01-04 18:40:56.201375 | focal-medium | Preparing metadata (setup.py): finished with status 'done' 2024-01-04 18:40:56.373844 | focal-medium | Collecting virtualenv<21,>=1.11.4 (from charm-tools==0.0.0) 2024-01-04 18:40:56.460177 | focal-medium | Downloading virtualenv-20.25.0-py3-none-any.whl.metadata (4.5 kB) 2024-01-04 18:40:56.546780 | focal-medium | Collecting colander<1.9 (from charm-tools==0.0.0) 2024-01-04 18:40:56.718561 | focal-medium | Downloading colander-1.8.3-py2.py3-none-any.whl (83 kB) 2024-01-04 18:40:56.731125 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 83.6/83.6 kB 10.8 MB/s eta 0:00:00 2024-01-04 18:40:56.790383 | focal-medium | Collecting jsonschema<4.18.0 (from charm-tools==0.0.0) 2024-01-04 18:40:56.876826 | focal-medium | Downloading jsonschema-4.17.3-py3-none-any.whl (90 kB) 2024-01-04 18:40:56.888377 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 90.4/90.4 kB 13.0 MB/s eta 0:00:00 2024-01-04 18:40:57.037299 | focal-medium | Collecting keyring<24 (from charm-tools==0.0.0) 2024-01-04 18:40:57.124968 | focal-medium | Downloading keyring-23.13.1-py3-none-any.whl (37 kB) 2024-01-04 18:40:57.157988 | focal-medium | Collecting secretstorage<3.4 (from charm-tools==0.0.0) 2024-01-04 18:40:57.244495 | focal-medium | Downloading SecretStorage-3.3.3-py3-none-any.whl (15 kB) 2024-01-04 18:40:57.317367 | focal-medium | Collecting dict2colander==0.2 (from charm-tools==0.0.0) 2024-01-04 18:40:57.485425 | focal-medium | Downloading dict2colander-0.2.tar.gz (7.4 kB) 2024-01-04 18:40:57.498904 | focal-medium | Preparing metadata (setup.py): started 2024-01-04 18:40:57.773668 | focal-medium | Preparing metadata (setup.py): finished with status 'done' 2024-01-04 18:40:57.806323 | focal-medium | Collecting vergit<2.0.0,>=1.0.0 (from charm-tools==0.0.0) 2024-01-04 18:40:57.894373 | focal-medium | Downloading vergit-1.0.2.tar.gz (3.2 kB) 2024-01-04 18:40:57.908891 | focal-medium | Preparing metadata (setup.py): started 2024-01-04 18:40:58.444675 | focal-medium | Preparing metadata (setup.py): finished with status 'done' 2024-01-04 18:40:58.475674 | focal-medium | Collecting requirements-parser<0.6 (from charm-tools==0.0.0) 2024-01-04 18:40:58.562105 | focal-medium | Downloading requirements_parser-0.5.0-py3-none-any.whl (18 kB) 2024-01-04 18:40:58.889993 | focal-medium | Collecting ruamel.yaml<0.18 (from charm-tools==0.0.0) 2024-01-04 18:40:58.978712 | focal-medium | Downloading ruamel.yaml-0.17.40-py3-none-any.whl.metadata (19 kB) 2024-01-04 18:40:59.017990 | focal-medium | Collecting pathspec<0.11 (from charm-tools==0.0.0) 2024-01-04 18:40:59.105704 | focal-medium | Downloading pathspec-0.10.3-py3-none-any.whl (29 kB) 2024-01-04 18:40:59.148829 | focal-medium | Collecting six (from blessings<2.0->charm-tools==0.0.0) 2024-01-04 18:40:59.235039 | focal-medium | Downloading six-1.16.0-py2.py3-none-any.whl (11 kB) 2024-01-04 18:40:59.288574 | focal-medium | Collecting translationstring (from colander<1.9->charm-tools==0.0.0) 2024-01-04 18:40:59.378542 | focal-medium | Downloading translationstring-1.4-py2.py3-none-any.whl (15 kB) 2024-01-04 18:40:59.412083 | focal-medium | Collecting iso8601 (from colander<1.9->charm-tools==0.0.0) 2024-01-04 18:40:59.499241 | focal-medium | Downloading iso8601-2.1.0-py3-none-any.whl.metadata (3.7 kB) 2024-01-04 18:40:59.508009 | focal-medium | Requirement already satisfied: setuptools>=11.3 in ./.tox/pep8/lib/python3.8/site-packages (from colander<1.9->charm-tools==0.0.0) (69.0.2) 2024-01-04 18:40:59.630309 | focal-medium | Collecting attrs>=17.4.0 (from jsonschema<4.18.0->charm-tools==0.0.0) 2024-01-04 18:40:59.718453 | focal-medium | Downloading attrs-23.2.0-py3-none-any.whl.metadata (9.5 kB) 2024-01-04 18:40:59.791096 | focal-medium | Collecting importlib-resources>=1.4.0 (from jsonschema<4.18.0->charm-tools==0.0.0) 2024-01-04 18:40:59.877149 | focal-medium | Downloading importlib_resources-6.1.1-py3-none-any.whl.metadata (4.1 kB) 2024-01-04 18:40:59.913227 | focal-medium | Collecting pkgutil-resolve-name>=1.3.10 (from jsonschema<4.18.0->charm-tools==0.0.0) 2024-01-04 18:40:59.999700 | focal-medium | Downloading pkgutil_resolve_name-1.3.10-py3-none-any.whl (4.7 kB) 2024-01-04 18:41:00.063676 | focal-medium | Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 (from jsonschema<4.18.0->charm-tools==0.0.0) 2024-01-04 18:41:00.151119 | focal-medium | Downloading pyrsistent-0.20.0-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (27 kB) 2024-01-04 18:41:00.239372 | focal-medium | Collecting jaraco.classes (from keyring<24->charm-tools==0.0.0) 2024-01-04 18:41:00.325547 | focal-medium | Downloading jaraco.classes-3.3.0-py3-none-any.whl.metadata (2.9 kB) 2024-01-04 18:41:00.428838 | focal-medium | Collecting importlib-metadata>=4.11.4 (from keyring<24->charm-tools==0.0.0) 2024-01-04 18:41:00.522915 | focal-medium | Downloading importlib_metadata-7.0.1-py3-none-any.whl.metadata (4.9 kB) 2024-01-04 18:41:00.559623 | focal-medium | Collecting jeepney>=0.4.2 (from keyring<24->charm-tools==0.0.0) 2024-01-04 18:41:00.645432 | focal-medium | Downloading jeepney-0.8.0-py3-none-any.whl (48 kB) 2024-01-04 18:41:00.655689 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 48.4/48.4 kB 8.5 MB/s eta 0:00:00 2024-01-04 18:41:00.736948 | focal-medium | Collecting stuf>=0.9.16 (from otherstuf<=1.1.0->charm-tools==0.0.0) 2024-01-04 18:41:00.911148 | focal-medium | Downloading stuf-0.9.16-py3-none-any.whl (27 kB) 2024-01-04 18:41:01.001294 | focal-medium | Collecting path (from path.py<13,>=10.5->charm-tools==0.0.0) 2024-01-04 18:41:01.088963 | focal-medium | Downloading path-16.9.0-py3-none-any.whl.metadata (6.7 kB) 2024-01-04 18:41:01.297255 | focal-medium | Collecting charset-normalizer<4,>=2 (from requests<3.0.0,>=2.0.0->charm-tools==0.0.0) 2024-01-04 18:41:01.384197 | focal-medium | Downloading charset_normalizer-3.3.2-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (33 kB) 2024-01-04 18:41:01.427151 | focal-medium | Collecting idna<4,>=2.5 (from requests<3.0.0,>=2.0.0->charm-tools==0.0.0) 2024-01-04 18:41:01.522590 | focal-medium | Downloading idna-3.6-py3-none-any.whl.metadata (9.9 kB) 2024-01-04 18:41:01.648869 | focal-medium | Collecting urllib3<3,>=1.21.1 (from requests<3.0.0,>=2.0.0->charm-tools==0.0.0) 2024-01-04 18:41:01.763818 | focal-medium | Downloading urllib3-2.1.0-py3-none-any.whl.metadata (6.4 kB) 2024-01-04 18:41:01.838476 | focal-medium | Collecting certifi>=2017.4.17 (from requests<3.0.0,>=2.0.0->charm-tools==0.0.0) 2024-01-04 18:41:01.951987 | focal-medium | Downloading certifi-2023.11.17-py3-none-any.whl.metadata (2.2 kB) 2024-01-04 18:41:02.030809 | focal-medium | Collecting types-setuptools>=57.0.0 (from requirements-parser<0.6->charm-tools==0.0.0) 2024-01-04 18:41:02.118633 | focal-medium | Downloading types_setuptools-69.0.0.0-py3-none-any.whl.metadata (1.6 kB) 2024-01-04 18:41:02.194983 | focal-medium | Collecting ruamel.yaml.clib>=0.2.7 (from ruamel.yaml<0.18->charm-tools==0.0.0) 2024-01-04 18:41:02.282463 | focal-medium | Downloading ruamel.yaml.clib-0.2.8-cp38-cp38-manylinux_2_5_x86_64.manylinux1_x86_64.whl.metadata (2.2 kB) 2024-01-04 18:41:02.669745 | focal-medium | Collecting cryptography>=2.0 (from secretstorage<3.4->charm-tools==0.0.0) 2024-01-04 18:41:02.756267 | focal-medium | Downloading cryptography-41.0.7-cp37-abi3-manylinux_2_28_x86_64.whl.metadata (5.2 kB) 2024-01-04 18:41:02.839655 | focal-medium | Collecting distlib<1,>=0.3.7 (from virtualenv<21,>=1.11.4->charm-tools==0.0.0) 2024-01-04 18:41:02.926587 | focal-medium | Downloading distlib-0.3.8-py2.py3-none-any.whl.metadata (5.1 kB) 2024-01-04 18:41:02.979611 | focal-medium | Collecting filelock<4,>=3.12.2 (from virtualenv<21,>=1.11.4->charm-tools==0.0.0) 2024-01-04 18:41:03.066415 | focal-medium | Downloading filelock-3.13.1-py3-none-any.whl.metadata (2.8 kB) 2024-01-04 18:41:03.116272 | focal-medium | Collecting platformdirs<5,>=3.9.1 (from virtualenv<21,>=1.11.4->charm-tools==0.0.0) 2024-01-04 18:41:03.207058 | focal-medium | Downloading platformdirs-4.1.0-py3-none-any.whl.metadata (11 kB) 2024-01-04 18:41:03.610294 | focal-medium | Collecting cffi>=1.12 (from cryptography>=2.0->secretstorage<3.4->charm-tools==0.0.0) 2024-01-04 18:41:03.695550 | focal-medium | Downloading cffi-1.16.0-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (1.5 kB) 2024-01-04 18:41:03.834377 | focal-medium | Collecting zipp>=0.5 (from importlib-metadata>=4.11.4->keyring<24->charm-tools==0.0.0) 2024-01-04 18:41:03.920076 | focal-medium | Downloading zipp-3.17.0-py3-none-any.whl.metadata (3.7 kB) 2024-01-04 18:41:04.208758 | focal-medium | Collecting parse>=1.6.6 (from stuf>=0.9.16->otherstuf<=1.1.0->charm-tools==0.0.0) 2024-01-04 18:41:04.295675 | focal-medium | Downloading parse-1.20.0-py2.py3-none-any.whl.metadata (21 kB) 2024-01-04 18:41:04.455900 | focal-medium | Collecting more-itertools (from jaraco.classes->keyring<24->charm-tools==0.0.0) 2024-01-04 18:41:04.542548 | focal-medium | Downloading more_itertools-10.1.0-py3-none-any.whl.metadata (33 kB) 2024-01-04 18:41:04.686731 | focal-medium | Collecting pycparser (from cffi>=1.12->cryptography>=2.0->secretstorage<3.4->charm-tools==0.0.0) 2024-01-04 18:41:04.775558 | focal-medium | Downloading pycparser-2.21-py2.py3-none-any.whl (118 kB) 2024-01-04 18:41:04.789018 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 118.7/118.7 kB 13.1 MB/s eta 0:00:00 2024-01-04 18:41:05.011529 | focal-medium | Downloading PyYAML-6.0.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (736 kB) 2024-01-04 18:41:05.031116 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 736.6/736.6 kB 48.7 MB/s eta 0:00:00 2024-01-04 18:41:05.115986 | focal-medium | Downloading requests-2.31.0-py3-none-any.whl (62 kB) 2024-01-04 18:41:05.126180 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 62.6/62.6 kB 9.3 MB/s eta 0:00:00 2024-01-04 18:41:05.214302 | focal-medium | Downloading ruamel.yaml-0.17.40-py3-none-any.whl (113 kB) 2024-01-04 18:41:05.226483 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 113.7/113.7 kB 13.6 MB/s eta 0:00:00 2024-01-04 18:41:05.323699 | focal-medium | Downloading virtualenv-20.25.0-py3-none-any.whl (3.8 MB) 2024-01-04 18:41:05.451995 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 3.8/3.8 MB 31.4 MB/s eta 0:00:00 2024-01-04 18:41:05.538680 | focal-medium | Downloading attrs-23.2.0-py3-none-any.whl (60 kB) 2024-01-04 18:41:05.549469 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 60.8/60.8 kB 8.9 MB/s eta 0:00:00 2024-01-04 18:41:05.637450 | focal-medium | Downloading certifi-2023.11.17-py3-none-any.whl (162 kB) 2024-01-04 18:41:05.648677 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 162.5/162.5 kB 22.1 MB/s eta 0:00:00 2024-01-04 18:41:05.735187 | focal-medium | Downloading charset_normalizer-3.3.2-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (141 kB) 2024-01-04 18:41:05.747022 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 141.1/141.1 kB 20.3 MB/s eta 0:00:00 2024-01-04 18:41:05.836046 | focal-medium | Downloading cryptography-41.0.7-cp37-abi3-manylinux_2_28_x86_64.whl (4.4 MB) 2024-01-04 18:41:06.210974 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.4/4.4 MB 11.8 MB/s eta 0:00:00 2024-01-04 18:41:06.298171 | focal-medium | Downloading distlib-0.3.8-py2.py3-none-any.whl (468 kB) 2024-01-04 18:41:06.316951 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 468.9/468.9 kB 36.4 MB/s eta 0:00:00 2024-01-04 18:41:06.403932 | focal-medium | Downloading filelock-3.13.1-py3-none-any.whl (11 kB) 2024-01-04 18:41:06.497356 | focal-medium | Downloading idna-3.6-py3-none-any.whl (61 kB) 2024-01-04 18:41:06.511096 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 61.6/61.6 kB 7.6 MB/s eta 0:00:00 2024-01-04 18:41:06.598881 | focal-medium | Downloading importlib_metadata-7.0.1-py3-none-any.whl (23 kB) 2024-01-04 18:41:06.692219 | focal-medium | Downloading importlib_resources-6.1.1-py3-none-any.whl (33 kB) 2024-01-04 18:41:06.787204 | focal-medium | Downloading platformdirs-4.1.0-py3-none-any.whl (17 kB) 2024-01-04 18:41:06.891662 | focal-medium | Downloading pyrsistent-0.20.0-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (121 kB) 2024-01-04 18:41:06.905838 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 121.8/121.8 kB 13.6 MB/s eta 0:00:00 2024-01-04 18:41:07.002717 | focal-medium | Downloading ruamel.yaml.clib-0.2.8-cp38-cp38-manylinux_2_5_x86_64.manylinux1_x86_64.whl (596 kB) 2024-01-04 18:41:07.021269 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 596.0/596.0 kB 46.0 MB/s eta 0:00:00 2024-01-04 18:41:07.107812 | focal-medium | Downloading types_setuptools-69.0.0.0-py3-none-any.whl (51 kB) 2024-01-04 18:41:07.121161 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 51.2/51.2 kB 6.2 MB/s eta 0:00:00 2024-01-04 18:41:07.209570 | focal-medium | Downloading urllib3-2.1.0-py3-none-any.whl (104 kB) 2024-01-04 18:41:07.221903 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 104.6/104.6 kB 14.7 MB/s eta 0:00:00 2024-01-04 18:41:07.310221 | focal-medium | Downloading iso8601-2.1.0-py3-none-any.whl (7.5 kB) 2024-01-04 18:41:07.411568 | focal-medium | Downloading jaraco.classes-3.3.0-py3-none-any.whl (5.9 kB) 2024-01-04 18:41:07.514706 | focal-medium | Downloading path-16.9.0-py3-none-any.whl (24 kB) 2024-01-04 18:41:07.614871 | focal-medium | Downloading cffi-1.16.0-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (444 kB) 2024-01-04 18:41:07.628932 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 444.7/444.7 kB 47.4 MB/s eta 0:00:00 2024-01-04 18:41:07.716625 | focal-medium | Downloading parse-1.20.0-py2.py3-none-any.whl (19 kB) 2024-01-04 18:41:07.809828 | focal-medium | Downloading zipp-3.17.0-py3-none-any.whl (7.4 kB) 2024-01-04 18:41:07.900793 | focal-medium | Downloading more_itertools-10.1.0-py3-none-any.whl (55 kB) 2024-01-04 18:41:07.913396 | focal-medium | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 55.8/55.8 kB 7.3 MB/s eta 0:00:00 2024-01-04 18:41:08.015564 | focal-medium | Building wheels for collected packages: charm-tools, dict2colander, jujubundlelib, vergit 2024-01-04 18:41:08.016710 | focal-medium | Building wheel for charm-tools (setup.py): started 2024-01-04 18:41:08.673421 | focal-medium | Building wheel for charm-tools (setup.py): finished with status 'done' 2024-01-04 18:41:08.675800 | focal-medium | Created wheel for charm-tools: filename=charm_tools-0.0.0-py3-none-any.whl size=137196 sha256=91f72f61fc79a6838184b9061f8e67c5b17ce27c5f0dd81bfdfd976b1215317a 2024-01-04 18:41:08.676768 | focal-medium | Stored in directory: /tmp/pip-ephem-wheel-cache-69pvsww8/wheels/e1/49/f2/5f6a2a76c66284eb23c7607ff9b913e581ef3df81b342c7564 2024-01-04 18:41:08.683942 | focal-medium | Building wheel for dict2colander (setup.py): started 2024-01-04 18:41:08.962169 | focal-medium | Building wheel for dict2colander (setup.py): finished with status 'done' 2024-01-04 18:41:08.963557 | focal-medium | Created wheel for dict2colander: filename=dict2colander-0.2-py3-none-any.whl size=7448 sha256=cd2be71294dcc5ed7407a1b543323ab76cd304874cc3c9f48276bb7203c9a111 2024-01-04 18:41:08.964185 | focal-medium | Stored in directory: /home/ubuntu/.cache/pip/wheels/fc/66/b0/4ee41c58b149b1c0e6cc114ac368e5170966f9aaa4857cd75e 2024-01-04 18:41:08.970779 | focal-medium | Building wheel for jujubundlelib (setup.py): started 2024-01-04 18:41:09.309850 | focal-medium | Building wheel for jujubundlelib (setup.py): finished with status 'done' 2024-01-04 18:41:09.311451 | focal-medium | Created wheel for jujubundlelib: filename=jujubundlelib-0.5.7-py2.py3-none-any.whl size=33929 sha256=a4223b18652f2cf739b4dd839cf6473d1a4c317e448136936804c974dd4ce493 2024-01-04 18:41:09.312096 | focal-medium | Stored in directory: /home/ubuntu/.cache/pip/wheels/94/dc/17/5be242c261f73b58dfe2ba9bd9dfc751de012e9288cebee39a 2024-01-04 18:41:09.318897 | focal-medium | Building wheel for vergit (setup.py): started 2024-01-04 18:41:09.849686 | focal-medium | Building wheel for vergit (setup.py): finished with status 'done' 2024-01-04 18:41:09.852593 | focal-medium | Created wheel for vergit: filename=vergit-1.0.2-py3-none-any.whl size=3204 sha256=ac719adece8c746008f9cbd0bfd2698446fcca26d6e300ee30d0316e48eae898 2024-01-04 18:41:09.854210 | focal-medium | Stored in directory: /home/ubuntu/.cache/pip/wheels/82/92/3d/735753ddb628c00c4c1c3b35065fbff5d2aaf0eedbec57c8dd 2024-01-04 18:41:09.862679 | focal-medium | Successfully built charm-tools dict2colander jujubundlelib vergit 2024-01-04 18:41:10.369613 | focal-medium | Installing collected packages: translationstring, parse, mccabe, distlib, dict2colander, zipp, vergit, urllib3, types-setuptools, stuf, six, ruamel.yaml.clib, pyyaml, pyrsistent, pyflakes, pycparser, pycodestyle, platformdirs, pkgutil-resolve-name, pip, pathspec, path, more-itertools, jeepney, iso8601, idna, filelock, cheetah3, charset-normalizer, certifi, attrs, virtualenv, ruamel.yaml, requirements-parser, requests, path.py, otherstuf, jujubundlelib, jaraco.classes, importlib-resources, importlib-metadata, flake8, colander, cffi, blessings, jsonschema, cryptography, secretstorage, keyring, charm-tools 2024-01-04 18:41:11.424559 | focal-medium | Attempting uninstall: pip 2024-01-04 18:41:11.426038 | focal-medium | Found existing installation: pip 23.3.1 2024-01-04 18:41:11.511546 | focal-medium | Uninstalling pip-23.3.1: 2024-01-04 18:41:11.539017 | focal-medium | Successfully uninstalled pip-23.3.1 2024-01-04 18:41:15.404729 | focal-medium | Successfully installed attrs-23.2.0 blessings-1.7 certifi-2023.11.17 cffi-1.16.0 charm-tools-0.0.0 charset-normalizer-3.3.2 cheetah3-3.2.6.post1 colander-1.8.3 cryptography-41.0.7 dict2colander-0.2 distlib-0.3.8 filelock-3.13.1 flake8-3.9.2 idna-3.6 importlib-metadata-7.0.1 importlib-resources-6.1.1 iso8601-2.1.0 jaraco.classes-3.3.0 jeepney-0.8.0 jsonschema-4.17.3 jujubundlelib-0.5.7 keyring-23.13.1 mccabe-0.6.1 more-itertools-10.1.0 otherstuf-1.1.0 parse-1.20.0 path-16.9.0 path.py-12.5.0 pathspec-0.10.3 pip-22.3.1 pkgutil-resolve-name-1.3.10 platformdirs-4.1.0 pycodestyle-2.7.0 pycparser-2.21 pyflakes-2.3.1 pyrsistent-0.20.0 pyyaml-6.0.1 requests-2.31.0 requirements-parser-0.5.0 ruamel.yaml-0.17.40 ruamel.yaml.clib-0.2.8 secretstorage-3.3.3 six-1.16.0 stuf-0.9.16 translationstring-1.4 types-setuptools-69.0.0.0 urllib3-2.1.0 vergit-1.0.2 virtualenv-20.25.0 zipp-3.17.0 2024-01-04 18:41:15.757038 | focal-medium | pep8: 28462 I exit 0 (27.49 seconds) /home/ubuntu/src/review.opendev.org/openstack/charm-vault> python -I -m pip install flake8==3.9.2 git+https://github.com/juju/charm-tools.git pid=31114 [tox/execute/api.py:279] 2024-01-04 18:41:15.761023 | focal-medium | pep8: OK (28.16 seconds) 2024-01-04 18:41:15.761057 | focal-medium | congratulations :) (28.26 seconds) 2024-01-04 18:41:15.958588 | focal-medium | ok: Runtime: 0:00:28.563083 2024-01-04 18:41:16.006042 | 2024-01-04 18:41:16.006435 | TASK [Create a tempfile to save tox showconfig] 2024-01-04 18:41:16.586549 | focal-medium | changed 2024-01-04 18:41:16.609049 | 2024-01-04 18:41:16.609241 | TASK [Get tox envlist config] 2024-01-04 18:41:17.652642 | focal-medium | ok: Runtime: 0:00:00.443803 2024-01-04 18:41:17.681755 | 2024-01-04 18:41:17.681976 | TASK [tox : Install any sibling python packages] 2024-01-04 18:41:18.333787 | focal-medium | ok: No setup.cfg, no action needed 2024-01-04 18:41:18.366721 | 2024-01-04 18:41:18.366970 | TASK [tox : Remove tempfile] 2024-01-04 18:41:19.073213 | focal-medium | changed 2024-01-04 18:41:19.101955 | 2024-01-04 18:41:19.102277 | TASK [Emit tox command] 2024-01-04 18:41:19.233767 | /home/ubuntu/.local/tox/bin/tox -epep8 -vv --skip-missing-interpreters=false 2024-01-04 18:41:19.258310 | 2024-01-04 18:41:19.258550 | TASK [Run tox] 2024-01-04 18:41:19.917451 | focal-medium | ROOT: 185 D setup logging to DEBUG on pid 31430 [tox/report.py:219] 2024-01-04 18:41:20.037472 | focal-medium | pep8: 304 I find interpreter for spec PythonSpec(major=3) [virtualenv/discovery/builtin.py:58] 2024-01-04 18:41:20.037595 | focal-medium | pep8: 305 D discover exe for PythonInfo(spec=CPython3.8.10.final.0-64, exe=/home/ubuntu/.local/tox/bin/python3, platform=linux, version='3.8.10 (default, Nov 22 2023, 10:22:35) \n[GCC 9.4.0]', encoding_fs_io=utf-8-utf-8) in /usr [virtualenv/discovery/py_info.py:441] 2024-01-04 18:41:20.038327 | focal-medium | pep8: 305 D filesystem is case-sensitive [virtualenv/info.py:26] 2024-01-04 18:41:20.039688 | focal-medium | pep8: 307 D got python info of %s from (PosixPath('/usr/bin/python3.8'), PosixPath('/home/ubuntu/.local/share/virtualenv/py_info/1/df0893f56f349688326838aaeea0de204df53a132722cbd565e54b24a8fec5f6.json')) [virtualenv/app_data/via_disk_folder.py:131] 2024-01-04 18:41:20.040760 | focal-medium | pep8: 308 I proposed PythonInfo(spec=CPython3.8.10.final.0-64, system=/usr/bin/python3.8, exe=/home/ubuntu/.local/tox/bin/python3, platform=linux, version='3.8.10 (default, Nov 22 2023, 10:22:35) \n[GCC 9.4.0]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:65] 2024-01-04 18:41:20.040829 | focal-medium | pep8: 308 D accepted PythonInfo(spec=CPython3.8.10.final.0-64, system=/usr/bin/python3.8, exe=/home/ubuntu/.local/tox/bin/python3, platform=linux, version='3.8.10 (default, Nov 22 2023, 10:22:35) \n[GCC 9.4.0]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:67] 2024-01-04 18:41:20.082024 | focal-medium | pep8: 349 W commands[0]> flake8 src unit_tests [tox/tox_env/api.py:427] 2024-01-04 18:41:20.916091 | focal-medium | src/lib/charm/vault_pki.py:206:35: E231 missing whitespace after ',' 2024-01-04 18:41:20.916196 | focal-medium | src/lib/charm/vault_pki.py:237:80: E501 line too long (96 > 79 characters) 2024-01-04 18:41:20.948456 | focal-medium | pep8: 1215 C exit 1 (0.86 seconds) /home/ubuntu/src/review.opendev.org/openstack/charm-vault> flake8 src unit_tests pid=31437 [tox/execute/api.py:279] 2024-01-04 18:41:20.950267 | focal-medium | pep8: FAIL code 1 (0.93=setup[0.07]+cmd[0.86] seconds) 2024-01-04 18:41:20.950329 | focal-medium | evaluation failed :( (1.04 seconds) 2024-01-04 18:41:21.301707 | focal-medium | ERROR 2024-01-04 18:41:21.302193 | focal-medium | { 2024-01-04 18:41:21.302385 | focal-medium | "delta": "0:00:01.323945", 2024-01-04 18:41:21.302505 | focal-medium | "end": "2024-01-04 18:41:21.007755", 2024-01-04 18:41:21.302593 | focal-medium | "msg": "non-zero return code", 2024-01-04 18:41:21.302685 | focal-medium | "rc": 1, 2024-01-04 18:41:21.302767 | focal-medium | "start": "2024-01-04 18:41:19.683810" 2024-01-04 18:41:21.302843 | focal-medium | } 2024-01-04 18:41:21.333689 | 2024-01-04 18:41:21.333876 | TASK [tox : Look for output] 2024-01-04 18:41:21.933028 | focal-medium | ok 2024-01-04 18:41:21.961403 | 2024-01-04 18:41:21.961637 | TASK [tox : Return file comments to Zuul] 2024-01-04 18:41:22.082343 | focal-medium | ok 2024-01-04 18:41:22.098203 | 2024-01-04 18:41:22.098360 | PLAY RECAP 2024-01-04 18:41:22.098492 | focal-medium | ok: 12 changed: 7 unreachable: 0 failed: 1 skipped: 3 rescued: 0 ignored: 0 2024-01-04 18:41:22.098566 | 2024-01-04 18:41:22.401555 | RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2024-01-04 18:41:22.402336 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2024-01-04 18:41:24.814003 | 2024-01-04 18:41:24.814240 | PLAY [all] 2024-01-04 18:41:24.846830 | 2024-01-04 18:41:24.847049 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2024-01-04 18:41:24.947003 | focal-medium | skipping: Conditional result was False 2024-01-04 18:41:24.991437 | 2024-01-04 18:41:24.991780 | TASK [fetch-tox-output : Set tox log path for single node] 2024-01-04 18:41:25.116151 | focal-medium | ok 2024-01-04 18:41:25.141049 | 2024-01-04 18:41:25.141284 | TASK [fetch-tox-output : Ensure local tox dir] 2024-01-04 18:41:25.712967 | focal-medium | changed 2024-01-04 18:41:25.735256 | 2024-01-04 18:41:25.735472 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2024-01-04 18:41:25.851239 | focal-medium | skipping: Conditional result was False 2024-01-04 18:41:25.878710 | 2024-01-04 18:41:25.878945 | TASK [fetch-tox-output : Set envlist fact] 2024-01-04 18:41:26.054974 | focal-medium | ok 2024-01-04 18:41:26.079125 | 2024-01-04 18:41:26.079449 | TASK [fetch-tox-output : Get tox version] 2024-01-04 18:41:26.996196 | focal-medium | ROOT: No tox.ini or setup.cfg or pyproject.toml found, assuming empty tox.ini at /home/ubuntu 2024-01-04 18:41:27.020181 | focal-medium | 4.11.4 from /home/ubuntu/.local/tox/lib/python3.8/site-packages/tox/__init__.py 2024-01-04 18:41:27.124224 | focal-medium | ok: Runtime: 0:00:00.372693 2024-01-04 18:41:27.156795 | 2024-01-04 18:41:27.157037 | TASK [fetch-tox-output : Find all default environments] 2024-01-04 18:41:27.306790 | focal-medium | skipping: Conditional result was False 2024-01-04 18:41:27.336378 | 2024-01-04 18:41:27.336589 | TASK [fetch-tox-output : Set envlist fact] 2024-01-04 18:41:27.440648 | focal-medium | skipping: Conditional result was False 2024-01-04 18:41:27.469428 | 2024-01-04 18:41:27.469666 | TASK [fetch-tox-output : Find all default environments] 2024-01-04 18:41:27.621898 | focal-medium | skipping: Conditional result was False 2024-01-04 18:41:27.648975 | 2024-01-04 18:41:27.649179 | TASK [fetch-tox-output : Set envlist fact] 2024-01-04 18:41:27.767247 | focal-medium | skipping: Conditional result was False 2024-01-04 18:41:27.805560 | 2024-01-04 18:41:27.805773 | LOOP [fetch-tox-output : Copy tox logs] 2024-01-04 18:41:27.906358 | focal-medium | skipping: Conditional result was False 2024-01-04 18:41:27.952493 | 2024-01-04 18:41:27.953043 | LOOP [fetch-tox-output : Collect tox logs] 2024-01-04 18:41:29.820335 | focal-medium | changed: 2024-01-04 18:41:29.820754 | focal-medium | cd+++++++++ ./ 2024-01-04 18:41:29.820851 | focal-medium | >f+++++++++ 1-commands[0].log 2024-01-04 18:41:29.820917 | 2024-01-04 18:41:29.844205 | 2024-01-04 18:41:29.844467 | PLAY RECAP 2024-01-04 18:41:29.844638 | focal-medium | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2024-01-04 18:41:29.844739 | 2024-01-04 18:41:30.208221 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2024-01-04 18:41:30.208662 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2024-01-04 18:41:32.820855 | 2024-01-04 18:41:32.821287 | PLAY [all] 2024-01-04 18:41:32.850743 | 2024-01-04 18:41:32.850976 | TASK [fetch-subunit-output : Find stestr or testr executable] 2024-01-04 18:41:33.188299 | focal-medium | changed: non-zero return code 2024-01-04 18:41:33.227914 | 2024-01-04 18:41:33.228151 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2024-01-04 18:41:33.324977 | focal-medium | skipping: Conditional result was False 2024-01-04 18:41:33.351430 | 2024-01-04 18:41:33.351631 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2024-01-04 18:41:33.487283 | 2024-01-04 18:41:33.487559 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2024-01-04 18:41:33.622888 | 2024-01-04 18:41:33.623161 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2024-01-04 18:41:33.727346 | focal-medium | skipping: Conditional result was False 2024-01-04 18:41:33.756287 | 2024-01-04 18:41:33.756469 | LOOP [fetch-subunit-output : Generate subunit file] 2024-01-04 18:41:33.895882 | 2024-01-04 18:41:33.896176 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2024-01-04 18:41:33.986652 | focal-medium | skipping: Conditional result was False 2024-01-04 18:41:34.015772 | 2024-01-04 18:41:34.015968 | TASK [fetch-subunit-output : Remove the temporary file] 2024-01-04 18:41:34.100743 | focal-medium | skipping: Conditional result was False 2024-01-04 18:41:34.130131 | 2024-01-04 18:41:34.130340 | TASK [fetch-subunit-output : Process and fetch subunit results] 2024-01-04 18:41:34.247360 | focal-medium | skipping: Conditional result was False 2024-01-04 18:41:34.269446 | 2024-01-04 18:41:34.269766 | PLAY RECAP 2024-01-04 18:41:34.269875 | focal-medium | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2024-01-04 18:41:34.269932 | 2024-01-04 18:41:34.510101 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2024-01-04 18:41:34.510488 | POST-RUN START: [trusted : github.com/openstack-charmers/zosci-config/playbooks/base/post.yaml@master] 2024-01-04 18:41:37.248679 | 2024-01-04 18:41:37.248915 | PLAY [localhost] 2024-01-04 18:41:37.267657 | 2024-01-04 18:41:37.267797 | TASK [Gathering Facts] 2024-01-04 18:41:39.666955 | localhost | ok 2024-01-04 18:41:39.718173 | 2024-01-04 18:41:39.718425 | TASK [Include Zuul manifest role] 2024-01-04 18:41:39.778081 | localhost | ok 2024-01-04 18:41:39.868353 | 2024-01-04 18:41:39.868873 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2024-01-04 18:41:40.435214 | localhost | changed 2024-01-04 18:41:40.457656 | 2024-01-04 18:41:40.457836 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2024-01-04 18:41:40.570316 | localhost | ok 2024-01-04 18:41:40.596086 | 2024-01-04 18:41:40.596333 | TASK [Include customized upload logs role] 2024-01-04 18:41:40.651914 | localhost | Output suppressed because no_log was given 2024-01-04 18:41:40.749809 | 2024-01-04 18:41:40.750098 | TASK [Set zuul-log-path fact] 2024-01-04 18:41:40.879220 | localhost | ok 2024-01-04 18:41:40.937952 | 2024-01-04 18:41:40.938253 | TASK [set-zuul-log-path-fact : Set log path for a change] 2024-01-04 18:41:41.072593 | localhost | skipping: Conditional result was False 2024-01-04 18:41:41.112509 | 2024-01-04 18:41:41.112913 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2024-01-04 18:41:41.222902 | localhost | skipping: Conditional result was False 2024-01-04 18:41:41.252262 | 2024-01-04 18:41:41.252488 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2024-01-04 18:41:41.391628 | localhost | skipping: Conditional result was False 2024-01-04 18:41:41.416355 | 2024-01-04 18:41:41.416617 | TASK [set-zuul-log-path-fact : Set log path for a change] 2024-01-04 18:41:41.544588 | localhost | ok 2024-01-04 18:41:41.571192 | 2024-01-04 18:41:41.571414 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2024-01-04 18:41:41.665025 | localhost | skipping: Conditional result was False 2024-01-04 18:41:41.692323 | 2024-01-04 18:41:41.692521 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2024-01-04 18:41:41.785782 | localhost | skipping: Conditional result was False 2024-01-04 18:41:41.818975 | 2024-01-04 18:41:41.819186 | TASK [upload-swift : Ensure logs are readable before uploading] 2024-01-04 18:41:42.479060 | localhost | ok: Runtime: 0:00:00.006199 2024-01-04 18:41:42.507037 | 2024-01-04 18:41:42.507289 | TASK [upload-swift : Upload logs to swift]