Activity log for bug #1969093

Date Who What changed Old value New value Message
2022-04-14 09:52:48 yuehui gan bug added bug
2022-04-14 09:55:40 yuehui gan summary Nodepool DIB fail to build ubuntu-focal vm image Nodepool DIB fail to build ubuntu-focal vm image. device-mapper: remove ioctl on loop0p1 failed: Device or resource busy
2022-04-14 10:01:31 yuehui gan description 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:55.943 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.119 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: 1.7 GiB (1854722048 bytes) trimmed exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.123 | INFO diskimage_builder.block_device.utils [-] Calling [sudo umount /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.675 | INFO diskimage_builder.block_device.utils [-] Calling [sudo kpartx -d /dev/loop0] 2022-04-13 08:42:56.715 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: device-mapper: remove ioctl on loop0p2 failed: Device or resource busy exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.799 | Traceback (most recent call last): 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:56.799 | sys.exit(main()) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:56.799 | return bdc.main() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:56.799 | self.args.func() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:56.799 | self.bd.cmd_umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:56.799 | node.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partition.py", line 88, in umount 2022-04-13 08:42:56.799 | self.partitioning.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partitioning.py", line 228, in umount 2022-04-13 08:42:56.799 | self.state['blockdev'][self.base]['device']]) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:56.799 | raise e 2022-04-13 08:42:56.799 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed 2022-04-13 08:42:56.864 | + diskimage_builder/lib/disk-image-create:main:1 : trap_cleanup 2022-04-13 08:42:56.868 | + diskimage_builder/lib/img-functions:trap_cleanup:36 : exitval=1 2022-04-13 08:42:56.872 | + diskimage_builder/lib/img-functions:trap_cleanup:37 : cleanup 2022-04-13 08:42:56.875 | + diskimage_builder/lib/img-functions:cleanup:42 : unmount_image 2022-04-13 08:42:56.878 | + diskimage_builder/lib/img-functions:unmount_image:22 : sync 2022-04-13 08:42:56.927 | + diskimage_builder/lib/img-functions:unmount_image:26 : unmount_dir /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.934 | + diskimage_builder/lib/common-functions:unmount_dir:414 : local dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.940 | + diskimage_builder/lib/common-functions:unmount_dir:415 : local real_dir 2022-04-13 08:42:56.946 | + diskimage_builder/lib/common-functions:unmount_dir:416 : local mnts 2022-04-13 08:42:56.952 | + diskimage_builder/lib/common-functions:unmount_dir:417 : local split_mounts 2022-04-13 08:42:56.958 | + diskimage_builder/lib/common-functions:unmount_dir:418 : local found_mountpoint 2022-04-13 08:42:56.964 | + diskimage_builder/lib/common-functions:unmount_dir:420 : '[' '!' -d /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt ']' 2022-04-13 08:42:56.971 | ++ diskimage_builder/lib/common-functions:unmount_dir:427 : readlink -e /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.979 | + diskimage_builder/lib/common-functions:unmount_dir:427 : real_dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.984 | + diskimage_builder/lib/common-functions:unmount_dir:430 : IFS='|' 2022-04-13 08:42:56.990 | + diskimage_builder/lib/common-functions:unmount_dir:430 : read -ra split_mounts 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : sort -r 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : grep '^/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/' 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : awk '{print $2}' 2022-04-13 08:42:57.004 | + diskimage_builder/lib/common-functions:unmount_dir:435 : mnts= 2022-04-13 08:42:57.010 | + diskimage_builder/lib/img-functions:unmount_image:27 : '[' -n '' ']' 2022-04-13 08:42:57.015 | + diskimage_builder/lib/img-functions:unmount_image:30 : '[' -n '' ']' 2022-04-13 08:42:57.020 | + diskimage_builder/lib/img-functions:cleanup:43 : /usr/bin/python3 /usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py umount 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Creating BlockDevice object __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:229 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Params [{'config': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/block-device/config.yaml', 'image-dir': '/var/cache/nodepool/dib_tmp/dib_image.F6YdxoMq', 'root-fs-type': 'ext4', 'root-label': None, 'mount-base': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt', 'build-dir': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI', 'image-size': '4253184KiB', 'root-fs-opts': '-i 4096 -J size=64 '}] __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:232 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:57.497 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:57.533 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: fstrim: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: the discard operation is not supported exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:57.538 | Traceback (most recent call last): 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:57.538 | sys.exit(main()) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:57.538 | return bdc.main() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:57.538 | self.args.func() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:57.538 | self.bd.cmd_umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:57.538 | node.umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level3/mount.py", line 111, in umount 2022-04-13 08:42:57.538 | self.state['mount'][self.mount_point]['path']]) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:57.538 | raise e 2022-04-13 08:42:57.538 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed Exit code: 1 find this https://bugs.launchpad.net/ubuntu/+source/vm-builder/+bug/335472. don't know if it's the same problem This error occurred during the cleanup phase. traces: 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:55.943 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.119 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: 1.7 GiB (1854722048 bytes) trimmed exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.123 | INFO diskimage_builder.block_device.utils [-] Calling [sudo umount /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.675 | INFO diskimage_builder.block_device.utils [-] Calling [sudo kpartx -d /dev/loop0] 2022-04-13 08:42:56.715 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: device-mapper: remove ioctl on loop0p2 failed: Device or resource busy exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.799 | Traceback (most recent call last): 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:56.799 | sys.exit(main()) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:56.799 | return bdc.main() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:56.799 | self.args.func() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:56.799 | self.bd.cmd_umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:56.799 | node.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partition.py", line 88, in umount 2022-04-13 08:42:56.799 | self.partitioning.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partitioning.py", line 228, in umount 2022-04-13 08:42:56.799 | self.state['blockdev'][self.base]['device']]) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:56.799 | raise e 2022-04-13 08:42:56.799 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed 2022-04-13 08:42:56.864 | + diskimage_builder/lib/disk-image-create:main:1 : trap_cleanup 2022-04-13 08:42:56.868 | + diskimage_builder/lib/img-functions:trap_cleanup:36 : exitval=1 2022-04-13 08:42:56.872 | + diskimage_builder/lib/img-functions:trap_cleanup:37 : cleanup 2022-04-13 08:42:56.875 | + diskimage_builder/lib/img-functions:cleanup:42 : unmount_image 2022-04-13 08:42:56.878 | + diskimage_builder/lib/img-functions:unmount_image:22 : sync 2022-04-13 08:42:56.927 | + diskimage_builder/lib/img-functions:unmount_image:26 : unmount_dir /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.934 | + diskimage_builder/lib/common-functions:unmount_dir:414 : local dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.940 | + diskimage_builder/lib/common-functions:unmount_dir:415 : local real_dir 2022-04-13 08:42:56.946 | + diskimage_builder/lib/common-functions:unmount_dir:416 : local mnts 2022-04-13 08:42:56.952 | + diskimage_builder/lib/common-functions:unmount_dir:417 : local split_mounts 2022-04-13 08:42:56.958 | + diskimage_builder/lib/common-functions:unmount_dir:418 : local found_mountpoint 2022-04-13 08:42:56.964 | + diskimage_builder/lib/common-functions:unmount_dir:420 : '[' '!' -d /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt ']' 2022-04-13 08:42:56.971 | ++ diskimage_builder/lib/common-functions:unmount_dir:427 : readlink -e /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.979 | + diskimage_builder/lib/common-functions:unmount_dir:427 : real_dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.984 | + diskimage_builder/lib/common-functions:unmount_dir:430 : IFS='|' 2022-04-13 08:42:56.990 | + diskimage_builder/lib/common-functions:unmount_dir:430 : read -ra split_mounts 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : sort -r 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : grep '^/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/' 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : awk '{print $2}' 2022-04-13 08:42:57.004 | + diskimage_builder/lib/common-functions:unmount_dir:435 : mnts= 2022-04-13 08:42:57.010 | + diskimage_builder/lib/img-functions:unmount_image:27 : '[' -n '' ']' 2022-04-13 08:42:57.015 | + diskimage_builder/lib/img-functions:unmount_image:30 : '[' -n '' ']' 2022-04-13 08:42:57.020 | + diskimage_builder/lib/img-functions:cleanup:43 : /usr/bin/python3 /usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py umount 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Creating BlockDevice object __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:229 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Params [{'config': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/block-device/config.yaml', 'image-dir': '/var/cache/nodepool/dib_tmp/dib_image.F6YdxoMq', 'root-fs-type': 'ext4', 'root-label': None, 'mount-base': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt', 'build-dir': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI', 'image-size': '4253184KiB', 'root-fs-opts': '-i 4096 -J size=64 '}] __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:232 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:57.497 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:57.533 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: fstrim: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: the discard operation is not supported exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:57.538 | Traceback (most recent call last): 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:57.538 | sys.exit(main()) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:57.538 | return bdc.main() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:57.538 | self.args.func() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:57.538 | self.bd.cmd_umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:57.538 | node.umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level3/mount.py", line 111, in umount 2022-04-13 08:42:57.538 | self.state['mount'][self.mount_point]['path']]) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:57.538 | raise e 2022-04-13 08:42:57.538 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed Exit code: 1
2022-04-14 12:28:24 yuehui gan description find this https://bugs.launchpad.net/ubuntu/+source/vm-builder/+bug/335472. don't know if it's the same problem This error occurred during the cleanup phase. traces: 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:55.943 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.119 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: 1.7 GiB (1854722048 bytes) trimmed exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.123 | INFO diskimage_builder.block_device.utils [-] Calling [sudo umount /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.675 | INFO diskimage_builder.block_device.utils [-] Calling [sudo kpartx -d /dev/loop0] 2022-04-13 08:42:56.715 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: device-mapper: remove ioctl on loop0p2 failed: Device or resource busy exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.799 | Traceback (most recent call last): 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:56.799 | sys.exit(main()) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:56.799 | return bdc.main() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:56.799 | self.args.func() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:56.799 | self.bd.cmd_umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:56.799 | node.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partition.py", line 88, in umount 2022-04-13 08:42:56.799 | self.partitioning.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partitioning.py", line 228, in umount 2022-04-13 08:42:56.799 | self.state['blockdev'][self.base]['device']]) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:56.799 | raise e 2022-04-13 08:42:56.799 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed 2022-04-13 08:42:56.864 | + diskimage_builder/lib/disk-image-create:main:1 : trap_cleanup 2022-04-13 08:42:56.868 | + diskimage_builder/lib/img-functions:trap_cleanup:36 : exitval=1 2022-04-13 08:42:56.872 | + diskimage_builder/lib/img-functions:trap_cleanup:37 : cleanup 2022-04-13 08:42:56.875 | + diskimage_builder/lib/img-functions:cleanup:42 : unmount_image 2022-04-13 08:42:56.878 | + diskimage_builder/lib/img-functions:unmount_image:22 : sync 2022-04-13 08:42:56.927 | + diskimage_builder/lib/img-functions:unmount_image:26 : unmount_dir /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.934 | + diskimage_builder/lib/common-functions:unmount_dir:414 : local dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.940 | + diskimage_builder/lib/common-functions:unmount_dir:415 : local real_dir 2022-04-13 08:42:56.946 | + diskimage_builder/lib/common-functions:unmount_dir:416 : local mnts 2022-04-13 08:42:56.952 | + diskimage_builder/lib/common-functions:unmount_dir:417 : local split_mounts 2022-04-13 08:42:56.958 | + diskimage_builder/lib/common-functions:unmount_dir:418 : local found_mountpoint 2022-04-13 08:42:56.964 | + diskimage_builder/lib/common-functions:unmount_dir:420 : '[' '!' -d /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt ']' 2022-04-13 08:42:56.971 | ++ diskimage_builder/lib/common-functions:unmount_dir:427 : readlink -e /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.979 | + diskimage_builder/lib/common-functions:unmount_dir:427 : real_dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.984 | + diskimage_builder/lib/common-functions:unmount_dir:430 : IFS='|' 2022-04-13 08:42:56.990 | + diskimage_builder/lib/common-functions:unmount_dir:430 : read -ra split_mounts 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : sort -r 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : grep '^/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/' 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : awk '{print $2}' 2022-04-13 08:42:57.004 | + diskimage_builder/lib/common-functions:unmount_dir:435 : mnts= 2022-04-13 08:42:57.010 | + diskimage_builder/lib/img-functions:unmount_image:27 : '[' -n '' ']' 2022-04-13 08:42:57.015 | + diskimage_builder/lib/img-functions:unmount_image:30 : '[' -n '' ']' 2022-04-13 08:42:57.020 | + diskimage_builder/lib/img-functions:cleanup:43 : /usr/bin/python3 /usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py umount 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Creating BlockDevice object __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:229 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Params [{'config': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/block-device/config.yaml', 'image-dir': '/var/cache/nodepool/dib_tmp/dib_image.F6YdxoMq', 'root-fs-type': 'ext4', 'root-label': None, 'mount-base': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt', 'build-dir': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI', 'image-size': '4253184KiB', 'root-fs-opts': '-i 4096 -J size=64 '}] __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:232 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:57.497 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:57.533 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: fstrim: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: the discard operation is not supported exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:57.538 | Traceback (most recent call last): 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:57.538 | sys.exit(main()) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:57.538 | return bdc.main() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:57.538 | self.args.func() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:57.538 | self.bd.cmd_umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:57.538 | node.umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level3/mount.py", line 111, in umount 2022-04-13 08:42:57.538 | self.state['mount'][self.mount_point]['path']]) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:57.538 | raise e 2022-04-13 08:42:57.538 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed Exit code: 1 find this https://bugs.launchpad.net/ubuntu/+source/vm-builder/+bug/335472. don't know if it's the same problem I install nodepool. use DIB build ubuntu-focal image in logical server.I had extend disk by run lvextend. traces: 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:55.943 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.119 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: 1.7 GiB (1854722048 bytes) trimmed exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.123 | INFO diskimage_builder.block_device.utils [-] Calling [sudo umount /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.675 | INFO diskimage_builder.block_device.utils [-] Calling [sudo kpartx -d /dev/loop0] 2022-04-13 08:42:56.715 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: device-mapper: remove ioctl on loop0p2 failed: Device or resource busy exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.799 | Traceback (most recent call last): 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:56.799 | sys.exit(main()) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:56.799 | return bdc.main() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:56.799 | self.args.func() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:56.799 | self.bd.cmd_umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:56.799 | node.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partition.py", line 88, in umount 2022-04-13 08:42:56.799 | self.partitioning.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partitioning.py", line 228, in umount 2022-04-13 08:42:56.799 | self.state['blockdev'][self.base]['device']]) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:56.799 | raise e 2022-04-13 08:42:56.799 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed 2022-04-13 08:42:56.864 | + diskimage_builder/lib/disk-image-create:main:1 : trap_cleanup 2022-04-13 08:42:56.868 | + diskimage_builder/lib/img-functions:trap_cleanup:36 : exitval=1 2022-04-13 08:42:56.872 | + diskimage_builder/lib/img-functions:trap_cleanup:37 : cleanup 2022-04-13 08:42:56.875 | + diskimage_builder/lib/img-functions:cleanup:42 : unmount_image 2022-04-13 08:42:56.878 | + diskimage_builder/lib/img-functions:unmount_image:22 : sync 2022-04-13 08:42:56.927 | + diskimage_builder/lib/img-functions:unmount_image:26 : unmount_dir /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.934 | + diskimage_builder/lib/common-functions:unmount_dir:414 : local dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.940 | + diskimage_builder/lib/common-functions:unmount_dir:415 : local real_dir 2022-04-13 08:42:56.946 | + diskimage_builder/lib/common-functions:unmount_dir:416 : local mnts 2022-04-13 08:42:56.952 | + diskimage_builder/lib/common-functions:unmount_dir:417 : local split_mounts 2022-04-13 08:42:56.958 | + diskimage_builder/lib/common-functions:unmount_dir:418 : local found_mountpoint 2022-04-13 08:42:56.964 | + diskimage_builder/lib/common-functions:unmount_dir:420 : '[' '!' -d /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt ']' 2022-04-13 08:42:56.971 | ++ diskimage_builder/lib/common-functions:unmount_dir:427 : readlink -e /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.979 | + diskimage_builder/lib/common-functions:unmount_dir:427 : real_dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.984 | + diskimage_builder/lib/common-functions:unmount_dir:430 : IFS='|' 2022-04-13 08:42:56.990 | + diskimage_builder/lib/common-functions:unmount_dir:430 : read -ra split_mounts 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : sort -r 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : grep '^/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/' 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : awk '{print $2}' 2022-04-13 08:42:57.004 | + diskimage_builder/lib/common-functions:unmount_dir:435 : mnts= 2022-04-13 08:42:57.010 | + diskimage_builder/lib/img-functions:unmount_image:27 : '[' -n '' ']' 2022-04-13 08:42:57.015 | + diskimage_builder/lib/img-functions:unmount_image:30 : '[' -n '' ']' 2022-04-13 08:42:57.020 | + diskimage_builder/lib/img-functions:cleanup:43 : /usr/bin/python3 /usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py umount 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Creating BlockDevice object __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:229 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Params [{'config': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/block-device/config.yaml', 'image-dir': '/var/cache/nodepool/dib_tmp/dib_image.F6YdxoMq', 'root-fs-type': 'ext4', 'root-label': None, 'mount-base': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt', 'build-dir': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI', 'image-size': '4253184KiB', 'root-fs-opts': '-i 4096 -J size=64 '}] __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:232 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:57.497 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:57.533 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: fstrim: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: the discard operation is not supported exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:57.538 | Traceback (most recent call last): 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:57.538 | sys.exit(main()) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:57.538 | return bdc.main() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:57.538 | self.args.func() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:57.538 | self.bd.cmd_umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:57.538 | node.umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level3/mount.py", line 111, in umount 2022-04-13 08:42:57.538 | self.state['mount'][self.mount_point]['path']]) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:57.538 | raise e 2022-04-13 08:42:57.538 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed Exit code: 1
2022-04-14 12:34:58 yuehui gan description find this https://bugs.launchpad.net/ubuntu/+source/vm-builder/+bug/335472. don't know if it's the same problem I install nodepool. use DIB build ubuntu-focal image in logical server.I had extend disk by run lvextend. traces: 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:55.943 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.119 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: 1.7 GiB (1854722048 bytes) trimmed exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.123 | INFO diskimage_builder.block_device.utils [-] Calling [sudo umount /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.675 | INFO diskimage_builder.block_device.utils [-] Calling [sudo kpartx -d /dev/loop0] 2022-04-13 08:42:56.715 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: device-mapper: remove ioctl on loop0p2 failed: Device or resource busy exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.799 | Traceback (most recent call last): 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:56.799 | sys.exit(main()) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:56.799 | return bdc.main() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:56.799 | self.args.func() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:56.799 | self.bd.cmd_umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:56.799 | node.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partition.py", line 88, in umount 2022-04-13 08:42:56.799 | self.partitioning.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partitioning.py", line 228, in umount 2022-04-13 08:42:56.799 | self.state['blockdev'][self.base]['device']]) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:56.799 | raise e 2022-04-13 08:42:56.799 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed 2022-04-13 08:42:56.864 | + diskimage_builder/lib/disk-image-create:main:1 : trap_cleanup 2022-04-13 08:42:56.868 | + diskimage_builder/lib/img-functions:trap_cleanup:36 : exitval=1 2022-04-13 08:42:56.872 | + diskimage_builder/lib/img-functions:trap_cleanup:37 : cleanup 2022-04-13 08:42:56.875 | + diskimage_builder/lib/img-functions:cleanup:42 : unmount_image 2022-04-13 08:42:56.878 | + diskimage_builder/lib/img-functions:unmount_image:22 : sync 2022-04-13 08:42:56.927 | + diskimage_builder/lib/img-functions:unmount_image:26 : unmount_dir /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.934 | + diskimage_builder/lib/common-functions:unmount_dir:414 : local dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.940 | + diskimage_builder/lib/common-functions:unmount_dir:415 : local real_dir 2022-04-13 08:42:56.946 | + diskimage_builder/lib/common-functions:unmount_dir:416 : local mnts 2022-04-13 08:42:56.952 | + diskimage_builder/lib/common-functions:unmount_dir:417 : local split_mounts 2022-04-13 08:42:56.958 | + diskimage_builder/lib/common-functions:unmount_dir:418 : local found_mountpoint 2022-04-13 08:42:56.964 | + diskimage_builder/lib/common-functions:unmount_dir:420 : '[' '!' -d /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt ']' 2022-04-13 08:42:56.971 | ++ diskimage_builder/lib/common-functions:unmount_dir:427 : readlink -e /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.979 | + diskimage_builder/lib/common-functions:unmount_dir:427 : real_dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.984 | + diskimage_builder/lib/common-functions:unmount_dir:430 : IFS='|' 2022-04-13 08:42:56.990 | + diskimage_builder/lib/common-functions:unmount_dir:430 : read -ra split_mounts 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : sort -r 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : grep '^/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/' 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : awk '{print $2}' 2022-04-13 08:42:57.004 | + diskimage_builder/lib/common-functions:unmount_dir:435 : mnts= 2022-04-13 08:42:57.010 | + diskimage_builder/lib/img-functions:unmount_image:27 : '[' -n '' ']' 2022-04-13 08:42:57.015 | + diskimage_builder/lib/img-functions:unmount_image:30 : '[' -n '' ']' 2022-04-13 08:42:57.020 | + diskimage_builder/lib/img-functions:cleanup:43 : /usr/bin/python3 /usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py umount 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Creating BlockDevice object __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:229 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Params [{'config': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/block-device/config.yaml', 'image-dir': '/var/cache/nodepool/dib_tmp/dib_image.F6YdxoMq', 'root-fs-type': 'ext4', 'root-label': None, 'mount-base': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt', 'build-dir': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI', 'image-size': '4253184KiB', 'root-fs-opts': '-i 4096 -J size=64 '}] __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:232 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:57.497 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:57.533 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: fstrim: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: the discard operation is not supported exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:57.538 | Traceback (most recent call last): 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:57.538 | sys.exit(main()) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:57.538 | return bdc.main() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:57.538 | self.args.func() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:57.538 | self.bd.cmd_umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:57.538 | node.umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level3/mount.py", line 111, in umount 2022-04-13 08:42:57.538 | self.state['mount'][self.mount_point]['path']]) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:57.538 | raise e 2022-04-13 08:42:57.538 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed Exit code: 1 environment: centos7.9, logical server. I install nodepool.nodepool use DIB build ubuntu focal image in logical server.I had extend disk by run lvextend. find this https://bugs.launchpad.net/ubuntu/+source/vm-builder/+bug/335472. don't know if it's the same problem traces: 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:55.943 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.119 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: 1.7 GiB (1854722048 bytes) trimmed exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.123 | INFO diskimage_builder.block_device.utils [-] Calling [sudo umount /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.675 | INFO diskimage_builder.block_device.utils [-] Calling [sudo kpartx -d /dev/loop0] 2022-04-13 08:42:56.715 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: device-mapper: remove ioctl on loop0p2 failed: Device or resource busy exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.799 | Traceback (most recent call last): 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:56.799 | sys.exit(main()) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:56.799 | return bdc.main() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:56.799 | self.args.func() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:56.799 | self.bd.cmd_umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:56.799 | node.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partition.py", line 88, in umount 2022-04-13 08:42:56.799 | self.partitioning.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partitioning.py", line 228, in umount 2022-04-13 08:42:56.799 | self.state['blockdev'][self.base]['device']]) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:56.799 | raise e 2022-04-13 08:42:56.799 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed 2022-04-13 08:42:56.864 | + diskimage_builder/lib/disk-image-create:main:1 : trap_cleanup 2022-04-13 08:42:56.868 | + diskimage_builder/lib/img-functions:trap_cleanup:36 : exitval=1 2022-04-13 08:42:56.872 | + diskimage_builder/lib/img-functions:trap_cleanup:37 : cleanup 2022-04-13 08:42:56.875 | + diskimage_builder/lib/img-functions:cleanup:42 : unmount_image 2022-04-13 08:42:56.878 | + diskimage_builder/lib/img-functions:unmount_image:22 : sync 2022-04-13 08:42:56.927 | + diskimage_builder/lib/img-functions:unmount_image:26 : unmount_dir /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.934 | + diskimage_builder/lib/common-functions:unmount_dir:414 : local dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.940 | + diskimage_builder/lib/common-functions:unmount_dir:415 : local real_dir 2022-04-13 08:42:56.946 | + diskimage_builder/lib/common-functions:unmount_dir:416 : local mnts 2022-04-13 08:42:56.952 | + diskimage_builder/lib/common-functions:unmount_dir:417 : local split_mounts 2022-04-13 08:42:56.958 | + diskimage_builder/lib/common-functions:unmount_dir:418 : local found_mountpoint 2022-04-13 08:42:56.964 | + diskimage_builder/lib/common-functions:unmount_dir:420 : '[' '!' -d /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt ']' 2022-04-13 08:42:56.971 | ++ diskimage_builder/lib/common-functions:unmount_dir:427 : readlink -e /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.979 | + diskimage_builder/lib/common-functions:unmount_dir:427 : real_dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.984 | + diskimage_builder/lib/common-functions:unmount_dir:430 : IFS='|' 2022-04-13 08:42:56.990 | + diskimage_builder/lib/common-functions:unmount_dir:430 : read -ra split_mounts 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : sort -r 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : grep '^/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/' 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : awk '{print $2}' 2022-04-13 08:42:57.004 | + diskimage_builder/lib/common-functions:unmount_dir:435 : mnts= 2022-04-13 08:42:57.010 | + diskimage_builder/lib/img-functions:unmount_image:27 : '[' -n '' ']' 2022-04-13 08:42:57.015 | + diskimage_builder/lib/img-functions:unmount_image:30 : '[' -n '' ']' 2022-04-13 08:42:57.020 | + diskimage_builder/lib/img-functions:cleanup:43 : /usr/bin/python3 /usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py umount 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Creating BlockDevice object __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:229 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Params [{'config': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/block-device/config.yaml', 'image-dir': '/var/cache/nodepool/dib_tmp/dib_image.F6YdxoMq', 'root-fs-type': 'ext4', 'root-label': None, 'mount-base': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt', 'build-dir': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI', 'image-size': '4253184KiB', 'root-fs-opts': '-i 4096 -J size=64 '}] __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:232 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:57.497 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:57.533 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: fstrim: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: the discard operation is not supported exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:57.538 | Traceback (most recent call last): 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:57.538 | sys.exit(main()) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:57.538 | return bdc.main() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:57.538 | self.args.func() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:57.538 | self.bd.cmd_umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:57.538 | node.umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level3/mount.py", line 111, in umount 2022-04-13 08:42:57.538 | self.state['mount'][self.mount_point]['path']]) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:57.538 | raise e 2022-04-13 08:42:57.538 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed Exit code: 1
2022-04-24 08:26:54 yuehui gan description environment: centos7.9, logical server. I install nodepool.nodepool use DIB build ubuntu focal image in logical server.I had extend disk by run lvextend. find this https://bugs.launchpad.net/ubuntu/+source/vm-builder/+bug/335472. don't know if it's the same problem traces: 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:55.943 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.119 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: 1.7 GiB (1854722048 bytes) trimmed exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.123 | INFO diskimage_builder.block_device.utils [-] Calling [sudo umount /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.675 | INFO diskimage_builder.block_device.utils [-] Calling [sudo kpartx -d /dev/loop0] 2022-04-13 08:42:56.715 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: device-mapper: remove ioctl on loop0p2 failed: Device or resource busy exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.799 | Traceback (most recent call last): 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:56.799 | sys.exit(main()) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:56.799 | return bdc.main() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:56.799 | self.args.func() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:56.799 | self.bd.cmd_umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:56.799 | node.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partition.py", line 88, in umount 2022-04-13 08:42:56.799 | self.partitioning.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partitioning.py", line 228, in umount 2022-04-13 08:42:56.799 | self.state['blockdev'][self.base]['device']]) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:56.799 | raise e 2022-04-13 08:42:56.799 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed 2022-04-13 08:42:56.864 | + diskimage_builder/lib/disk-image-create:main:1 : trap_cleanup 2022-04-13 08:42:56.868 | + diskimage_builder/lib/img-functions:trap_cleanup:36 : exitval=1 2022-04-13 08:42:56.872 | + diskimage_builder/lib/img-functions:trap_cleanup:37 : cleanup 2022-04-13 08:42:56.875 | + diskimage_builder/lib/img-functions:cleanup:42 : unmount_image 2022-04-13 08:42:56.878 | + diskimage_builder/lib/img-functions:unmount_image:22 : sync 2022-04-13 08:42:56.927 | + diskimage_builder/lib/img-functions:unmount_image:26 : unmount_dir /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.934 | + diskimage_builder/lib/common-functions:unmount_dir:414 : local dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.940 | + diskimage_builder/lib/common-functions:unmount_dir:415 : local real_dir 2022-04-13 08:42:56.946 | + diskimage_builder/lib/common-functions:unmount_dir:416 : local mnts 2022-04-13 08:42:56.952 | + diskimage_builder/lib/common-functions:unmount_dir:417 : local split_mounts 2022-04-13 08:42:56.958 | + diskimage_builder/lib/common-functions:unmount_dir:418 : local found_mountpoint 2022-04-13 08:42:56.964 | + diskimage_builder/lib/common-functions:unmount_dir:420 : '[' '!' -d /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt ']' 2022-04-13 08:42:56.971 | ++ diskimage_builder/lib/common-functions:unmount_dir:427 : readlink -e /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.979 | + diskimage_builder/lib/common-functions:unmount_dir:427 : real_dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.984 | + diskimage_builder/lib/common-functions:unmount_dir:430 : IFS='|' 2022-04-13 08:42:56.990 | + diskimage_builder/lib/common-functions:unmount_dir:430 : read -ra split_mounts 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : sort -r 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : grep '^/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/' 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : awk '{print $2}' 2022-04-13 08:42:57.004 | + diskimage_builder/lib/common-functions:unmount_dir:435 : mnts= 2022-04-13 08:42:57.010 | + diskimage_builder/lib/img-functions:unmount_image:27 : '[' -n '' ']' 2022-04-13 08:42:57.015 | + diskimage_builder/lib/img-functions:unmount_image:30 : '[' -n '' ']' 2022-04-13 08:42:57.020 | + diskimage_builder/lib/img-functions:cleanup:43 : /usr/bin/python3 /usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py umount 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Creating BlockDevice object __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:229 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Params [{'config': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/block-device/config.yaml', 'image-dir': '/var/cache/nodepool/dib_tmp/dib_image.F6YdxoMq', 'root-fs-type': 'ext4', 'root-label': None, 'mount-base': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt', 'build-dir': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI', 'image-size': '4253184KiB', 'root-fs-opts': '-i 4096 -J size=64 '}] __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:232 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:57.497 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:57.533 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: fstrim: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: the discard operation is not supported exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:57.538 | Traceback (most recent call last): 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:57.538 | sys.exit(main()) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:57.538 | return bdc.main() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:57.538 | self.args.func() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:57.538 | self.bd.cmd_umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:57.538 | node.umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level3/mount.py", line 111, in umount 2022-04-13 08:42:57.538 | self.state['mount'][self.mount_point]['path']]) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:57.538 | raise e 2022-04-13 08:42:57.538 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed Exit code: 1 I have sloved this. I'm use centos gnome. this error due to centos gnome will auto mount /dev/loop0p2 on /root/media, and during the cleanup phase of the diskimagebuild would not unmount /dev/loop0p2. so I turn off auto mount of the centos gnome. https://access.redhat.com/solutions/20107 . it build success finally. environment: centos7.9 with gnome, logical server. I install nodepool.nodepool use DIB build ubuntu focal image in logical server.I had extend disk by run lvextend. traces: 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:55.630 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:55.943 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.119 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: 1.7 GiB (1854722048 bytes) trimmed exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.123 | INFO diskimage_builder.block_device.utils [-] Calling [sudo umount /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:56.675 | INFO diskimage_builder.block_device.utils [-] Calling [sudo kpartx -d /dev/loop0] 2022-04-13 08:42:56.715 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: device-mapper: remove ioctl on loop0p2 failed: Device or resource busy exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:56.799 | Traceback (most recent call last): 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:56.799 | sys.exit(main()) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:56.799 | return bdc.main() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:56.799 | self.args.func() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:56.799 | self.bd.cmd_umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:56.799 | node.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partition.py", line 88, in umount 2022-04-13 08:42:56.799 | self.partitioning.umount() 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level1/partitioning.py", line 228, in umount 2022-04-13 08:42:56.799 | self.state['blockdev'][self.base]['device']]) 2022-04-13 08:42:56.799 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:56.799 | raise e 2022-04-13 08:42:56.799 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed 2022-04-13 08:42:56.864 | + diskimage_builder/lib/disk-image-create:main:1 : trap_cleanup 2022-04-13 08:42:56.868 | + diskimage_builder/lib/img-functions:trap_cleanup:36 : exitval=1 2022-04-13 08:42:56.872 | + diskimage_builder/lib/img-functions:trap_cleanup:37 : cleanup 2022-04-13 08:42:56.875 | + diskimage_builder/lib/img-functions:cleanup:42 : unmount_image 2022-04-13 08:42:56.878 | + diskimage_builder/lib/img-functions:unmount_image:22 : sync 2022-04-13 08:42:56.927 | + diskimage_builder/lib/img-functions:unmount_image:26 : unmount_dir /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.934 | + diskimage_builder/lib/common-functions:unmount_dir:414 : local dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.940 | + diskimage_builder/lib/common-functions:unmount_dir:415 : local real_dir 2022-04-13 08:42:56.946 | + diskimage_builder/lib/common-functions:unmount_dir:416 : local mnts 2022-04-13 08:42:56.952 | + diskimage_builder/lib/common-functions:unmount_dir:417 : local split_mounts 2022-04-13 08:42:56.958 | + diskimage_builder/lib/common-functions:unmount_dir:418 : local found_mountpoint 2022-04-13 08:42:56.964 | + diskimage_builder/lib/common-functions:unmount_dir:420 : '[' '!' -d /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt ']' 2022-04-13 08:42:56.971 | ++ diskimage_builder/lib/common-functions:unmount_dir:427 : readlink -e /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.979 | + diskimage_builder/lib/common-functions:unmount_dir:427 : real_dir=/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt 2022-04-13 08:42:56.984 | + diskimage_builder/lib/common-functions:unmount_dir:430 : IFS='|' 2022-04-13 08:42:56.990 | + diskimage_builder/lib/common-functions:unmount_dir:430 : read -ra split_mounts 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : sort -r 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : grep '^/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/' 2022-04-13 08:42:56.997 | ++ diskimage_builder/lib/common-functions:unmount_dir:435 : awk '{print $2}' 2022-04-13 08:42:57.004 | + diskimage_builder/lib/common-functions:unmount_dir:435 : mnts= 2022-04-13 08:42:57.010 | + diskimage_builder/lib/img-functions:unmount_image:27 : '[' -n '' ']' 2022-04-13 08:42:57.015 | + diskimage_builder/lib/img-functions:unmount_image:30 : '[' -n '' ']' 2022-04-13 08:42:57.020 | + diskimage_builder/lib/img-functions:cleanup:43 : /usr/bin/python3 /usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py umount 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Creating BlockDevice object __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:229 2022-04-13 08:42:57.408 | DEBUG diskimage_builder.block_device.blockdevice [-] Params [{'config': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/block-device/config.yaml', 'image-dir': '/var/cache/nodepool/dib_tmp/dib_image.F6YdxoMq', 'root-fs-type': 'ext4', 'root-label': None, 'mount-base': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt', 'build-dir': '/var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI', 'image-size': '4253184KiB', 'root-fs-opts': '-i 4096 -J size=64 '}] __init__ /usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py:232 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.level3.mount [-] Called for [mount_mkfs_root] 2022-04-13 08:42:57.409 | INFO diskimage_builder.block_device.utils [-] Calling [sudo sync] 2022-04-13 08:42:57.497 | INFO diskimage_builder.block_device.utils [-] Calling [sudo fstrim --verbose /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/] 2022-04-13 08:42:57.533 | DEBUG diskimage_builder.block_device.utils [-] exec_sudo: fstrim: /var/cache/nodepool/dib_tmp/dib_build.3DMuQbbI/mnt/: the discard operation is not supported exec_sudo /usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py:135 2022-04-13 08:42:57.538 | Traceback (most recent call last): 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/lib/dib-block-device.py", line 7, in <module> 2022-04-13 08:42:57.538 | sys.exit(main()) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 120, in main 2022-04-13 08:42:57.538 | return bdc.main() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 115, in main 2022-04-13 08:42:57.538 | self.args.func() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/cmd.py", line 39, in cmd_umount 2022-04-13 08:42:57.538 | self.bd.cmd_umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/blockdevice.py", line 442, in cmd_umount 2022-04-13 08:42:57.538 | node.umount() 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/level3/mount.py", line 111, in umount 2022-04-13 08:42:57.538 | self.state['mount'][self.mount_point]['path']]) 2022-04-13 08:42:57.538 | File "/usr/lib/python3.6/site-packages/diskimage_builder/block_device/utils.py", line 143, in exec_sudo 2022-04-13 08:42:57.538 | raise e 2022-04-13 08:42:57.538 | diskimage_builder.block_device.exception.BlockDeviceSetupException: exec_sudo failed Exit code: 1