Bug#872999: qemu image built by vmdebootstrap is unbootable due to bad root=/dev/mapper/loop0p1 kernel parameter

Raphael Hertzog hertzog at debian.org
Thu Sep 7 11:53:08 BST 2017 

On Thu, 07 Sep 2017, Raphael Hertzog wrote:
> What informs udev about the new filesystem?

Somehow, it's the kernel apparently.

> Or is this a bug in the kernel really?

At least "udevadm monitor" shows that the kernel is sending
less uevents when I run the command in the chroot. I attach
two logs of "udevadm monitor -k -u -p", once for the run in
the host, and one for the run in schroot.

And I also attach a diff of edited logs where I dropped the
timestamps. We can clearly see the lack of a "KERNEL[] change
/devices/virtual/block/dm-4 (block)" with its associated
UDEV rule adding the by-uuid links.

So this is with 4.12.6-1 (unstable).

Cheers,
-- 
Raphaël Hertzog ◈ Debian Developer

Support Debian LTS: https://www.freexian.com/services/debian-lts.html
Learn to master Debian: https://debian-handbook.info/get/
-------------- next part --------------
KERNEL[1303173.467860] change   /devices/virtual/block/loop0 (block)
ACTION=change
DEVNAME=/dev/loop0
DEVPATH=/devices/virtual/block/loop0
DEVTYPE=disk
MAJOR=7
MINOR=0
SEQNUM=4256
SUBSYSTEM=block

KERNEL[1303173.492386] add      /devices/virtual/bdi/254:4 (bdi)
ACTION=add
DEVPATH=/devices/virtual/bdi/254:4
SEQNUM=4257
SUBSYSTEM=bdi

KERNEL[1303173.492809] add      /devices/virtual/block/dm-4 (block)
ACTION=add
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
MAJOR=254
MINOR=4
SEQNUM=4258
SUBSYSTEM=block

UDEV  [1303173.493320] add      /devices/virtual/bdi/254:4 (bdi)
ACTION=add
DEVPATH=/devices/virtual/bdi/254:4
SEQNUM=4257
SUBSYSTEM=bdi
USEC_INITIALIZED=1303173493269

UDEV  [1303173.495279] change   /devices/virtual/block/loop0 (block)
.ID_FS_TYPE_NEW=
ACTION=change
DEVNAME=/dev/loop0
DEVPATH=/devices/virtual/block/loop0
DEVTYPE=disk
ID_FS_TYPE=
ID_PART_TABLE_TYPE=dos
ID_PART_TABLE_UUID=91b643c6
MAJOR=7
MINOR=0
SEQNUM=4256
SUBSYSTEM=block
TAGS=:systemd:
USEC_INITIALIZED=13952290172

KERNEL[1303173.495444] change   /devices/virtual/block/dm-4 (block)
ACTION=change
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
DM_COOKIE=4194304
MAJOR=254
MINOR=4
SEQNUM=4259
SUBSYSTEM=block

UDEV  [1303173.510693] add      /devices/virtual/block/dm-4 (block)
ACTION=add
DEVLINKS=/dev/disk/by-id/raid-loop0p1
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
DM_NAME=loop0p1
DM_PART=1
DM_STATE=ACTIVE
DM_TABLE_STATE=LIVE
DM_TYPE=raid
DM_UDEV_DISABLE_DISK_RULES_FLAG=1
DM_UDEV_DISABLE_OTHER_RULES_FLAG=1
DM_UDEV_DISABLE_SUBSYSTEM_RULES_FLAG=1
DM_UUID=part1-loop0
MAJOR=254
MINOR=4
SEQNUM=4258
SUBSYSTEM=block
SYSTEMD_READY=0
TAGS=:systemd:
USEC_INITIALIZED=1303173510442

