Installer crashes during installation: OS Error 16

[joeljosedev]

Description

The installer crashes during the installation process due to OS Error 16. The issue was found in a Pop!_OS 21.10 virtual machine running on VMware Workstation 16 Player on a Windows 11 host.

Contents of /tmp/installer.log

[INFO distinst:crates/disks/src/config/disks.rs:579] probed "/dev/sda"
[INFO distinst:crates/disks/src/config/disk.rs:164] obtaining disk information from /dev/sda
[INFO distinst:crates/disks/src/serial.rs:14] obtaining serial model from /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:31] opening disk at /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:37] unable to open disk; creating new table on it
[INFO distinst:crates/external/src/lvm.rs:209] obtaining list of physical volumes
[DEBUG distinst:crates/disk-types/src/sector.rs:17] get block size for "/sys/class/block/sda"
[INFO distinst:src/auto/options/mod.rs:150] found free sectors at the end on "/dev/sda": 1025 - 41940992
[INFO distinst:src/auto/options/mod.rs:176] found erase option on "/dev/sda": 41943040 sectors
[INFO distinst:crates/disks/src/config/disks.rs:579] probed "/dev/sda"
[INFO distinst:crates/disks/src/config/disk.rs:164] obtaining disk information from /dev/sda
[INFO distinst:crates/disks/src/serial.rs:14] obtaining serial model from /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:31] opening disk at /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:37] unable to open disk; creating new table on it
[DEBUG distinst:crates/disk-types/src/sector.rs:17] get block size for "/sys/class/block/sda"
[INFO distinst:crates/disk-ops/src/parted.rs:8] getting device at /dev/sda
[INFO distinst:crates/disks/src/config/disk.rs:164] obtaining disk information from /dev/sda
[INFO distinst:crates/disks/src/serial.rs:14] obtaining serial model from /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:31] opening disk at /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:37] unable to open disk; creating new table on it
[INFO distinst:crates/disks/src/config/disk.rs:348] specifying to write new table on /dev/sda
[INFO distinst:crates/disks/src/config/disk.rs:278] unmount all partitions on /dev/sda
[DEBUG distinst:crates/disk-types/src/sector.rs:17] get block size for "/sys/class/block/sda"
[DEBUG distinst:crates/disk-types/src/sector.rs:17] get block size for "/sys/class/block/sda"
[INFO distinst:crates/disks/src/config/disk_trait.rs:118] checking if 4096:33550335 overlaps
[DEBUG distinst:crates/disk-types/src/sector.rs:17] get block size for "/sys/class/block/sda"
[DEBUG distinst:crates/disk-types/src/sector.rs:17] get block size for "/sys/class/block/sda"
[DEBUG distinst:crates/disk-types/src/sector.rs:17] get block size for "/sys/class/block/sda"
[INFO distinst:crates/disks/src/config/disk_trait.rs:118] checking if 33550336:41938943 overlaps
[DEBUG distinst:crates/disk-types/src/sector.rs:17] get block size for "/sys/class/block/sda"
[DEBUG distinst:crates/disk-types/src/sector.rs:17] get block size for "/sys/class/block/sda"
[ERROR distinst:ffi/src/lib.rs:49] libdistinst: pointer in FFI is null
[ERROR distinst:ffi/src/lib.rs:49] libdistinst: pointer in FFI is null
[ERROR distinst:ffi/src/lib.rs:49] libdistinst: pointer in FFI is null
[INFO distinst:src/installer/state.rs:33] starting initializing step
[INFO distinst:src/installer/steps/initialize.rs:15] Initializing
[INFO distinst:src/installer/steps/initialize.rs:20] config.squashfs: found at /cdrom/casper_pop-os_21.10_amd64_intel_debug_48/filesystem.squashfs
[INFO distinst:crates/disk-ops/src/parted.rs:8] getting device at /dev/sda
[INFO distinst:crates/disks/src/config/disk.rs:164] obtaining disk information from /dev/sda
[INFO distinst:crates/disks/src/serial.rs:14] obtaining serial model from /dev/sda
[INFO distinst:crates/disks/src/config/disks.rs:808] verifying if keyfiles have paths
[INFO distinst:crates/disk-ops/src/parted.rs:31] opening disk at /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:37] unable to open disk; creating new table on it
[INFO distinst:crates/disks/src/config/disks.rs:397] devices to modify: []
[INFO distinst:crates/external/src/lvm.rs:209] obtaining list of physical volumes
[INFO distinst:crates/disks/src/config/disks.rs:399] volume map: {}
[INFO distinst:crates/external/src/lvm.rs:51] searching for device maps to deactivate
[INFO distinst:crates/disks/src/config/disks.rs:401] pvs: []
[INFO distinst:crates/disks/src/config/disks.rs:550] unmounting devices
[INFO distinst:crates/disks/src/config/disk.rs:305] unmount all partitions with a target on /dev/sda
[INFO distinst:src/installer/state.rs:33] starting partitioning step
[INFO distinst:src/installer/steps/partition.rs:25] /dev/sda: Committing changes to disk
[INFO distinst:crates/external/src/lvm.rs:209] obtaining list of physical volumes
[INFO distinst:crates/disks/src/config/disk.rs:786] committing changes to /dev/sda: Disk {
    model_name: "VMware, VMware Virtual S",
    serial: "",
    device_path: "/dev/sda",
    file_system: None,
    mount_point: None,
    size: 41943040,
    device_type: "PED_DEVICE_SCSI",
    table_type: Some(
        Msdos,
    ),
    read_only: false,
    mklabel: true,
    partitions: [
        PartitionInfo {
            bitflags: 4,
            number: -1,
            ordering: -1,
            start_sector: 4096,
            end_sector: 33550335,
            part_type: Primary,
            filesystem: Some(
                Ext4,
            ),
            flags: [],
            name: None,
            device_path: "",
            mount_point: None,
            target: Some(
                "/",
            ),
            original_vg: None,
            volume_group: None,
            key_id: None,
            identifiers: PartitionIdentifiers {
                id: None,
                label: None,
                part_label: None,
                part_uuid: None,
                path: None,
                uuid: None,
            },
        },
        PartitionInfo {
            bitflags: 4,
            number: -1,
            ordering: -1,
            start_sector: 33550336,
            end_sector: 41938943,
            part_type: Primary,
            filesystem: Some(
                Swap,
            ),
            flags: [],
            name: None,
            device_path: "",
            mount_point: None,
            target: None,
            original_vg: None,
            volume_group: None,
            key_id: None,
            identifiers: PartitionIdentifiers {
                id: None,
                label: None,
                part_label: None,
                part_uuid: None,
                path: None,
                uuid: None,
            },
        },
    ],
}
[INFO distinst:crates/disk-ops/src/parted.rs:8] getting device at /dev/sda
[INFO distinst:crates/disks/src/config/disk.rs:164] obtaining disk information from /dev/sda
[INFO distinst:crates/disks/src/serial.rs:14] obtaining serial model from /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:31] opening disk at /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:37] unable to open disk; creating new table on it
[INFO distinst:crates/disks/src/config/disk.rs:613] generating diff of disk at /dev/sda
[INFO distinst:crates/disks/src/config/disk.rs:669] proposed layout:
	-1: 4096 - 33550335
	-1: 33550336 - 41938943
