and here is the journalctl extract (one hair shorter) of the system started again with the debug kernel parameter and the script called manually :
00:00:09 kernel: usb 2-3: new SuperSpeed Gen 1 USB device number 4 using xhci_hcd
00:00:09 systemd-udevd[216]: 2-3: Device is queued (SEQNUM=2255, ACTION="">00:00:09 systemd-udevd[216]: Validate module index
00:00:09 systemd-udevd[216]: Check if link configuration needs reloading.
00:00:09 systemd-udevd[216]: 2-3: Device ready for processing (SEQNUM=2255, ACTION="">00:00:09 systemd-udevd[216]: Successfully forked off 'n/a' as PID 985.
00:00:09 systemd-udevd[216]: 2-3: Worker [985] is forked for processing SEQNUM=2255.
00:00:09 systemd-udevd[216]: 2-3:1.0: Device is queued (SEQNUM=2256, ACTION="">00:00:09 systemd-udevd[216]: 2-3:1.0: SEQNUM=2256 blocked by SEQNUM=2255
00:00:09 systemd-udevd[985]: 2-3: Processing device (SEQNUM=2255, ACTION="">00:00:09 systemd-udevd[985]: 2-3: Failed to get watch handle, ignoring: No such file or directory
00:00:09 systemd-udevd[985]: 2-3: /usr/lib/udev/rules.d/50-udev-default.rules:13 Importing properties from results of builtin command 'usb_id'
00:00:09 systemd-udevd[216]: scsi_tmf_6: Device is queued (SEQNUM=2257, ACTION="">00:00:09 systemd-udevd[216]: scsi_tmf_6: Device ready for processing (SEQNUM=2257, ACTION="">00:00:09 systemd-udevd[216]: Successfully forked off 'n/a' as PID 988.
00:00:09 systemd-udevd[216]: scsi_tmf_6: Worker [988] is forked for processing SEQNUM=2257.
00:00:09 systemd-udevd[988]: scsi_tmf_6: Processing device (SEQNUM=2257, ACTION="">00:00:09 systemd-udevd[988]: scsi_tmf_6: Device processed (SEQNUM=2257, ACTION="">00:00:09 systemd-udevd[988]: scsi_tmf_6: sd-device-monitor: Passed 156 byte to netlink monitor
00:00:09 systemd-udevd[216]: host6: Device is queued (SEQNUM=2258, ACTION="">00:00:09 systemd-udevd[216]: host6: SEQNUM=2258 blocked by SEQNUM=2255
00:00:09 systemd-udevd[216]: host6: Device is queued (SEQNUM=2259, ACTION="">00:00:09 systemd-udevd[216]: host6: SEQNUM=2259 blocked by SEQNUM=2255
00:00:09 systemd-udevd[216]: 2-3:1.0: Device is queued (SEQNUM=2260, ACTION="">00:00:09 systemd-udevd[216]: 2-3:1.0: SEQNUM=2260 blocked by SEQNUM=2255
00:00:09 systemd-udevd[216]: 2-3: Device is queued (SEQNUM=2261, ACTION="">00:00:09 systemd-udevd[216]: 2-3: SEQNUM=2261 blocked by SEQNUM=2255
00:00:09 systemd-udevd[985]: 2-3: /usr/lib/udev/rules.d/50-udev-default.rules:13 Importing properties from results of builtin command 'hwdb --subsystem=usb'
00:00:09 systemd-udevd[985]: 2-3: hwdb modalias key: "usb:v46F4p0001:QEMU USB HARDDRIVE"
00:00:09 systemd-udevd[985]: 2-3: /usr/lib/udev/rules.d/50-udev-default.rules:50 MODE 0664
00:00:09 systemd-udevd[985]: 2-3: /usr/lib/udev/rules.d/60-drm.rules:3 Importing properties from results of builtin command 'path_id'
00:00:09 systemd-udevd[985]: 2-3: /usr/lib/udev/rules.d/69-libmtp.rules:39 Running PROGRAM '/usr/lib/udev/mtp-probe /sys/devices/pci0000:00/0000:00:03.0/usb2/2-3 2 4'
00:00:09 systemd-udevd[985]: 2-3: Starting '/usr/lib/udev/mtp-probe /sys/devices/pci0000:00/0000:00:03.0/usb2/2-3 2 4'
00:00:09 systemd-udevd[985]: Successfully forked off '(spawn)' as PID 990.
00:00:09 kernel: usb 2-3: New USB device found, idVendor=46f4, idProduct=0001, bcdDevice= 0.00
00:00:09 kernel: usb 2-3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
00:00:09 kernel: usb 2-3: Product: QEMU USB HARDDRIVE
00:00:09 kernel: usb 2-3: Manufacturer: QEMU
00:00:09 kernel: usb 2-3: SerialNumber: 1-0000:00:03.0-3
00:00:09 kernel: usb-storage 2-3:1.0: USB Mass Storage device detected
00:00:09 kernel: scsi host6: usb-storage 2-3:1.0
00:00:09 mtp-probe[990]: checking bus 2, device 4: "/sys/devices/pci0000:00/0000:00:03.0/usb2/2-3"
00:00:09 mtp-probe[990]: bus: 2, device: 4 was not an MTP device
00:00:09 systemd-udevd[985]: 2-3: '/usr/lib/udev/mtp-probe /sys/devices/pci0000:00/0000:00:03.0/usb2/2-3 2 4'(out) '0'
00:00:09 systemd-udevd[985]: 2-3: Process '/usr/lib/udev/mtp-probe /sys/devices/pci0000:00/0000:00:03.0/usb2/2-3 2 4' succeeded.
00:00:09 systemd-udevd[985]: 2-3: Handling device node '/dev/bus/usb/002/004', devnum=c189:131
00:00:09 systemd-udevd[985]: 2-3: Setting permissions /dev/bus/usb/002/004, uid=0, gid=0, mode=0664
00:00:09 systemd-udevd[985]: 2-3: Creating symlink '/dev/char/189:131' to '../bus/usb/002/004'
00:00:09 systemd-udevd[985]: 2-3: sd-device: Created db file '/run/udev/data/c189:131' for '/devices/pci0000:00/0000:00:03.0/usb2/2-3'
00:00:09 systemd-udevd[985]: 2-3: Handling device node '/dev/bus/usb/002/004', devnum=c189:131
00:00:09 systemd-udevd[985]: 2-3: Preserve permissions of /dev/bus/usb/002/004, uid=0, gid=0, mode=0664
00:00:09 systemd-udevd[985]: 2-3: Preserve already existing symlink '/dev/char/189:131' to '../bus/usb/002/004'
00:00:09 systemd-udevd[985]: 2-3: Failed to get watch handle, ignoring: No such file or directory
00:00:09 systemd-udevd[985]: 2-3: Device processed (SEQNUM=2255, ACTION="">00:00:09 systemd-udevd[985]: 2-3: sd-device-monitor: Passed 718 byte to netlink monitor
00:00:09 systemd-udevd[216]: 2-3:1.0: Device ready for processing (SEQNUM=2256, ACTION="">00:00:09 systemd-udevd[216]: 2-3:1.0: sd-device-monitor: Passed 288 byte to netlink monitor
00:00:09 systemd-udevd[988]: 2-3:1.0: Processing device (SEQNUM=2256, ACTION="">00:00:09 systemd-udevd[988]: 2-3:1.0: /usr/lib/udev/rules.d/50-udev-default.rules:14 Importing properties from results of builtin command 'hwdb --subsystem=usb'
00:00:09 systemd-udevd[216]: host6: SEQNUM=2258 blocked by SEQNUM=2256
00:00:09 systemd-udevd[216]: host6: SEQNUM=2259 blocked by SEQNUM=2256
00:00:09 systemd-udevd[216]: 2-3:1.0: SEQNUM=2260 blocked by SEQNUM=2256
00:00:09 systemd-udevd[216]: 2-3: SEQNUM=2261 blocked by SEQNUM=2256
00:00:09 systemd-udevd[988]: 2-3:1.0: hwdb modalias key: "usb:v46F4p0001d0000dc00dsc00dp00ic08isc06ip50in00"
00:00:09 systemd-udevd[988]: 2-3:1.0: /usr/lib/udev/rules.d/60-drm.rules:3 Importing properties from results of builtin command 'path_id'
00:00:09 systemd-udevd[988]: 2-3:1.0: /usr/lib/udev/rules.d/80-drivers.rules:5 RUN 'kmod load '$env{MODALIAS}''
00:00:09 systemd-udevd[988]: 2-3:1.0: sd-device: Created db file '/run/udev/data/+usb:2-3:1.0' for '/devices/pci0000:00/0000:00:03.0/usb2/2-3/2-3:1.0'
00:00:09 systemd-udevd[988]: 2-3:1.0: Running built-in command "kmod load 'usb:v46F4p0001d0000dc00dsc00dp00ic08isc06ip50in00'"
00:00:09 systemd-udevd[988]: Loading module: usb:v46F4p0001d0000dc00dsc00dp00ic08isc06ip50in00
00:00:09 systemd-udevd[988]: Module 'uas' is already loaded
00:00:09 systemd-udevd[988]: Module 'usb_storage' is already loaded
00:00:09 systemd-udevd[988]: 2-3:1.0: Device processed (SEQNUM=2256, ACTION="">00:00:09 systemd-udevd[988]: 2-3:1.0: sd-device-monitor: Passed 395 byte to netlink monitor
00:00:09 systemd-udevd[216]: host6: Device ready for processing (SEQNUM=2258, ACTION="">00:00:09 systemd-udevd[216]: host6: sd-device-monitor: Passed 187 byte to netlink monitor
00:00:09 systemd-udevd[216]: host6: SEQNUM=2259 blocked by SEQNUM=2258
00:00:09 systemd-udevd[216]: 2-3:1.0: SEQNUM=2260 blocked by SEQNUM=2258
00:00:09 systemd-udevd[216]: 2-3: SEQNUM=2261 blocked by SEQNUM=2258
00:00:09 systemd-udevd[988]: host6: Processing device (SEQNUM=2258, ACTION="">00:00:09 systemd-udevd[988]: host6: Device processed (SEQNUM=2258, ACTION="">00:00:09 systemd-udevd[988]: host6: sd-device-monitor: Passed 187 byte to netlink monitor
00:00:09 systemd-udevd[216]: host6: Device ready for processing (SEQNUM=2259, ACTION="">00:00:09 systemd-udevd[216]: host6: sd-device-monitor: Passed 190 byte to netlink monitor
00:00:09 systemd-udevd[216]: 2-3:1.0: SEQNUM=2260 blocked by SEQNUM=2259
00:00:09 systemd-udevd[216]: 2-3: SEQNUM=2261 blocked by SEQNUM=2259
00:00:09 systemd-udevd[988]: host6: Processing device (SEQNUM=2259, ACTION="">00:00:09 systemd-udevd[988]: host6: Device processed (SEQNUM=2259, ACTION="">00:00:09 systemd-udevd[988]: host6: sd-device-monitor: Passed 190 byte to netlink monitor
00:00:09 systemd-udevd[216]: 2-3:1.0: Device ready for processing (SEQNUM=2260, ACTION="">00:00:09 systemd-udevd[216]: 2-3:1.0: sd-device-monitor: Passed 308 byte to netlink monitor
00:00:09 systemd-udevd[216]: 2-3: SEQNUM=2261 blocked by SEQNUM=2260
00:00:09 systemd-udevd[988]: 2-3:1.0: Processing device (SEQNUM=2260, ACTION="">00:00:09 systemd-udevd[988]: 2-3:1.0: /usr/lib/udev/rules.d/50-udev-default.rules:14 Importing properties from results of builtin command 'hwdb --subsystem=usb'
00:00:09 systemd-udevd[988]: 2-3:1.0: hwdb modalias key: "usb:v46F4p0001d0000dc00dsc00dp00ic08isc06ip50in00"
00:00:09 systemd-udevd[988]: 2-3:1.0: /usr/lib/udev/rules.d/60-drm.rules:3 Importing properties from results of builtin command 'path_id'
00:00:09 systemd-udevd[988]: 2-3:1.0: sd-device: Created db file '/run/udev/data/+usb:2-3:1.0' for '/devices/pci0000:00/0000:00:03.0/usb2/2-3/2-3:1.0'
00:00:09 systemd-udevd[988]: 2-3:1.0: Device processed (SEQNUM=2260, ACTION="">00:00:09 systemd-udevd[988]: 2-3:1.0: sd-device-monitor: Passed 415 byte to netlink monitor
00:00:09 systemd-udevd[216]: 2-3: Device ready for processing (SEQNUM=2261, ACTION="">00:00:09 systemd-udevd[216]: 2-3: sd-device-monitor: Passed 284 byte to netlink monitor
00:00:09 systemd-udevd[988]: 2-3: Processing device (SEQNUM=2261, ACTION="">00:00:09 systemd-udevd[988]: 2-3: Failed to get watch handle, ignoring: No such file or directory
00:00:09 systemd-udevd[988]: 2-3: /usr/lib/udev/rules.d/50-udev-default.rules:13 Importing properties from results of builtin command 'usb_id'
00:00:09 systemd-udevd[988]: 2-3: /usr/lib/udev/rules.d/50-udev-default.rules:13 Importing properties from results of builtin command 'hwdb --subsystem=usb'
00:00:09 systemd-udevd[988]: 2-3: hwdb modalias key: "usb:v46F4p0001:QEMU USB HARDDRIVE"
00:00:09 systemd-udevd[988]: 2-3: /usr/lib/udev/rules.d/60-drm.rules:3 Importing properties from results of builtin command 'path_id'
00:00:09 systemd-udevd[988]: 2-3: /usr/lib/udev/rules.d/69-libmtp.rules:39 Running PROGRAM '/usr/lib/udev/mtp-probe /sys/devices/pci0000:00/0000:00:03.0/usb2/2-3 2 4'
00:00:09 systemd-udevd[988]: 2-3: Starting '/usr/lib/udev/mtp-probe /sys/devices/pci0000:00/0000:00:03.0/usb2/2-3 2 4'
00:00:09 systemd-udevd[988]: Successfully forked off '(spawn)' as PID 991.
00:00:09 mtp-probe[991]: checking bus 2, device 4: "/sys/devices/pci0000:00/0000:00:03.0/usb2/2-3"
00:00:09 mtp-probe[991]: bus: 2, device: 4 was not an MTP device
00:00:09 systemd-udevd[988]: 2-3: '/usr/lib/udev/mtp-probe /sys/devices/pci0000:00/0000:00:03.0/usb2/2-3 2 4'(out) '0'
00:00:09 systemd-udevd[988]: 2-3: Process '/usr/lib/udev/mtp-probe /sys/devices/pci0000:00/0000:00:03.0/usb2/2-3 2 4' succeeded.
00:00:09 systemd-udevd[988]: 2-3: Handling device node '/dev/bus/usb/002/004', devnum=c189:131
00:00:09 systemd-udevd[988]: 2-3: Preserve already existing symlink '/dev/char/189:131' to '../bus/usb/002/004'
00:00:09 systemd-udevd[988]: 2-3: sd-device: Created db file '/run/udev/data/c189:131' for '/devices/pci0000:00/0000:00:03.0/usb2/2-3'
00:00:09 systemd-udevd[988]: 2-3: Handling device node '/dev/bus/usb/002/004', devnum=c189:131
00:00:09 systemd-udevd[988]: 2-3: Preserve already existing symlink '/dev/char/189:131' to '../bus/usb/002/004'
00:00:09 systemd-udevd[988]: 2-3: Failed to get watch handle, ignoring: No such file or directory
00:00:09 systemd-udevd[988]: 2-3: Device processed (SEQNUM=2261, ACTION="">00:00:09 systemd-udevd[988]: 2-3: sd-device-monitor: Passed 730 byte to netlink monitor
00:00:10 systemd-udevd[216]: target6:0:0: Device is queued (SEQNUM=2262, ACTION="">00:00:10 systemd-udevd[216]: target6:0:0: Device ready for processing (SEQNUM=2262, ACTION="">00:00:10 systemd-udevd[216]: target6:0:0: sd-device-monitor: Passed 201 byte to netlink monitor
00:00:10 systemd-udevd[216]: 6:0:0:0: Device is queued (SEQNUM=2263, ACTION="">00:00:10 systemd-udevd[216]: 6:0:0:0: SEQNUM=2263 blocked by SEQNUM=2262
00:00:10 systemd-udevd[216]: 6:0:0:0: Device is queued (SEQNUM=2264, ACTION="">00:00:10 systemd-udevd[216]: 6:0:0:0: SEQNUM=2264 blocked by SEQNUM=2262
00:00:10 systemd-udevd[988]: target6:0:0: Processing device (SEQNUM=2262, ACTION="">00:00:10 systemd-udevd[988]: target6:0:0: Device processed (SEQNUM=2262, ACTION="">00:00:10 systemd-udevd[988]: target6:0:0: sd-device-monitor: Passed 201 byte to netlink monitor
00:00:10 systemd-udevd[216]: 6:0:0:0: Device is queued (SEQNUM=2265, ACTION="">00:00:10 systemd-udevd[216]: 6:0:0:0: SEQNUM=2265 blocked by SEQNUM=2262
00:00:10 systemd-udevd[216]: 6:0:0:0: Device ready for processing (SEQNUM=2263, ACTION="">00:00:10 systemd-udevd[216]: 6:0:0:0: sd-device-monitor: Passed 230 byte to netlink monitor
00:00:10 systemd-udevd[216]: 6:0:0:0: SEQNUM=2264 blocked by SEQNUM=2263
00:00:10 systemd-udevd[216]: 6:0:0:0: SEQNUM=2265 blocked by SEQNUM=2263
00:00:10 systemd-udevd[216]: 6:0:0:0: Device is queued (SEQNUM=2266, ACTION="">00:00:10 systemd-udevd[216]: 6:0:0:0: SEQNUM=2266 blocked by SEQNUM=2263
00:00:10 systemd-udevd[216]: 6:0:0:0: Device is queued (SEQNUM=2267, ACTION="">00:00:10 systemd-udevd[216]: 6:0:0:0: SEQNUM=2267 blocked by SEQNUM=2263
00:00:10 systemd-udevd[216]: 8:16: Device is queued (SEQNUM=2268, ACTION="">00:00:10 systemd-udevd[216]: 8:16: Device ready for processing (SEQNUM=2268, ACTION="">00:00:10 systemd-udevd[985]: 8:16: Processing device (SEQNUM=2268, ACTION="">00:00:10 systemd-udevd[985]: 8:16: Device processed (SEQNUM=2268, ACTION="">00:00:10 systemd-udevd[985]: 8:16: sd-device-monitor: Passed 138 byte to netlink monitor
00:00:10 systemd-udevd[216]: 8:16: sd-device-monitor: Passed 138 byte to netlink monitor
00:00:10 systemd-udevd[216]: sdb: Device is queued (SEQNUM=2269, ACTION="">00:00:10 systemd-udevd[216]: sdb: SEQNUM=2269 blocked by SEQNUM=2263
00:00:10 systemd-udevd[988]: 6:0:0:0: Processing device (SEQNUM=2263, ACTION="">00:00:10 systemd-udevd[988]: 6:0:0:0: /usr/lib/udev/rules.d/50-udev-default.rules:14 Importing properties from results of builtin command 'hwdb --subsystem=scsi'
00:00:10 systemd-udevd[988]: 6:0:0:0: hwdb modalias key: "scsi:t-0x00"
00:00:10 systemd-udevd[988]: 6:0:0:0: No entry found from hwdb.
00:00:10 systemd-udevd[988]: 6:0:0:0: /usr/lib/udev/rules.d/50-udev-default.rules:14 Failed to run builtin 'hwdb --subsystem=scsi': No data available
00:00:10 systemd-udevd[988]: 6:0:0:0: /usr/lib/udev/rules.d/80-drivers.rules:5 RUN 'kmod load '$env{MODALIAS}''
00:00:10 systemd-udevd[988]: 6:0:0:0: Running built-in command "kmod load 'scsi:t-0x00'"
00:00:10 systemd-udevd[988]: Loading module: scsi:t-0x00
00:00:10 systemd-udevd[988]: Module 'sd_mod' is built in
00:00:10 systemd-udevd[988]: 6:0:0:0: Device processed (SEQNUM=2263, ACTION="">00:00:10 systemd-udevd[988]: 6:0:0:0: sd-device-monitor: Passed 230 byte to netlink monitor
00:00:10 systemd-udevd[216]: 6:0:0:0: Device ready for processing (SEQNUM=2264, ACTION="">00:00:10 systemd-udevd[216]: 6:0:0:0: sd-device-monitor: Passed 216 byte to netlink monitor
00:00:10 systemd-udevd[216]: 6:0:0:0: Device ready for processing (SEQNUM=2265, ACTION="">00:00:10 systemd-udevd[985]: 6:0:0:0: Processing device (SEQNUM=2265, ACTION="">00:00:10 systemd-udevd[985]: 6:0:0:0: Device processed (SEQNUM=2265, ACTION="">00:00:10 systemd-udevd[985]: 6:0:0:0: sd-device-monitor: Passed 212 byte to netlink monitor
00:00:10 systemd-udevd[216]: 6:0:0:0: sd-device-monitor: Passed 212 byte to netlink monitor
00:00:10 systemd-udevd[216]: 6:0:0:0: SEQNUM=2266 blocked by SEQNUM=2264
00:00:10 systemd-udevd[216]: 6:0:0:0: SEQNUM=2267 blocked by SEQNUM=2266
00:00:10 systemd-udevd[216]: sdb: SEQNUM=2269 blocked by SEQNUM=2266
00:00:10 systemd-udevd[988]: 6:0:0:0: Processing device (SEQNUM=2264, ACTION="">00:00:10 systemd-udevd[988]: 6:0:0:0: Device processed (SEQNUM=2264, ACTION="">00:00:10 systemd-udevd[988]: 6:0:0:0: sd-device-monitor: Passed 216 byte to netlink monitor
00:00:10 systemd-udevd[216]: 6:0:0:0: Device ready for processing (SEQNUM=2266, ACTION="">00:00:10 systemd-udevd[216]: 6:0:0:0: sd-device-monitor: Passed 275 byte to netlink monitor
00:00:10 kernel: scsi 6:0:0:0: Direct-Access QEMU QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5
00:00:10 kernel: sd 6:0:0:0: Power-on or device reset occurred
00:00:10 kernel: sd 6:0:0:0: [sdb] 524288 512-byte logical blocks: (268 MB/256 MiB)
00:00:10 kernel: sd 6:0:0:0: [sdb] Write Protect is off
00:00:10 kernel: sd 6:0:0:0: [sdb] Mode Sense: 63 00 00 08
00:00:10 kernel: sd 6:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
00:00:10 systemd-udevd[988]: 6:0:0:0: Processing device (SEQNUM=2266, ACTION="">00:00:10 systemd-udevd[988]: 6:0:0:0: /usr/lib/udev/rules.d/50-udev-default.rules:14 Importing properties from results of builtin command 'hwdb --subsystem=scsi'
00:00:10 systemd-udevd[988]: 6:0:0:0: hwdb modalias key: "scsi:t-0x00"
00:00:10 systemd-udevd[988]: 6:0:0:0: No entry found from hwdb.
00:00:10 systemd-udevd[988]: 6:0:0:0: /usr/lib/udev/rules.d/50-udev-default.rules:14 Failed to run builtin 'hwdb --subsystem=scsi': No data available
00:00:10 systemd-udevd[988]: 6:0:0:0: /usr/lib/udev/rules.d/60-block.rules:8 ATTR '/sys/devices/pci0000:00/0000:00:03.0/usb2/2-3/2-3:1.0/host6/target6:0:0/6:0:0:0/block/sdb/uevent' writing 'change'
00:00:10 systemd-udevd[988]: 6:0:0:0: Device processed (SEQNUM=2266, ACTION="">00:00:10 systemd-udevd[988]: 6:0:0:0: sd-device-monitor: Passed 275 byte to netlink monitor
00:00:10 systemd-udevd[216]: sdb: Device is queued (SEQNUM=2270, ACTION="">00:00:10 systemd-udevd[216]: sdb: SEQNUM=2270 blocked by SEQNUM=2266
00:00:10 systemd-udevd[216]: 6:0:0:0: Device ready for processing (SEQNUM=2267, ACTION="">00:00:10 systemd-udevd[216]: 6:0:0:0: sd-device-monitor: Passed 243 byte to netlink monitor
00:00:10 systemd-udevd[216]: sdb: Device ready for processing (SEQNUM=2269, ACTION="">00:00:10 systemd-udevd[985]: sdb: Processing device (SEQNUM=2269, ACTION="">00:00:10 systemd-udevd[985]: sdb: Failed to get watch handle, ignoring: No such file or directory
00:00:10 systemd-udevd[985]: sdb: /usr/lib/udev/rules.d/50-udev-default.rules:69 GROUP 995
00:00:10 systemd-udevd[985]: sdb: /usr/lib/udev/rules.d/60-persistent-storage.rules:60 Importing properties from results of 'ata_id --export /dev/sdb'
00:00:10 systemd-udevd[985]: sdb: Starting 'ata_id --export /dev/sdb'
00:00:10 systemd-udevd[985]: Successfully forked off '(spawn)' as PID 992.
00:00:10 systemd-udevd[216]: sdb: sd-device-monitor: Passed 247 byte to netlink monitor
00:00:10 systemd-udevd[216]: sdb: SEQNUM=2270 blocked by SEQNUM=2269
00:00:10 systemd-udevd[988]: 6:0:0:0: Processing device (SEQNUM=2267, ACTION="">00:00:10 systemd-udevd[988]: 6:0:0:0: Failed to get watch handle, ignoring: No such file or directory
00:00:10 systemd-udevd[988]: 6:0:0:0: Handling device node '/dev/bsg/6:0:0:0', devnum=c243:2
00:00:10 systemd-udevd[988]: 6:0:0:0: Preserve permissions of /dev/bsg/6:0:0:0, uid=0, gid=0, mode=0600
00:00:10 systemd-udevd[988]: 6:0:0:0: Creating symlink '/dev/char/243:2' to '../bsg/6:0:0:0'
00:00:10 systemd-udevd[988]: 6:0:0:0: sd-device: Created empty file '/run/udev/data/c243:2' for '/devices/pci0000:00/0000:00:03.0/usb2/2-3/2-3:1.0/host6/target6:0:0/6:0:0:0/bsg/6:0:0:0'
00:00:10 systemd-udevd[988]: 6:0:0:0: Handling device node '/dev/bsg/6:0:0:0', devnum=c243:2
00:00:10 systemd-udevd[988]: 6:0:0:0: Preserve permissions of /dev/bsg/6:0:0:0, uid=0, gid=0, mode=0600
00:00:10 systemd-udevd[988]: 6:0:0:0: Preserve already existing symlink '/dev/char/243:2' to '../bsg/6:0:0:0'
00:00:10 systemd-udevd[988]: 6:0:0:0: Failed to get watch handle, ignoring: No such file or directory
00:00:10 systemd-udevd[988]: 6:0:0:0: Device processed (SEQNUM=2267, ACTION="">00:00:10 systemd-udevd[988]: 6:0:0:0: sd-device-monitor: Passed 243 byte to netlink monitor
00:00:10 systemd-udevd[216]: 6:0:0:0: Device is queued (SEQNUM=2271, ACTION="">00:00:10 systemd-udevd[216]: 6:0:0:0: SEQNUM=2271 blocked by SEQNUM=2269
00:00:10 systemd-udevd[985]: sdb: Process 'ata_id --export /dev/sdb' failed with exit code 2.
00:00:10 systemd-udevd[985]: sdb: /usr/lib/udev/rules.d/60-persistent-storage.rules:60 Command "ata_id --export /dev/sdb" returned 2 (error), ignoring
00:00:10 systemd-udevd[985]: sdb: /usr/lib/udev/rules.d/60-persistent-storage.rules:63 Importing properties from results of builtin command 'usb_id'
00:00:10 systemd-udevd[985]: 2-3:1.0: if_class:8 protocol:6
00:00:10 systemd-udevd[985]: sdb: /usr/lib/udev/rules.d/60-persistent-storage.rules:68 LINK 'disk/by-id/usb-QEMU_QEMU_HARDDISK_1-0000:00:03.0-3-0:0'
00:00:10 systemd-udevd[985]: sdb: /usr/lib/udev/rules.d/60-persistent-storage.rules:90 Importing properties from results of builtin command 'path_id'
00:00:10 systemd-udevd[985]: sdb: /usr/lib/udev/rules.d/60-persistent-storage.rules:92 LINK 'disk/by-path/pci-0000:00:03.0-usb-0:3:1.0-scsi-0:0:0:0'
00:00:10 systemd-udevd[985]: sdb: /usr/lib/udev/rules.d/60-persistent-storage.rules:110 Importing properties from results of builtin command 'blkid'
00:00:10 systemd-udevd[985]: sdb: Probe /dev/sdb with raid and offset=0
00:00:10 kernel: sd 6:0:0:0: [sdb] Attached SCSI disk
00:00:10 systemd-udevd[985]: sdb: /usr/lib/udev/rules.d/69-vdev.rules:5 Importing properties from results of '/usr/lib/udev/vdev_id -d sdb'
00:00:10 systemd-udevd[985]: sdb: Starting '/usr/lib/udev/vdev_id -d sdb'
00:00:10 systemd-udevd[985]: Successfully forked off '(spawn)' as PID 993.
00:00:10 systemd-udevd[985]: sdb: '/usr/lib/udev/vdev_id -d sdb'(out) 'Error: Config file "/etc/zfs/vdev_id.conf" not found'
00:00:10 systemd-udevd[985]: sdb: Process '/usr/lib/udev/vdev_id -d sdb' failed with exit code 1.
00:00:10 systemd-udevd[985]: sdb: /usr/lib/udev/rules.d/69-vdev.rules:5 Command "/usr/lib/udev/vdev_id -d sdb" returned 1 (error), ignoring
00:00:10 systemd-udevd[985]: sdb: Handling device node '/dev/sdb', devnum=b8:16
00:00:10 systemd-udevd[985]: sdb: Setting permissions /dev/sdb, uid=0, gid=995, mode=0660
00:00:10 systemd-udevd[985]: sdb: Found 'b8:16' claiming '/run/udev/links/disk\x2fby-id\x2fusb-QEMU_QEMU_HARDDISK_1-0000:00:03.0-3-0:0'
00:00:10 systemd-udevd[985]: sdb: Creating symlink '/dev/disk/by-id/usb-QEMU_QEMU_HARDDISK_1-0000:00:03.0-3-0:0' to '../../sdb'
00:00:10 systemd-udevd[985]: sdb: Found 'b8:16' claiming '/run/udev/links/disk\x2fby-path\x2fpci-0000:00:03.0-usb-0:3:1.0-scsi-0:0:0:0'
00:00:10 systemd-udevd[985]: sdb: Creating symlink '/dev/disk/by-path/pci-0000:00:03.0-usb-0:3:1.0-scsi-0:0:0:0' to '../../sdb'
00:00:10 systemd-udevd[985]: sdb: Creating symlink '/dev/block/8:16' to '../sdb'
00:00:10 systemd-udevd[985]: sdb: sd-device: Created db file '/run/udev/data/b8:16' for '/devices/pci0000:00/0000:00:03.0/usb2/2-3/2-3:1.0/host6/target6:0:0/6:0:0:0/block/sdb'
00:00:10 systemd-udevd[985]: sdb: Handling device node '/dev/sdb', devnum=b8:16
00:00:10 systemd-udevd[985]: sdb: Preserve permissions of /dev/sdb, uid=0, gid=995, mode=0660
00:00:10 systemd-udevd[985]: sdb: Found 'b8:16' claiming '/run/udev/links/disk\x2fby-id\x2fusb-QEMU_QEMU_HARDDISK_1-0000:00:03.0-3-0:0'
00:00:10 systemd-udevd[985]: sdb: Preserve already existing symlink '/dev/disk/by-id/usb-QEMU_QEMU_HARDDISK_1-0000:00:03.0-3-0:0' to '../../sdb'
00:00:10 systemd-udevd[985]: sdb: Found 'b8:16' claiming '/run/udev/links/disk\x2fby-path\x2fpci-0000:00:03.0-usb-0:3:1.0-scsi-0:0:0:0'
00:00:10 systemd-udevd[985]: sdb: Preserve already existing symlink '/dev/disk/by-path/pci-0000:00:03.0-usb-0:3:1.0-scsi-0:0:0:0' to '../../sdb'
00:00:10 systemd-udevd[985]: sdb: Preserve already existing symlink '/dev/block/8:16' to '../sdb'
00:00:10 systemd-udevd[985]: sdb: Adding watch on '/dev/sdb'
00:00:10 systemd-udevd[985]: sdb: Device processed (SEQNUM=2269, ACTION="">00:00:10 systemd[295]: dev-disk-by\x2did-usb\x2dQEMU_QEMU_HARDDISK_1\x2d0000:00:03.0\x2d3\x2d0:0.device: Changed dead -> plugged
00:00:10 systemd[1]: dev-disk-by\x2dpath-pci\x2d0000:00:03.0\x2dusb\x2d0:3:1.0\x2dscsi\x2d0:0:0:0.device: Changed dead -> plugged
00:00:10 systemd[1]: dev-disk-by\x2did-usb\x2dQEMU_QEMU_HARDDISK_1\x2d0000:00:03.0\x2d3\x2d0:0.device: Changed dead -> plugged
00:00:10 systemd[1]: dev-sdb.device: Changed dead -> plugged
00:00:10 systemd[1]: sys-devices-pci0000:00-0000:00:03.0-usb2-2\x2d3-2\x2d3:1.0-host6-target6:0:0-6:0:0:0-block-sdb.device: Changed dead -> plugged
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=UnitNew cookie=290 reply_cookie=0 signature=so error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=UnitNew cookie=291 reply_cookie=0 signature=so error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=UnitNew cookie=292 reply_cookie=0 signature=so error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=UnitNew cookie=293 reply_cookie=0 signature=so error-name=n/a error-message=n/a
00:00:10 systemd[295]: dev-disk-by\x2dpath-pci\x2d0000:00:03.0\x2dusb\x2d0:3:1.0\x2dscsi\x2d0:0:0:0.device: Changed dead -> plugged
00:00:10 systemd[295]: dev-sdb.device: Changed dead -> plugged
00:00:10 systemd[295]: sys-devices-pci0000:00-0000:00:03.0-usb2-2\x2d3-2\x2d3:1.0-host6-target6:0:0-6:0:0:0-block-sdb.device: Changed dead -> plugged
00:00:10 systemd-udevd[985]: sdb: sd-device-monitor: Passed 885 byte to netlink monitor
00:00:10 systemd-udevd[216]: sdb: Device ready for processing (SEQNUM=2270, ACTION="">00:00:10 systemd-udevd[216]: sdb: sd-device-monitor: Passed 263 byte to netlink monitor
00:00:10 systemd-udevd[988]: sdb: Processing device (SEQNUM=2270, ACTION="">00:00:10 systemd-udevd[988]: sdb: Removing watch
00:00:10 systemd-udevd[216]: 6:0:0:0: SEQNUM=2271 blocked by SEQNUM=2270
00:00:10 systemd-udevd[216]: sdb: Inotify event: 8000 for /dev/sdb
00:00:10 systemd-udevd[988]: sdb: /usr/lib/udev/rules.d/60-persistent-storage.rules:60 Importing properties from results of 'ata_id --export /dev/sdb'
00:00:10 systemd-udevd[988]: sdb: Starting 'ata_id --export /dev/sdb'
00:00:10 systemd-udevd[988]: Successfully forked off '(spawn)' as PID 994.
00:00:10 systemd-udevd[988]: sdb: Process 'ata_id --export /dev/sdb' failed with exit code 2.
00:00:10 systemd-udevd[988]: sdb: /usr/lib/udev/rules.d/60-persistent-storage.rules:60 Command "ata_id --export /dev/sdb" returned 2 (error), ignoring
00:00:10 systemd-udevd[988]: sdb: /usr/lib/udev/rules.d/60-persistent-storage.rules:63 Importing properties from results of builtin command 'usb_id'
00:00:10 systemd-udevd[988]: 2-3:1.0: if_class:8 protocol:6
00:00:10 systemd-udevd[988]: sdb: /usr/lib/udev/rules.d/60-persistent-storage.rules:68 LINK 'disk/by-id/usb-QEMU_QEMU_HARDDISK_1-0000:00:03.0-3-0:0'
00:00:10 systemd-udevd[988]: sdb: /usr/lib/udev/rules.d/60-persistent-storage.rules:90 Importing properties from results of builtin command 'path_id'
00:00:10 systemd-udevd[988]: sdb: /usr/lib/udev/rules.d/60-persistent-storage.rules:92 LINK 'disk/by-path/pci-0000:00:03.0-usb-0:3:1.0-scsi-0:0:0:0'
00:00:10 systemd-udevd[988]: sdb: /usr/lib/udev/rules.d/60-persistent-storage.rules:110 Importing properties from results of builtin command 'blkid'
00:00:10 systemd-udevd[988]: sdb: Probe /dev/sdb with raid and offset=0
00:00:10 systemd-udevd[988]: sdb: /usr/lib/udev/rules.d/69-vdev.rules:5 Importing properties from results of '/usr/lib/udev/vdev_id -d sdb'
00:00:10 systemd-udevd[988]: sdb: Starting '/usr/lib/udev/vdev_id -d sdb'
00:00:10 systemd-udevd[988]: Successfully forked off '(spawn)' as PID 995.
00:00:10 systemd-udevd[988]: sdb: '/usr/lib/udev/vdev_id -d sdb'(out) 'Error: Config file "/etc/zfs/vdev_id.conf" not found'
00:00:10 systemd-udevd[988]: sdb: Process '/usr/lib/udev/vdev_id -d sdb' failed with exit code 1.
00:00:10 systemd-udevd[988]: sdb: /usr/lib/udev/rules.d/69-vdev.rules:5 Command "/usr/lib/udev/vdev_id -d sdb" returned 1 (error), ignoring
00:00:10 systemd-udevd[988]: sdb: Handling device node '/dev/sdb', devnum=b8:16
00:00:10 systemd-udevd[988]: sdb: Found 'b8:16' claiming '/run/udev/links/disk\x2fby-id\x2fusb-QEMU_QEMU_HARDDISK_1-0000:00:03.0-3-0:0'
00:00:10 systemd-udevd[988]: sdb: Preserve already existing symlink '/dev/disk/by-id/usb-QEMU_QEMU_HARDDISK_1-0000:00:03.0-3-0:0' to '../../sdb'
00:00:10 systemd-udevd[988]: sdb: Found 'b8:16' claiming '/run/udev/links/disk\x2fby-path\x2fpci-0000:00:03.0-usb-0:3:1.0-scsi-0:0:0:0'
00:00:10 systemd-udevd[988]: sdb: Preserve already existing symlink '/dev/disk/by-path/pci-0000:00:03.0-usb-0:3:1.0-scsi-0:0:0:0' to '../../sdb'
00:00:10 systemd-udevd[988]: sdb: Preserve already existing symlink '/dev/block/8:16' to '../sdb'
00:00:10 systemd-udevd[988]: sdb: sd-device: Created db file '/run/udev/data/b8:16' for '/devices/pci0000:00/0000:00:03.0/usb2/2-3/2-3:1.0/host6/target6:0:0/6:0:0:0/block/sdb'
00:00:10 systemd-udevd[988]: sdb: Handling device node '/dev/sdb', devnum=b8:16
00:00:10 systemd-udevd[988]: sdb: Found 'b8:16' claiming '/run/udev/links/disk\x2fby-id\x2fusb-QEMU_QEMU_HARDDISK_1-0000:00:03.0-3-0:0'
00:00:10 systemd-udevd[988]: sdb: Preserve already existing symlink '/dev/disk/by-id/usb-QEMU_QEMU_HARDDISK_1-0000:00:03.0-3-0:0' to '../../sdb'
00:00:10 systemd-udevd[988]: sdb: Found 'b8:16' claiming '/run/udev/links/disk\x2fby-path\x2fpci-0000:00:03.0-usb-0:3:1.0-scsi-0:0:0:0'
00:00:10 systemd-udevd[988]: sdb: Preserve already existing symlink '/dev/disk/by-path/pci-0000:00:03.0-usb-0:3:1.0-scsi-0:0:0:0' to '../../sdb'
00:00:10 systemd-udevd[988]: sdb: Preserve already existing symlink '/dev/block/8:16' to '../sdb'
00:00:10 systemd-udevd[988]: sdb: Adding watch on '/dev/sdb'
00:00:10 systemd-udevd[988]: sdb: Device processed (SEQNUM=2270, ACTION="">00:00:10 systemd[295]: dev-disk-by\x2did-usb\x2dQEMU_QEMU_HARDDISK_1\x2d0000:00:03.0\x2d3\x2d0:0.device: Installed new job dev-disk-by\x2did-usb\x2dQEMU_QEMU_HARDDISK_1\x2d0000:00:03.0\x2d3\x2d0:0.device/nop as 58
00:00:10 systemd[295]: dev-disk-by\x2dpath-pci\x2d0000:00:03.0\x2dusb\x2d0:3:1.0\x2dscsi\x2d0:0:0:0.device: Installed new job dev-disk-by\x2dpath-pci\x2d0000:00:03.0\x2dusb\x2d0:3:1.0\x2dscsi\x2d0:0:0:0.device/nop as 59
00:00:10 systemd[295]: dev-sdb.device: Installed new job dev-sdb.device/nop as 60
00:00:10 systemd[295]: sys-devices-pci0000:00-0000:00:03.0-usb2-2\x2d3-2\x2d3:1.0-host6-target6:0:0-6:0:0:0-block-sdb.device: Installed new job sys-devices-pci0000:00-0000:00:03.0-usb2-2\x2d3-2\x2d3:1.0-host6-target6:0:0-6:0:0:0-block-sdb.device/nop as 61
00:00:10 systemd[295]: dev-disk-by\x2did-usb\x2dQEMU_QEMU_HARDDISK_1\x2d0000:00:03.0\x2d3\x2d0:0.device: Job 58 dev-disk-by\x2did-usb\x2dQEMU_QEMU_HARDDISK_1\x2d0000:00:03.0\x2d3\x2d0:0.device/nop finished, result=done
00:00:10 systemd[295]: dev-disk-by\x2dpath-pci\x2d0000:00:03.0\x2dusb\x2d0:3:1.0\x2dscsi\x2d0:0:0:0.device: Job 59 dev-disk-by\x2dpath-pci\x2d0000:00:03.0\x2dusb\x2d0:3:1.0\x2dscsi\x2d0:0:0:0.device/nop finished, result=done
00:00:10 systemd[295]: dev-sdb.device: Job 60 dev-sdb.device/nop finished, result=done
00:00:10 systemd[295]: sys-devices-pci0000:00-0000:00:03.0-usb2-2\x2d3-2\x2d3:1.0-host6-target6:0:0-6:0:0:0-block-sdb.device: Job 61 sys-devices-pci0000:00-0000:00:03.0-usb2-2\x2d3-2\x2d3:1.0-host6-target6:0:0-6:0:0:0-block-sdb.device/nop finished, result=done
00:00:10 systemd[1]: dev-disk-by\x2dpath-pci\x2d0000:00:03.0\x2dusb\x2d0:3:1.0\x2dscsi\x2d0:0:0:0.device: Installed new job dev-disk-by\x2dpath-pci\x2d0000:00:03.0\x2dusb\x2d0:3:1.0\x2dscsi\x2d0:0:0:0.device/nop as 300
00:00:10 systemd[1]: dev-disk-by\x2did-usb\x2dQEMU_QEMU_HARDDISK_1\x2d0000:00:03.0\x2d3\x2d0:0.device: Installed new job dev-disk-by\x2did-usb\x2dQEMU_QEMU_HARDDISK_1\x2d0000:00:03.0\x2d3\x2d0:0.device/nop as 301
00:00:10 systemd[1]: dev-sdb.device: Installed new job dev-sdb.device/nop as 302
00:00:10 systemd[1]: sys-devices-pci0000:00-0000:00:03.0-usb2-2\x2d3-2\x2d3:1.0-host6-target6:0:0-6:0:0:0-block-sdb.device: Installed new job sys-devices-pci0000:00-0000:00:03.0-usb2-2\x2d3-2\x2d3:1.0-host6-target6:0:0-6:0:0:0-block-sdb.device/nop as 303
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/sys_2ddevices_2dpci0000_3a00_2d0000_3a00_3a03_2e0_2dusb2_2d2_5cx2d3_2d2_5cx2d3_3a1_2e0_2dhost6_2dtarget6_3a0_3a0_2d6_3a0_3a0_3a0_2dblock_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=294 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/sys_2ddevices_2dpci0000_3a00_2d0000_3a00_3a03_2e0_2dusb2_2d2_5cx2d3_2d2_5cx2d3_3a1_2e0_2dhost6_2dtarget6_3a0_3a0_2d6_3a0_3a0_3a0_2dblock_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=295 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/dev_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=296 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/dev_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=297 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2did_2dusb_5cx2dQEMU_5fQEMU_5fHARDDISK_5f1_5cx2d0000_3a00_3a03_2e0_5cx2d3_5cx2d0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=298 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2did_2dusb_5cx2dQEMU_5fQEMU_5fHARDDISK_5f1_5cx2d0000_3a00_3a03_2e0_5cx2d3_5cx2d0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=299 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2dpath_2dpci_5cx2d0000_3a00_3a03_2e0_5cx2dusb_5cx2d0_3a3_3a1_2e0_5cx2dscsi_5cx2d0_3a0_3a0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=300 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2dpath_2dpci_5cx2d0000_3a00_3a03_2e0_5cx2dusb_5cx2d0_3a3_3a1_2e0_5cx2dscsi_5cx2d0_3a0_3a0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=301 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=JobNew cookie=302 reply_cookie=0 signature=uos error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=JobNew cookie=303 reply_cookie=0 signature=uos error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=JobNew cookie=304 reply_cookie=0 signature=uos error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=JobNew cookie=305 reply_cookie=0 signature=uos error-name=n/a error-message=n/a
00:00:10 systemd[1]: dev-disk-by\x2did-usb\x2dQEMU_QEMU_HARDDISK_1\x2d0000:00:03.0\x2d3\x2d0:0.device: Job 301 dev-disk-by\x2did-usb\x2dQEMU_QEMU_HARDDISK_1\x2d0000:00:03.0\x2d3\x2d0:0.device/nop finished, result=done
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=JobRemoved cookie=306 reply_cookie=0 signature=uoss error-name=n/a error-message=n/a
00:00:10 systemd[1]: dev-disk-by\x2dpath-pci\x2d0000:00:03.0\x2dusb\x2d0:3:1.0\x2dscsi\x2d0:0:0:0.device: Job 300 dev-disk-by\x2dpath-pci\x2d0000:00:03.0\x2dusb\x2d0:3:1.0\x2dscsi\x2d0:0:0:0.device/nop finished, result=done
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=JobRemoved cookie=307 reply_cookie=0 signature=uoss error-name=n/a error-message=n/a
00:00:10 systemd[1]: dev-sdb.device: Job 302 dev-sdb.device/nop finished, result=done
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=JobRemoved cookie=308 reply_cookie=0 signature=uoss error-name=n/a error-message=n/a
00:00:10 systemd[1]: sys-devices-pci0000:00-0000:00:03.0-usb2-2\x2d3-2\x2d3:1.0-host6-target6:0:0-6:0:0:0-block-sdb.device: Job 303 sys-devices-pci0000:00-0000:00:03.0-usb2-2\x2d3-2\x2d3:1.0-host6-target6:0:0-6:0:0:0-block-sdb.device/nop finished, result=done
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=JobRemoved cookie=309 reply_cookie=0 signature=uoss error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/sys_2ddevices_2dpci0000_3a00_2d0000_3a00_3a03_2e0_2dusb2_2d2_5cx2d3_2d2_5cx2d3_3a1_2e0_2dhost6_2dtarget6_3a0_3a0_2d6_3a0_3a0_3a0_2dblock_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=310 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/sys_2ddevices_2dpci0000_3a00_2d0000_3a00_3a03_2e0_2dusb2_2d2_5cx2d3_2d2_5cx2d3_3a1_2e0_2dhost6_2dtarget6_3a0_3a0_2d6_3a0_3a0_3a0_2dblock_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=311 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/dev_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=312 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/dev_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=313 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2dpath_2dpci_5cx2d0000_3a00_3a03_2e0_5cx2dusb_5cx2d0_3a3_3a1_2e0_5cx2dscsi_5cx2d0_3a0_3a0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=314 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2dpath_2dpci_5cx2d0000_3a00_3a03_2e0_5cx2dusb_5cx2d0_3a3_3a1_2e0_5cx2dscsi_5cx2d0_3a0_3a0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=315 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2did_2dusb_5cx2dQEMU_5fQEMU_5fHARDDISK_5f1_5cx2d0000_3a00_3a03_2e0_5cx2d3_5cx2d0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=316 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2did_2dusb_5cx2dQEMU_5fQEMU_5fHARDDISK_5f1_5cx2d0000_3a00_3a03_2e0_5cx2d3_5cx2d0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=317 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/sys_2ddevices_2dpci0000_3a00_2d0000_3a00_3a03_2e0_2dusb2_2d2_5cx2d3_2d2_5cx2d3_3a1_2e0_2dhost6_2dtarget6_3a0_3a0_2d6_3a0_3a0_3a0_2dblock_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=294 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/sys_2ddevices_2dpci0000_3a00_2d0000_3a00_3a03_2e0_2dusb2_2d2_5cx2d3_2d2_5cx2d3_3a1_2e0_2dhost6_2dtarget6_3a0_3a0_2d6_3a0_3a0_3a0_2dblock_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=295 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/dev_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=296 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/dev_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=297 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2did_2dusb_5cx2dQEMU_5fQEMU_5fHARDDISK_5f1_5cx2d0000_3a00_3a03_2e0_5cx2d3_5cx2d0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=298 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2did_2dusb_5cx2dQEMU_5fQEMU_5fHARDDISK_5f1_5cx2d0000_3a00_3a03_2e0_5cx2d3_5cx2d0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=299 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2dpath_2dpci_5cx2d0000_3a00_3a03_2e0_5cx2dusb_5cx2d0_3a3_3a1_2e0_5cx2dscsi_5cx2d0_3a0_3a0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=300 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2dpath_2dpci_5cx2d0000_3a00_3a03_2e0_5cx2dusb_5cx2d0_3a3_3a1_2e0_5cx2dscsi_5cx2d0_3a0_3a0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=301 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=JobRemoved cookie=306 reply_cookie=0 signature=uoss error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=JobRemoved cookie=307 reply_cookie=0 signature=uoss error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=JobRemoved cookie=308 reply_cookie=0 signature=uoss error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=JobRemoved cookie=309 reply_cookie=0 signature=uoss error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/sys_2ddevices_2dpci0000_3a00_2d0000_3a00_3a03_2e0_2dusb2_2d2_5cx2d3_2d2_5cx2d3_3a1_2e0_2dhost6_2dtarget6_3a0_3a0_2d6_3a0_3a0_3a0_2dblock_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=310 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/sys_2ddevices_2dpci0000_3a00_2d0000_3a00_3a03_2e0_2dusb2_2d2_5cx2d3_2d2_5cx2d3_3a1_2e0_2dhost6_2dtarget6_3a0_3a0_2d6_3a0_3a0_3a0_2dblock_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=311 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/dev_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=312 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/dev_2dsdb_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=313 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2dpath_2dpci_5cx2d0000_3a00_3a03_2e0_5cx2dusb_5cx2d0_3a3_3a1_2e0_5cx2dscsi_5cx2d0_3a0_3a0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=314 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2dpath_2dpci_5cx2d0000_3a00_3a03_2e0_5cx2dusb_5cx2d0_3a3_3a1_2e0_5cx2dscsi_5cx2d0_3a0_3a0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=315 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2did_2dusb_5cx2dQEMU_5fQEMU_5fHARDDISK_5f1_5cx2d0000_3a00_3a03_2e0_5cx2d3_5cx2d0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=316 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-logind[290]: Got message type=signal sender=:1.0 destination=n/a path=/org/freedesktop/systemd1/unit/dev_2ddisk_2dby_5cx2did_2dusb_5cx2dQEMU_5fQEMU_5fHARDDISK_5f1_5cx2d0000_3a00_3a03_2e0_5cx2d3_5cx2d0_3a0_2edevice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=317 reply_cookie=0 signature=sa{sv}as error-name=n/a error-message=n/a
00:00:10 systemd-udevd[988]: sdb: sd-device-monitor: Passed 901 byte to netlink monitor
00:00:10 systemd-udevd[216]: 6:0:0:0: Device ready for processing (SEQNUM=2271, ACTION="">00:00:10 systemd-udevd[216]: 6:0:0:0: sd-device-monitor: Passed 241 byte to netlink monitor
00:00:10 systemd-udevd[988]: 6:0:0:0: Processing device (SEQNUM=2271, ACTION="">00:00:10 systemd-udevd[988]: 6:0:0:0: /usr/lib/udev/rules.d/50-udev-default.rules:14 Importing properties from results of builtin command 'hwdb --subsystem=scsi'
00:00:10 systemd-udevd[988]: 6:0:0:0: hwdb modalias key: "scsi:t-0x00"
00:00:10 systemd-udevd[988]: 6:0:0:0: No entry found from hwdb.
00:00:10 systemd-udevd[988]: 6:0:0:0: /usr/lib/udev/rules.d/50-udev-default.rules:14 Failed to run builtin 'hwdb --subsystem=scsi': No data available
00:00:10 systemd-udevd[988]: 6:0:0:0: Device processed (SEQNUM=2271, ACTION="">00:00:10 systemd-udevd[988]: 6:0:0:0: sd-device-monitor: Passed 241 byte to netlink monitor
00:00:13 systemd[1]: systemd-journald.service: Got notification message from PID 200 (FDSTORE=1)
00:00:13 systemd[1]: systemd-journald.service: Added fd 61 (n/a) to fd store.
00:00:13 cat[1005]: script running...
00:00:13 systemd[1]: Received SIGCHLD from PID 1010 (qemu-nbd).
00:00:13 systemd[1]: Child 1010 (qemu-nbd) died (code=exited, status=0/SUCCESS)
00:00:13 systemd[1]: session-1.scope: Child 1010 belongs to session-1.scope.
00:00:13 cat[1005]: script performed.
00:00:13 systemd[1]: systemd-journald.service: Received EPOLLHUP on stored fd 61 (stored), closing.
00:00:13 systemd-udevd[216]: nbd0: Inotify event: 8 for /dev/nbd0
00:00:13 systemd-udevd[216]: nbd0: device is closed, synthesising 'change' on /sys/devices/virtual/block/nbd0
00:00:13 systemd-udevd[216]: nbd0: Device is queued (SEQNUM=2272, ACTION="">00:00:13 systemd-udevd[216]: Validate module index
00:00:13 systemd-udevd[216]: Check if link configuration needs reloading.
00:00:13 systemd-udevd[216]: nbd0: Device ready for processing (SEQNUM=2272, ACTION="">00:00:13 systemd-udevd[216]: nbd0: sd-device-monitor: Passed 206 byte to netlink monitor
00:00:13 systemd-udevd[988]: nbd0: Processing device (SEQNUM=2272, ACTION="">00:00:13 systemd-udevd[988]: nbd0: Removing watch
00:00:13 systemd-udevd[988]: nbd0: /usr/lib/udev/rules.d/60-persistent-storage.rules:110 Importing properties from results of builtin command 'blkid'
00:00:13 systemd-udevd[988]: nbd0: Probe /dev/nbd0 with raid and offset=0
00:00:13 systemd-udevd[988]: nbd0: /usr/lib/udev/rules.d/69-vdev.rules:5 Importing properties from results of '/usr/lib/udev/vdev_id -d nbd0'
00:00:13 systemd-udevd[988]: nbd0: Starting '/usr/lib/udev/vdev_id -d nbd0'
00:00:13 systemd-udevd[988]: Successfully forked off '(spawn)' as PID 1022.
00:00:13 systemd-udevd[216]: Failed to create sd_device object from watch handle, ignoring: No such file or directory
00:00:13 systemd-udevd[988]: nbd0: '/usr/lib/udev/vdev_id -d nbd0'(out) 'Error: Config file "/etc/zfs/vdev_id.conf" not found'
00:00:13 systemd-udevd[988]: nbd0: Process '/usr/lib/udev/vdev_id -d nbd0' failed with exit code 1.
00:00:13 systemd-udevd[988]: nbd0: /usr/lib/udev/rules.d/69-vdev.rules:5 Command "/usr/lib/udev/vdev_id -d nbd0" returned 1 (error), ignoring
00:00:13 systemd-udevd[988]: nbd0: Handling device node '/dev/nbd0', devnum=b43:0
00:00:13 systemd-udevd[988]: nbd0: Preserve already existing symlink '/dev/block/43:0' to '../nbd0'
00:00:13 systemd-udevd[988]: nbd0: sd-device: Created db file '/run/udev/data/b43:0' for '/devices/virtual/block/nbd0'
00:00:13 systemd-udevd[988]: nbd0: Handling device node '/dev/nbd0', devnum=b43:0
00:00:13 systemd-udevd[988]: nbd0: Preserve already existing symlink '/dev/block/43:0' to '../nbd0'
00:00:13 systemd-udevd[988]: nbd0: Adding watch on '/dev/nbd0'
00:00:13 systemd-udevd[988]: nbd0: Device processed (SEQNUM=2272, ACTION="">00:00:13 systemd-udevd[988]: nbd0: sd-device-monitor: Passed 260 byte to netlink monitor
00:00:13 systemd-udevd[216]: nbd0: Device is queued (SEQNUM=2273, ACTION="">00:00:13 systemd-udevd[216]: nbd0: Device ready for processing (SEQNUM=2273, ACTION="">00:00:13 systemd-udevd[216]: nbd0: sd-device-monitor: Passed 193 byte to netlink monitor
00:00:13 systemd-udevd[988]: nbd0: Processing device (SEQNUM=2273, ACTION="">00:00:13 systemd-udevd[988]: nbd0: Removing watch
00:00:13 systemd-udevd[216]: nbd0: Inotify event: 8000 for /dev/nbd0
00:00:13 systemd-udevd[988]: nbd0: /usr/lib/udev/rules.d/60-persistent-storage.rules:110 Importing properties from results of builtin command 'blkid'
00:00:13 systemd-udevd[988]: nbd0: Probe /dev/nbd0 with raid and offset=0
00:00:13 systemd-udevd[988]: nbd0: /usr/lib/udev/rules.d/69-vdev.rules:5 Importing properties from results of '/usr/lib/udev/vdev_id -d nbd0'
00:00:13 systemd-udevd[988]: nbd0: Starting '/usr/lib/udev/vdev_id -d nbd0'
00:00:13 systemd-udevd[988]: Successfully forked off '(spawn)' as PID 1024.
00:00:13 systemd-udevd[988]: nbd0: '/usr/lib/udev/vdev_id -d nbd0'(out) 'Error: Config file "/etc/zfs/vdev_id.conf" not found'
00:00:13 systemd-udevd[988]: nbd0: Process '/usr/lib/udev/vdev_id -d nbd0' failed with exit code 1.
00:00:13 systemd-udevd[988]: nbd0: /usr/lib/udev/rules.d/69-vdev.rules:5 Command "/usr/lib/udev/vdev_id -d nbd0" returned 1 (error), ignoring
00:00:13 systemd-udevd[988]: nbd0: Handling device node '/dev/nbd0', devnum=b43:0
00:00:13 systemd-udevd[988]: nbd0: Preserve already existing symlink '/dev/block/43:0' to '../nbd0'
00:00:13 systemd-udevd[988]: nbd0: sd-device: Created db file '/run/udev/data/b43:0' for '/devices/virtual/block/nbd0'
00:00:13 systemd-udevd[988]: nbd0: Handling device node '/dev/nbd0', devnum=b43:0
00:00:13 systemd-udevd[988]: nbd0: Preserve already existing symlink '/dev/block/43:0' to '../nbd0'
00:00:13 systemd-udevd[988]: nbd0: Adding watch on '/dev/nbd0'
00:00:13 systemd-udevd[988]: nbd0: Device processed (SEQNUM=2273, ACTION="">00:00:13 systemd[295]: dev-nbd0.device: Changed dead -> plugged
00:00:13 systemd[295]: sys-devices-virtual-block-nbd0.device: Changed dead -> plugged
00:00:13 systemd[1]: dev-nbd0.device: Changed dead -> plugged
00:00:13 systemd[1]: sys-devices-virtual-block-nbd0.device: Changed dead -> plugged
00:00:13 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=UnitNew cookie=318 reply_cookie=0 signature=so error-name=n/a error-message=n/a
00:00:13 systemd[1]: Sent message type=signal sender=n/a destination=n/a path=/org/freedesktop/systemd1 interface=org.freedesktop.systemd1.Manager member=UnitNew cookie=319 reply_cookie=0 signature=so error-name=n/a error-message=n/a
00:00:13 systemd-udevd[988]: nbd0: sd-device-monitor: Passed 231 byte to netlink monitor
00:00:16 systemd-udevd[216]: Cleanup idle workers
00:00:16 systemd-udevd[985]: Unload module index
00:00:16 systemd-udevd[985]: Unloaded link configuration context.
00:00:16 systemd-udevd[216]: Worker [985] exited
00:00:16 systemd-udevd[988]: Unload module index
00:00:16 systemd-udevd[988]: Unloaded link configuration context.
00:00:16 systemd-udevd[216]: Worker [988] exited
On Thu, May 19, 2022 at 04:40:27PM +0200, Pascal wrote:
> hi,
>
> my system is a Linux (5.10.83) with SystemD (249.7) and Qemu (6.1.0) and
> I've a poor small Bash script:
>
> #!/usr/bin/bash
> systemd-cat -p warning <<< "script running..."
> qemu-nbd -r -s -f raw -c /dev/nbd0 /dev/sdb |& systemd-cat -p warning
>
> after loading nbd module, if I plug a blank disk (/dev/sdb with no
> partition) and call the script (as root) then all is ok and my disk is
> accessible via /dev/nbd0.
>
> after rebooting and reloading nbd module, I install a Udev rule that calls
> my script when a device is added to the system, plug the disk and observe
> the system events with journalctl -f.
> the script is called (eg. script running...) and /dev/nbd0 seems to be
> linked with /dev/sdb but 2 seconds later, the message kernel: block nbd0:
> shutting down sockets appears and /dev/nbd0 becomes unreachable.
>
> where can the problem come from ?
git grep 'shutting down sockets'
does not have any hits in qemu.git, so the message is coming from the
kernel module, and not from the qemu-nbd side of things. Is the
qemu-nbd process still alive when you see the error message? Could it
be a permissions issue, where running your script via a udev rule
creates sockets with different permissions than when running the
script as root, such that the qemu-nbd process is locked out of access
to sockets needed to drive the kernel module?
Can you add a --trace parameter to qemu-nbd to cause it to log more
details about what is going on?
--
Eric Blake, Principal Software Engineer
Red Hat, Inc. +1-919-301-3266
Virtualization: qemu.org | libvirt.org