UDEV  [1303173.527433] change   /devices/virtual/block/dm-4 (block)
.ID_FS_TYPE_NEW=
ACTION=change
DEVLINKS=/dev/disk/by-partuuid/91b643c6-01 /dev/mapper/loop0p1 /dev/disk/by-id/raid-loop0p1 /dev/disk/by-id/dm-uuid-part1-loop0 /dev/disk/by-id/dm-name-loop0p1
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
DM_ACTIVATION=1
DM_COOKIE=4194304
DM_NAME=loop0p1
DM_PART=1
DM_STATE=ACTIVE
DM_SUSPENDED=0
DM_TABLE_STATE=LIVE
DM_TYPE=raid
DM_UDEV_PRIMARY_SOURCE_FLAG=1
DM_UDEV_RULES=1
DM_UUID=part1-loop0
ID_FS_TYPE=
ID_PART_ENTRY_DISK=7:0
ID_PART_ENTRY_FLAGS=0x80
ID_PART_ENTRY_NUMBER=1
ID_PART_ENTRY_OFFSET=2048
ID_PART_ENTRY_SCHEME=dos
ID_PART_ENTRY_SIZE=19527680
ID_PART_ENTRY_TYPE=0x83
ID_PART_ENTRY_UUID=91b643c6-01
MAJOR=254
MINOR=4
SEQNUM=4259
SUBSYSTEM=block
TAGS=:systemd:
USEC_INITIALIZED=1303173510442

--- debootstrap ---

KERNEL[1303301.063685] change   /devices/virtual/block/loop0 (block)
ACTION=change
DEVNAME=/dev/loop0
DEVPATH=/devices/virtual/block/loop0
DEVTYPE=disk
MAJOR=7
MINOR=0
SEQNUM=4260
SUBSYSTEM=block

UDEV  [1303301.069592] change   /devices/virtual/block/loop0 (block)
.ID_FS_TYPE_NEW=
ACTION=change
DEVNAME=/dev/loop0
DEVPATH=/devices/virtual/block/loop0
DEVTYPE=disk
ID_FS_TYPE=
ID_PART_TABLE_TYPE=dos
ID_PART_TABLE_UUID=91b643c6
MAJOR=7
MINOR=0
SEQNUM=4260
SUBSYSTEM=block
TAGS=:systemd:
USEC_INITIALIZED=13952290172

KERNEL[1303303.480902] remove   /devices/virtual/block/dm-4 (block)
ACTION=remove
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
DM_COOKIE=6291456
MAJOR=254
MINOR=4
SEQNUM=4261
SUBSYSTEM=block

UDEV  [1303303.497202] remove   /devices/virtual/block/dm-4 (block)
.ID_FS_TYPE_NEW=
ACTION=remove
DEVLINKS=/dev/mapper/loop0p1 /dev/disk/by-partuuid/91b643c6-01 /dev/disk/by-id/raid-loop0p1 /dev/disk/by-id/dm-uuid-part1-loop0 /dev/disk/by-id/dm-name-loop0p1
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
DM_ACTIVATION=1
DM_COOKIE=6291456
DM_NAME=loop0p1
DM_PART=1
DM_STATE=ACTIVE
DM_SUSPENDED=0
DM_TABLE_STATE=LIVE
DM_TYPE=raid
DM_UDEV_DISABLE_LIBRARY_FALLBACK_FLAG=1
DM_UDEV_PRIMARY_SOURCE_FLAG=1
DM_UDEV_RULES=1
DM_UUID=part1-loop0
ID_FS_TYPE=
ID_PART_ENTRY_DISK=7:0
ID_PART_ENTRY_FLAGS=0x80
ID_PART_ENTRY_NUMBER=1
ID_PART_ENTRY_OFFSET=2048
ID_PART_ENTRY_SCHEME=dos
ID_PART_ENTRY_SIZE=19527680
ID_PART_ENTRY_TYPE=0x83
ID_PART_ENTRY_UUID=91b643c6-01
MAJOR=254
MINOR=4
SEQNUM=4261
SUBSYSTEM=block
TAGS=:systemd:
USEC_INITIALIZED=1303173510442

KERNEL[1303303.504839] remove   /devices/virtual/bdi/254:4 (bdi)
ACTION=remove
DEVPATH=/devices/virtual/bdi/254:4
SEQNUM=4262
SUBSYSTEM=bdi

KERNEL[1303303.505154] remove   /devices/virtual/block/dm-4 (block)
ACTION=remove
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
MAJOR=254
MINOR=4
SEQNUM=4263
SUBSYSTEM=block

UDEV  [1303303.508068] remove   /devices/virtual/bdi/254:4 (bdi)
ACTION=remove
DEVPATH=/devices/virtual/bdi/254:4
SEQNUM=4262
SUBSYSTEM=bdi
USEC_INITIALIZED=1303303505069