[INFO distinst:crates/disk-ops/src/ops.rs:50] /dev/sda: executing remove operations
[INFO distinst:crates/external/src/block.rs:14] using wipefs to wipe signatures from "/dev/sda"
[INFO distinst:crates/external/src/lib.rs:34] executing wipefs with ["-a", "/dev/sda"]
[INFO distinst:crates/disk-ops/src/mklabel.rs:16] writing Msdos table on /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:20] opening device at /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:62] committing changes to /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:78] syncing device at /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:20] opening device at /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:31] opening disk at /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:78] syncing device at /dev/sda
[INFO distinst:crates/disk-ops/src/ops.rs:94] /dev/sda: executing change operations
[INFO distinst:crates/disk-ops/src/parted.rs:20] opening device at /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:78] syncing device at /dev/sda
[INFO distinst:crates/disk-ops/src/ops.rs:218] /dev/sda: executing creation operations
[INFO distinst:crates/disk-ops/src/ops.rs:221] creating partition (PartitionCreate { path: "/dev/sda", start_sector: 4096, end_sector: 33550335, format: true, file_system: Some(Ext4), kind: Primary, flags: [], label: None }) on /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:20] opening device at /dev/sda
[INFO distinst:crates/disk-ops/src/mkpart.rs:81] creating new partition with 33546239 sectors: 4096 - 33550335
[INFO distinst:crates/disk-ops/src/parted.rs:31] opening disk at /dev/sda
[INFO distinst:crates/disk-ops/src/mkpart.rs:124] committing new partition (4096:33550335) on /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:62] committing changes to /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:78] syncing device at /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:8] getting device at /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:31] opening disk at /dev/sda
[INFO distinst:crates/disk-ops/src/ops.rs:221] creating partition (PartitionCreate { path: "/dev/sda", start_sector: 33550336, end_sector: 41938943, format: true, file_system: Some(Swap), kind: Primary, flags: [], label: None }) on /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:20] opening device at /dev/sda
[INFO distinst:crates/disk-ops/src/mkpart.rs:81] creating new partition with 8388607 sectors: 33550336 - 41938943
[INFO distinst:crates/disk-ops/src/parted.rs:31] opening disk at /dev/sda
[INFO distinst:crates/disk-ops/src/mkpart.rs:124] committing new partition (33550336:41938943) on /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:62] committing changes to /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:78] syncing device at /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:8] getting device at /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:31] opening disk at /dev/sda
[INFO distinst:crates/external/src/lib.rs:34] executing blockdev with ["--flushbufs", "--rereadpt", "/dev/sda"]
[INFO distinst:crates/disk-ops/src/ops.rs:292] executing format operations
[INFO distinst:crates/disk-ops/src/ops.rs:296] formatting /dev/sda1 with Ext4
[INFO distinst:crates/disk-ops/src/ops.rs:296] formatting /dev/sda2 with Swap
[INFO distinst:crates/external/src/lib.rs:34] executing mkfs.ext4 with ["-F", "-q", "-E", "lazy_itable_init", "/dev/sda1"]
[INFO distinst:crates/external/src/lib.rs:34] executing mkswap with ["-f", "/dev/sda2"]
[INFO distinst:crates/disks/src/config/disk.rs:807] reloading disk information for /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:8] getting device at /dev/sda
[INFO distinst:crates/disks/src/config/disk.rs:164] obtaining disk information from /dev/sda
[INFO distinst:crates/disks/src/serial.rs:14] obtaining serial model from /dev/sda
[INFO distinst:crates/disk-ops/src/parted.rs:31] opening disk at /dev/sda
[INFO distinst:crates/disks/src/config/partitions/mod.rs:118] obtaining partition information from /dev/sda1
[INFO distinst:crates/disks/src/config/partitions/mod.rs:118] obtaining partition information from /dev/sda2
[INFO distinst:crates/disks/src/config/disk.rs:831] checking for mount target at 4096
[INFO distinst:crates/external/src/lib.rs:34] executing blockdev with ["--flushbufs", "--rereadpt", "/dev/sda"]
[INFO distinst:src/installer/mod.rs:170] mounting temporary chroot directory at distinst
[INFO distinst:src/installer/mod.rs:175] mounting all targets to the temporary chroot
[INFO distinst:crates/disks/src/config/disks.rs:243] mounting "/dev/sda1" (ext4) to "/tmp/distinst.8Bmviy0gy7Mj/"
[INFO distinst:src/installer/state.rs:33] starting extracting step
[INFO distinst:src/installer/mod.rs:413] Extracting /cdrom/casper_pop-os_21.10_amd64_intel_debug_48/filesystem.squashfs
[DEBUG distinst:crates/squashfs/src/lib.rs:166] "unsquashfs" "-f" "-d" "/tmp/distinst.8Bmviy0gy7Mj" "/cdrom/casper_pop-os_21.10_amd64_intel_debug_48/filesystem.squashfs"
[INFO distinst:src/installer/state.rs:33] starting configuring chroot step
[INFO distinst:src/installer/steps/configure/mod.rs:79] Configuring on /tmp/distinst.8Bmviy0gy7Mj
[INFO distinst:src/installer/steps/configure/mod.rs:93] applying LVM initramfs autodetect workaround
[INFO distinst:src/installer/traits.rs:32] generating /etc/crypttab & /etc/fstab in memory
[INFO distinst:src/installer/traits.rs:144] generated the following crypttab data:
cryptswap UUID=c33459f9-3e04-462b-9b76-701f1710ef87 /dev/urandom swap,plain,offset=1024,cipher=aes-xts-plain64,size=512