UDEV  [1303303.509527] remove   /devices/virtual/block/dm-4 (block)
.ID_FS_TYPE_NEW=
ACTION=remove
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
ID_FS_TYPE=
MAJOR=254
MINOR=4
SEQNUM=4263
SUBSYSTEM=block
USEC_INITIALIZED=1303303506161

KERNEL[1303303.540234] change   /devices/virtual/block/loop0 (block)
ACTION=change
DEVNAME=/dev/loop0
DEVPATH=/devices/virtual/block/loop0
DEVTYPE=disk
MAJOR=7
MINOR=0
SEQNUM=4264
SUBSYSTEM=block

UDEV  [1303303.541605] change   /devices/virtual/block/loop0 (block)
.ID_FS_TYPE_NEW=
ACTION=change
DEVNAME=/dev/loop0
DEVPATH=/devices/virtual/block/loop0
DEVTYPE=disk
ID_FS_TYPE=
MAJOR=7
MINOR=0
SEQNUM=4264
SUBSYSTEM=block
SYSTEMD_READY=0
TAGS=:systemd:
USEC_INITIALIZED=13952290172
-------------- next part --------------
KERNEL[1302954.323520] change   /devices/virtual/block/loop0 (block)
ACTION=change
DEVNAME=/dev/loop0
DEVPATH=/devices/virtual/block/loop0
DEVTYPE=disk
MAJOR=7
MINOR=0
SEQNUM=4246
SUBSYSTEM=block

KERNEL[1302954.343939] add      /devices/virtual/bdi/254:4 (bdi)
ACTION=add
DEVPATH=/devices/virtual/bdi/254:4
SEQNUM=4247
SUBSYSTEM=bdi

KERNEL[1302954.344186] add      /devices/virtual/block/dm-4 (block)
ACTION=add
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
MAJOR=254
MINOR=4
SEQNUM=4248
SUBSYSTEM=block

UDEV  [1302954.344952] add      /devices/virtual/bdi/254:4 (bdi)
ACTION=add
DEVPATH=/devices/virtual/bdi/254:4
SEQNUM=4247
SUBSYSTEM=bdi
USEC_INITIALIZED=1302954344761

KERNEL[1302954.347235] change   /devices/virtual/block/dm-4 (block)
ACTION=change
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
DM_COOKIE=4235776
MAJOR=254
MINOR=4
SEQNUM=4249
SUBSYSTEM=block

UDEV  [1302954.349050] change   /devices/virtual/block/loop0 (block)
.ID_FS_TYPE_NEW=
ACTION=change
DEVNAME=/dev/loop0
DEVPATH=/devices/virtual/block/loop0
DEVTYPE=disk
ID_FS_TYPE=
ID_PART_TABLE_TYPE=dos
ID_PART_TABLE_UUID=0bd88d64
MAJOR=7
MINOR=0
SEQNUM=4246
SUBSYSTEM=block
TAGS=:systemd:
USEC_INITIALIZED=13952290172

UDEV  [1302954.371529] add      /devices/virtual/block/dm-4 (block)
ACTION=add
DEVLINKS=/dev/disk/by-id/raid-loop0p1
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
DM_NAME=loop0p1
DM_PART=1
DM_STATE=ACTIVE
DM_TABLE_STATE=LIVE
DM_TYPE=raid
DM_UDEV_DISABLE_DISK_RULES_FLAG=1
DM_UDEV_DISABLE_OTHER_RULES_FLAG=1
DM_UDEV_DISABLE_SUBSYSTEM_RULES_FLAG=1
DM_UUID=part1-loop0
MAJOR=254
MINOR=4
SEQNUM=4248
SUBSYSTEM=block
SYSTEMD_READY=0
TAGS=:systemd:
USEC_INITIALIZED=1302954371373

UDEV  [1302954.387688] change   /devices/virtual/block/dm-4 (block)
.ID_FS_TYPE_NEW=
ACTION=change
DEVLINKS=/dev/disk/by-id/raid-loop0p1 /dev/disk/by-id/dm-uuid-part1-loop0 /dev/disk/by-id/dm-name-loop0p1 /dev/mapper/loop0p1 /dev/disk/by-partuuid/0bd88d64-01
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
DM_ACTIVATION=1
DM_COOKIE=4235776
DM_NAME=loop0p1
DM_PART=1
DM_STATE=ACTIVE
DM_SUSPENDED=0
DM_TABLE_STATE=LIVE
DM_TYPE=raid
DM_UDEV_PRIMARY_SOURCE_FLAG=1
DM_UDEV_RULES=1
DM_UUID=part1-loop0
ID_FS_TYPE=
ID_PART_ENTRY_DISK=7:0
ID_PART_ENTRY_FLAGS=0x80
ID_PART_ENTRY_NUMBER=1
ID_PART_ENTRY_OFFSET=2048
ID_PART_ENTRY_SCHEME=dos
ID_PART_ENTRY_SIZE=19527680
ID_PART_ENTRY_TYPE=0x83
ID_PART_ENTRY_UUID=0bd88d64-01
MAJOR=254
MINOR=4
SEQNUM=4249
SUBSYSTEM=block
TAGS=:systemd:
USEC_INITIALIZED=1302954371373

KERNEL[1302954.743984] change   /devices/virtual/block/dm-4 (block)
ACTION=change
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
MAJOR=254
MINOR=4
SEQNUM=4250
SUBSYSTEM=block

UDEV  [1302954.789691] change   /devices/virtual/block/dm-4 (block)
.ID_FS_TYPE_NEW=ext4
ACTION=change
DEVLINKS=/dev/mapper/loop0p1 /dev/disk/by-uuid/5fa02639-e3a9-4efa-b36b-45137163844b /dev/disk/by-id/dm-uuid-part1-loop0 /dev/disk/by-id/raid-loop0p1 /dev/disk/by-id/dm-name-loop0p1 /dev/disk/by-partuuid/0bd88d64-01
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
DM_NAME=loop0p1
DM_PART=1
DM_STATE=ACTIVE
DM_SUSPENDED=0
DM_TABLE_STATE=LIVE
DM_TYPE=raid
DM_UDEV_PRIMARY_SOURCE_FLAG=1
DM_UDEV_RULES=1
DM_UUID=part1-loop0
ID_FS_TYPE=ext4
ID_FS_USAGE=filesystem
ID_FS_UUID=5fa02639-e3a9-4efa-b36b-45137163844b
ID_FS_UUID_ENC=5fa02639-e3a9-4efa-b36b-45137163844b
ID_FS_VERSION=1.0
ID_PART_ENTRY_DISK=7:0
ID_PART_ENTRY_FLAGS=0x80
ID_PART_ENTRY_NUMBER=1
ID_PART_ENTRY_OFFSET=2048
ID_PART_ENTRY_SCHEME=dos
ID_PART_ENTRY_SIZE=19527680
ID_PART_ENTRY_TYPE=0x83
ID_PART_ENTRY_UUID=0bd88d64-01
MAJOR=254
MINOR=4
SEQNUM=4250
SUBSYSTEM=block
TAGS=:systemd:
USEC_INITIALIZED=1302954371373

--- debootstrap ---

KERNEL[1303081.676617] change   /devices/virtual/block/loop0 (block)
ACTION=change
DEVNAME=/dev/loop0
DEVPATH=/devices/virtual/block/loop0
DEVTYPE=disk
MAJOR=7
MINOR=0
SEQNUM=4251
SUBSYSTEM=block

UDEV  [1303081.683144] change   /devices/virtual/block/loop0 (block)
.ID_FS_TYPE_NEW=
ACTION=change
DEVNAME=/dev/loop0
DEVPATH=/devices/virtual/block/loop0
DEVTYPE=disk
ID_FS_TYPE=
ID_PART_TABLE_TYPE=dos
ID_PART_TABLE_UUID=0bd88d64
MAJOR=7
MINOR=0
SEQNUM=4251
SUBSYSTEM=block
TAGS=:systemd:
USEC_INITIALIZED=13952290172

KERNEL[1303084.095964] remove   /devices/virtual/block/dm-4 (block)
ACTION=remove
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
DM_COOKIE=6291961
MAJOR=254
MINOR=4
SEQNUM=4252
SUBSYSTEM=block