[INFO distinst:src/installer/traits.rs:146] generated the following fstab data:
UUID=83779b93-e64e-4820-a302-30ed9958b05a  /  ext4  noatime,errors=remount-ro  0  0
/dev/mapper/cryptswap  none  swap  defaults  0  0

[INFO distinst:src/installer/steps/configure/mod.rs:105] writing /etc/crypttab
[INFO distinst:src/installer/steps/configure/mod.rs:110] writing /etc/fstab
[INFO distinst:src/installer/steps/configure/mod.rs:146] chrooting into target on /tmp/distinst.8Bmviy0gy7Mj
[INFO distinst:crates/chroot/src/command.rs:72] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "check_language_support" "-l" "en" "--show-installed"
[INFO distinst:src/installer/steps/configure/chroot_conf.rs:267] symlinking update-initramfs to true for duration of initial setup
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "sh" "-c" "mv /usr/sbin/update-initramfs /usr/sbin/update-initramfs.bak"
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "sh" "-c" "ln -s /usr/bin/true /usr/sbin/update-initramfs"
[INFO distinst:src/installer/steps/configure/chroot_conf.rs:244] setting hostname to pop-os
[INFO distinst:src/installer/steps/configure/chroot_conf.rs:253] setting hosts file
[INFO distinst:src/installer/steps/configure/chroot_conf.rs:237] generating machine id via `dbus-uuidgen`
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "sh" "-c" "dbus-uuidgen > /etc/machine-id"
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "ln" "-sf" "/etc/machine-id" "/var/lib/dbus/machine-id"
[INFO distinst:src/installer/steps/configure/chroot_conf.rs:358] creating /etc/resolv.conf
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "ln" "-sf" "../run/systemd/resolve/stub-resolv.conf" "/etc/resolv.conf"
[INFO distinst:src/installer/steps/configure/chroot_conf.rs:230] generating locales via `locale-gen` and `update-locale`
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "locale-gen" "--purge" "en_GB.UTF-8"
[INFO distinst:crates/chroot/src/command.rs:99] Generating locales (this might take a while)...
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "update-locale" "--reset" "LANG=en_GB.UTF-8"
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "useradd" "-m" "-G" "adm,sudo,lpadmin" "-s" "/bin/bash" "-c" "Joel Jose" "joel"
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "passwd" "joel"
[INFO distinst:src/installer/steps/configure/chroot_conf.rs:105] adding apt-cdrom to /etc/apt/sources.list
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "apt-cdrom" "-o" "Acquire::cdrom::AutoDetect=0" "-o" "Acquire::cdrom::mount=/cdrom" "-o" "APT::CDROM::NoMount=1" "add"
[INFO distinst:crates/chroot/src/command.rs:99] Using CD-ROM mount point /cdrom/
[INFO distinst:crates/chroot/src/command.rs:99] Identifying... [8358c87a2d60d2e47b5360ce31a1851e-2]
[INFO distinst:crates/chroot/src/command.rs:99] Scanning disc for index files...
[INFO distinst:crates/chroot/src/command.rs:99] Found 2 package indices, 0 source indices, 0 translation indices and 1 signatures
[INFO distinst:crates/chroot/src/command.rs:99] Found label 'Pop_OS 21.10 _Impish Indri_ - Release amd64 (20220124)'
[INFO distinst:crates/chroot/src/command.rs:99] This disc is called: 
[INFO distinst:crates/chroot/src/command.rs:99] 'Pop_OS 21.10 _Impish Indri_ - Release amd64 (20220124)'
[WARN distinst:crates/chroot/src/command.rs:99] gpgv: Signature made Mon 24 Jan 2022 08:18:04 UTC
[WARN distinst:crates/chroot/src/command.rs:99] gpgv:                using RSA key 63C46DF0140D738961429F4E204DD8AEC33A7AFF
[WARN distinst:crates/chroot/src/command.rs:99] gpgv:                issuer "[email protected]"
[WARN distinst:crates/chroot/src/command.rs:99] gpgv: Good signature from "Pop OS (ISO Signing Key) <[email protected]>"
[INFO distinst:src/installer/steps/configure/chroot_conf.rs:40] installing packages: ["grub-common", "grub2-common", "grub-pc", "e2fsprogs"]
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "apt-get" "install" "-q" "-y" "-o" "Acquire::cdrom::AutoDetect=0" "-o" "Acquire::cdrom::mount=/cdrom" "-o" "APT::CDROM::NoMount=1" "grub-common" "grub2-common" "grub-pc" "e2fsprogs"
[INFO distinst:src/installer/steps/configure/chroot_conf.rs:156] disabling apt-cdrom from /etc/apt/sources.list
[INFO distinst:src/installer/steps/configure/chroot_conf.rs:57] removing packages: ["btrfs-progs", "casper", "cifs-utils", "distinst", "distinst-v2", "dmraid", "expect", "f2fs-tools", "fatresize", "gettext", "gparted", "gparted-common", "kpartx", "kpartx-boot", "libdistinst", "libdmraid1.0.0.rc16", "libgranite6", "libinih1", "libnss-mymachines", "localechooser-data", "os-prober", "pop-installer", "pop-installer-casper", "pop-shop-casper", "squashfs-tools", "systemd-container", "tcl-expect", "user-setup", "xfsprogs", "kernelstub"]
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "apt-get" "purge" "-y" "btrfs-progs" "casper" "cifs-utils" "distinst" "distinst-v2" "dmraid" "expect" "f2fs-tools" "fatresize" "gettext" "gparted" "gparted-common" "kpartx" "kpartx-boot" "libdistinst" "libdmraid1.0.0.rc16" "libgranite6" "libinih1" "libnss-mymachines" "localechooser-data" "os-prober" "pop-installer" "pop-installer-casper" "pop-shop-casper" "squashfs-tools" "systemd-container" "tcl-expect" "user-setup" "xfsprogs" "kernelstub"
[INFO distinst:crates/chroot/src/command.rs:99] Reading package lists...
[INFO distinst:crates/chroot/src/command.rs:99] Building dependency tree...
[INFO distinst:crates/chroot/src/command.rs:99] Reading state information...
[INFO distinst:crates/chroot/src/command.rs:99] The following package was automatically installed and is no longer required:
[INFO distinst:crates/chroot/src/command.rs:99]   efibootmgr
[INFO distinst:crates/chroot/src/command.rs:99] Use 'apt autoremove' to remove it.
[INFO distinst:crates/chroot/src/command.rs:99] The following packages will be REMOVED
[INFO distinst:crates/chroot/src/command.rs:99]   btrfs-progs* casper* cifs-utils* distinst* distinst-v2* dmraid* expect*
[INFO distinst:crates/chroot/src/command.rs:99]   f2fs-tools* fatresize* gettext* gparted* gparted-common* kernelstub* kpartx*
[INFO distinst:crates/chroot/src/command.rs:99]   kpartx-boot* libdistinst* libdmraid1.0.0.rc16* libgranite6* libinih1*
[INFO distinst:crates/chroot/src/command.rs:99]   libnss-mymachines* localechooser-data* os-prober* pop-installer*
[INFO distinst:crates/chroot/src/command.rs:99]   pop-installer-casper* pop-shop-casper* squashfs-tools* systemd-container*
[INFO distinst:crates/chroot/src/command.rs:99]   tcl-expect* user-setup* xfsprogs*
[INFO distinst:crates/chroot/src/command.rs:99] 0 to upgrade, 0 to newly install, 30 to remove and 0 not to upgrade.
[INFO distinst:crates/chroot/src/command.rs:99] After this operation, 35.8 MB disk space will be freed.
[INFO distinst:crates/chroot/src/command.rs:99] (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 ... 198132 files and directories currently installed.)
[INFO distinst:crates/chroot/src/command.rs:99] Removing pop-installer (0.0.1~1642024258~21.10~1a980fb) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing distinst-v2 (0.1.0~1641855581~21.10~f1693f6) ...
[INFO distinst:crates/chroot/src/command.rs:99] Running in chroot, ignoring command 'stop'
[INFO distinst:crates/chroot/src/command.rs:99] Running in chroot, ignoring command 'daemon-reload'
[INFO distinst:crates/chroot/src/command.rs:99] Running in chroot, ignoring command 'daemon-reload'
[INFO distinst:crates/chroot/src/command.rs:99] Removing distinst (0.3.2~1642534021~21.10~ebc554a) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing libdistinst (0.3.2~1642534021~21.10~ebc554a) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing btrfs-progs (5.10.1-2build1) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing pop-installer-casper (0.0.1~1642024258~21.10~1a980fb) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing pop-shop-casper (3.4.2pop0~1638820932~21.10~fcc9028) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing casper (1.465) ...
[INFO distinst:crates/chroot/src/command.rs:99] Running in chroot, ignoring command 'daemon-reload'
[INFO distinst:crates/chroot/src/command.rs:99] Running in chroot, ignoring command 'daemon-reload'
[INFO distinst:crates/chroot/src/command.rs:99] Running in chroot, ignoring command 'daemon-reload'
[INFO distinst:crates/chroot/src/command.rs:99] Removing cifs-utils (2:6.11-3.1) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing dmraid (1.0.0.rc16-8ubuntu5) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing expect (5.45.4-2build1) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing f2fs-tools (1.14.0-2build1) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing fatresize (1.1.0-1) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing gettext (0.21-4ubuntu3) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing gparted (1.2.0-1ubuntu2) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing gparted-common (1.2.0-1ubuntu2) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing kernelstub (3.1.4~1631911584~21.10~de5b292) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing kpartx-boot (0.8.5-2ubuntu2) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing kpartx (0.8.5-2ubuntu2) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing libdmraid1.0.0.rc16 (1.0.0.rc16-8ubuntu5) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing libgranite6:amd64 (6.0.0~1639159241~21.10~9265df7) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing xfsprogs (5.10.0-4ubuntu2) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing libinih1:amd64 (53-1ubuntu1) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing libnss-mymachines:amd64 (248.3-1ubuntu8.2pop0~1642619863~21.10~47b8972) ...
[INFO distinst:crates/chroot/src/command.rs:99] Checking NSS setup...
[INFO distinst:crates/chroot/src/command.rs:99] Removing localechooser-data (2.89ubuntu3) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing os-prober (1.79ubuntu1) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing squashfs-tools (1:4.4-2ubuntu2) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing systemd-container (248.3-1ubuntu8.2pop0~1642619863~21.10~47b8972) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing tcl-expect:amd64 (5.45.4-2build1) ...
[INFO distinst:crates/chroot/src/command.rs:99] Removing user-setup (1.88ubuntu1) ...
[INFO distinst:crates/chroot/src/command.rs:99] Processing triggers for initramfs-tools (0.140ubuntu6) ...
[INFO distinst:crates/chroot/src/command.rs:99] Processing triggers for hicolor-icon-theme (0.17-2) ...
[INFO distinst:crates/chroot/src/command.rs:99] Processing triggers for gnome-menus (3.36.0-1ubuntu1) ...
[INFO distinst:crates/chroot/src/command.rs:99] Processing triggers for libc-bin (2.34-0ubuntu3) ...
[INFO distinst:crates/chroot/src/command.rs:99] Processing triggers for man-db (2.9.4-2) ...
[INFO distinst:crates/chroot/src/command.rs:99] Processing triggers for dbus (1.12.20-2ubuntu2) ...
[INFO distinst:crates/chroot/src/command.rs:99] Processing triggers for install-info (6.7.0.dfsg.2-6) ...
[INFO distinst:crates/chroot/src/command.rs:99] Processing triggers for desktop-file-utils (0.26-1ubuntu2) ...
[INFO distinst:crates/chroot/src/command.rs:99] (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 ... 197197 files and directories currently installed.)
[INFO distinst:crates/chroot/src/command.rs:99] Purging configuration files for kpartx-boot (0.8.5-2ubuntu2) ...
[INFO distinst:crates/chroot/src/command.rs:99] Purging configuration files for cifs-utils (2:6.11-3.1) ...
[INFO distinst:crates/chroot/src/command.rs:99] Purging configuration files for distinst-v2 (0.1.0~1641855581~21.10~f1693f6) ...
[INFO distinst:crates/chroot/src/command.rs:99] Running in chroot, ignoring command 'daemon-reload'
[INFO distinst:crates/chroot/src/command.rs:99] Running in chroot, ignoring command 'daemon-reload'
[INFO distinst:crates/chroot/src/command.rs:99] Running in chroot, ignoring command 'daemon-reload'
[INFO distinst:crates/chroot/src/command.rs:99] Purging configuration files for casper (1.465) ...
[INFO distinst:crates/chroot/src/command.rs:99] Running in chroot, ignoring command 'daemon-reload'
[INFO distinst:crates/chroot/src/command.rs:99] Running in chroot, ignoring command 'daemon-reload'
[INFO distinst:crates/chroot/src/command.rs:99] Running in chroot, ignoring command 'daemon-reload'
[INFO distinst:crates/chroot/src/command.rs:99] Running in chroot, ignoring command 'daemon-reload'
[INFO distinst:crates/chroot/src/command.rs:99] Purging configuration files for libnss-mymachines:amd64 (248.3-1ubuntu8.2pop0~1642619863~21.10~47b8972) ...
[INFO distinst:crates/chroot/src/command.rs:99] Purging configuration files for dmraid (1.0.0.rc16-8ubuntu5) ...
[INFO distinst:crates/chroot/src/command.rs:99] Purging configuration files for systemd-container (248.3-1ubuntu8.2pop0~1642619863~21.10~47b8972) ...
[INFO distinst:crates/chroot/src/command.rs:99] Purging configuration files for user-setup (1.88ubuntu1) ...
[INFO distinst:crates/chroot/src/command.rs:99] Purging configuration files for kernelstub (3.1.4~1631911584~21.10~de5b292) ...
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "apt-get" "autoremove" "-y" "--purge"
[INFO distinst:crates/chroot/src/command.rs:99] Reading package lists...
[INFO distinst:crates/chroot/src/command.rs:99] Building dependency tree...
[INFO distinst:crates/chroot/src/command.rs:99] Reading state information...
[INFO distinst:crates/chroot/src/command.rs:99] The following packages will be REMOVED
[INFO distinst:crates/chroot/src/command.rs:99]   efibootmgr*
[INFO distinst:crates/chroot/src/command.rs:99] 0 to upgrade, 0 to newly install, 1 to remove and 0 not to upgrade.
[INFO distinst:crates/chroot/src/command.rs:99] After this operation, 93.2 kB disk space will be freed.
[INFO distinst:crates/chroot/src/command.rs:99] (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 ... 197193 files and directories currently installed.)
[INFO distinst:crates/chroot/src/command.rs:99] Removing efibootmgr (17-1ubuntu2) ...
[INFO distinst:crates/chroot/src/command.rs:99] Processing triggers for man-db (2.9.4-2) ...
[INFO distinst:src/installer/steps/configure/chroot_conf.rs:372] creating recovery partition
[WARN distinst:src/installer/steps/configure/chroot_conf.rs:381] recovery at /tmp/distinst.8Bmviy0gy7Mj/recovery was not found, therefore no recovery partition will be created
[INFO distinst:src/installer/steps/configure/chroot_conf.rs:73] configuring bootloader
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "kernelstub" "--esp-path" "/boot/efi" "--add-options" "quiet loglevel=0 systemd.show_status=false splash" "--loader" "--manage-only" "--force-update" "--verbose"
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "update-grub"
[WARN distinst:crates/chroot/src/command.rs:99] Sourcing file `/etc/default/grub'
[WARN distinst:crates/chroot/src/command.rs:99] Sourcing file `/etc/default/grub.d/init-select.cfg'
[WARN distinst:crates/chroot/src/command.rs:99] Generating grub configuration file ...
[WARN distinst:crates/chroot/src/command.rs:99] Found linux image: /boot/vmlinuz-5.15.15-76051515-generic
[WARN distinst:crates/chroot/src/command.rs:99] Found initrd image: /boot/initrd.img-5.15.15-76051515-generic
[INFO distinst:src/installer/steps/configure/chroot_conf.rs:291] configuring keyboard layout
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "localectl" "set-x11-keymap" "us" "" ""
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "/usr/bin/env" "-i" "SYSTEMCTL_SKIP_REDIRECT=_" "openvt" "--" "sh" "/etc/init.d/console-setup.sh" "reload"
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "ln" "-s" "/etc/console-setup/cached_UTF-8_del.kmap.gz" "/etc/console-setup/cached.kmap.gz"
[INFO distinst:src/installer/steps/configure/chroot_conf.rs:279] re-enabling update-initramfs
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "sh" "-c" "rm /usr/sbin/update-initramfs"
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "sh" "-c" "mv /usr/sbin/update-initramfs.bak /usr/sbin/update-initramfs"
[INFO distinst:src/installer/state.rs:33] starting configuring bootloader step
[INFO distinst:src/installer/steps/bootloader.rs:35] /dev/sda: installing bootloader for Bios
[INFO distinst:crates/chroot/src/command.rs:109] running "chroot" "/tmp/distinst.8Bmviy0gy7Mj" "grub-install" "--recheck" "--target=i386-pc" "/dev/sda"
[WARN distinst:crates/chroot/src/command.rs:99] Installing for i386-pc platform.
[WARN distinst:crates/chroot/src/command.rs:99] Installation finished. No error reported.
[ERROR distinst:src/installer/mod.rs:300] errored while installing system: chroot unmount: Device or resource busy (os error 16)
[INFO distinst:ffi/src/installer.rs:188] Install error: chroot unmount: Device or resource busy (os error 16)