UDEV  [1303084.108909] remove   /devices/virtual/block/dm-4 (block)
.ID_FS_TYPE_NEW=ext4
ACTION=remove
DEVLINKS=/dev/mapper/loop0p1 /dev/disk/by-id/dm-uuid-part1-loop0 /dev/disk/by-partuuid/0bd88d64-01 /dev/disk/by-id/dm-name-loop0p1 /dev/disk/by-id/raid-loop0p1 /dev/disk/by-uuid/5fa02639-e3a9-4efa-b36b-45137163844b
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
DM_COOKIE=6291961
DM_NAME=loop0p1
DM_PART=1
DM_STATE=ACTIVE
DM_SUSPENDED=0
DM_TABLE_STATE=LIVE
DM_TYPE=raid
DM_UDEV_DISABLE_LIBRARY_FALLBACK_FLAG=1
DM_UDEV_PRIMARY_SOURCE_FLAG=1
DM_UDEV_RULES=1
DM_UUID=part1-loop0
ID_FS_TYPE=ext4
ID_FS_USAGE=filesystem
ID_FS_UUID=5fa02639-e3a9-4efa-b36b-45137163844b
ID_FS_UUID_ENC=5fa02639-e3a9-4efa-b36b-45137163844b
ID_FS_VERSION=1.0
ID_PART_ENTRY_DISK=7:0
ID_PART_ENTRY_FLAGS=0x80
ID_PART_ENTRY_NUMBER=1
ID_PART_ENTRY_OFFSET=2048
ID_PART_ENTRY_SCHEME=dos
ID_PART_ENTRY_SIZE=19527680
ID_PART_ENTRY_TYPE=0x83
ID_PART_ENTRY_UUID=0bd88d64-01
MAJOR=254
MINOR=4
SEQNUM=4252
SUBSYSTEM=block
TAGS=:systemd:
USEC_INITIALIZED=1302954371373

KERNEL[1303084.140184] remove   /devices/virtual/bdi/254:4 (bdi)
ACTION=remove
DEVPATH=/devices/virtual/bdi/254:4
SEQNUM=4253
SUBSYSTEM=bdi

KERNEL[1303084.140261] remove   /devices/virtual/block/dm-4 (block)
ACTION=remove
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
MAJOR=254
MINOR=4
SEQNUM=4254
SUBSYSTEM=block

UDEV  [1303084.141047] remove   /devices/virtual/bdi/254:4 (bdi)
ACTION=remove
DEVPATH=/devices/virtual/bdi/254:4
SEQNUM=4253
SUBSYSTEM=bdi
USEC_INITIALIZED=1303084140284

UDEV  [1303084.141143] remove   /devices/virtual/block/dm-4 (block)
.ID_FS_TYPE_NEW=
ACTION=remove
DEVNAME=/dev/dm-4
DEVPATH=/devices/virtual/block/dm-4
DEVTYPE=disk
ID_FS_TYPE=
MAJOR=254
MINOR=4
SEQNUM=4254
SUBSYSTEM=block
USEC_INITIALIZED=1303084140576

KERNEL[1303084.160228] change   /devices/virtual/block/loop0 (block)
ACTION=change
DEVNAME=/dev/loop0
DEVPATH=/devices/virtual/block/loop0
DEVTYPE=disk
MAJOR=7
MINOR=0
SEQNUM=4255
SUBSYSTEM=block

UDEV  [1303084.161630] change   /devices/virtual/block/loop0 (block)
.ID_FS_TYPE_NEW=
ACTION=change
DEVNAME=/dev/loop0
DEVPATH=/devices/virtual/block/loop0
DEVTYPE=disk
ID_FS_TYPE=
MAJOR=7
MINOR=0
SEQNUM=4255
SUBSYSTEM=block
SYSTEMD_READY=0
TAGS=:systemd:
USEC_INITIALIZED=13952290172
-------------- next part --------------
A non-text attachment was scrubbed...
Name: udevadm.diff
Type: text/x-diff
Size: 4467 bytes
Desc: not available
URL: <http://alioth-lists.debian.net/pipermail/pkg-systemd-maintainers/attachments/20170907/defabd38/attachment-0002.diff>

More information about the Pkg-systemd-maintainers mailing list