All of lore.kernel.org
 help / color / mirror / Atom feed
From: Dio Putra <dioput12@gmail.com>
To: Greg KH <gregkh@linuxfoundation.org>
Cc: oneukum@suse.com, linux-usb@vger.kernel.org,
	linux-scsi@vger.kernel.org, linux-usb@vger.kernel.org,
	linux-scsi@vger.kernel.org, usb-storage@lists.one-eyed-alien.net,
	stern@rowland.harvard.edu, linux-kernel@vger.kernel.org
Subject: Re: USB Attached SCSI breakage due no udev involvement
Date: Sun, 10 May 2020 16:48:30 +0700	[thread overview]
Message-ID: <80d4f4d9-91be-b7e8-1f64-13c2fe74f496@gmail.com> (raw)
In-Reply-To: <20200510084820.GA3598083@kroah.com>

[-- Attachment #1: Type: text/plain, Size: 4136 bytes --]

On 5/10/20 3:48 PM, Greg KH wrote:
> On Sun, May 10, 2020 at 03:35:34PM +0700, Dio Putra wrote:
>> On 5/10/20 2:32 PM, Greg KH wrote:
>>> On Sun, May 10, 2020 at 02:10:04PM +0700, Dio Putra wrote:
>>>> On 5/10/20 1:54 PM, Greg KH wrote:
>>>>> On Sun, May 10, 2020 at 01:48:24PM +0700, Dio Putra wrote:
>>>>>> On 5/10/20 12:47 PM, Greg KH wrote:
>>>>>>> On Sun, May 10, 2020 at 09:55:57AM +0700, Dio Putra wrote:
>>>>>>>> Hi, it's first time for me to report user-space breakage in here, so
>>>>>>>> i'm begging your pardon.
>>>>>>>>
>>>>>>>> I want to report that Linux 5.4 breaking my USB mount workflow due
>>>>>>>> udevadm monitor report here (I'm using vanilla kernel 5.4.39 on
>>>>>>>> Slackware64 Current and vanilla kernel 4.4.221 on Slackware64 14.2):
>>>>>>>
>>>>>>> <snip>
>>>>>>>
>>>>>>> Sorry, but what actually changed that you can see in the logs?
>>>>>> Sorry, what do you mean? The dmesg log or the kernel changelogs?
>>>>>
>>>>> Either, your message made them pretty impossible to compare with all of
>>>>> the line-wrapping :(
>>>>>
>>>> I'm so sorry for first message mess, because that message has been sent by
>>>> Gmail Website. Can I send my logs as attachment? I try to convenient everyone
>>>> here. ( FYI, I just switched to Thunderbird with these settings:
>>>> https://www.kernel.org/doc/html/v4.12/process/email-clients.html#thunderbird-gui ) 
>>>
>>> Sure, attachments work, but better yet, if you can show the difference
>>> in a few lines that is much nicer than having to dig through large
>>> numbers of log files.
>>>
>> Okay, I'll attach long messages and trim it as far as I can.
> 
> Again, I really do not understand what exactly is "not working".
> 
> Please explain that when you send the new log messages.
> 
Okay, here's compilation of "dmesg | grep -i udev && udevadm
monitor && lsblk" on linux-4.4.221 vs linux-5.4.39. You can check
my attachment here because I can't explain it by words (I'm not
english native speaker anyway, which makes it so difficult to
explain it for me).

>>>>>>> What functionality broke?  What used to work that no longer does work?
>>>>>>>
>>>>>> Yes, it supposed that just work and kernel could talk with udev, not just handled by the kernel.
>>>>>
>>>>> I don't understand, what functionality changed?  What exactly used to
>>>>> work that no longer does?
>>>> linux-5.4 has been never called the udev dependencies whereas
>>>> linux-4.4 will call any udev dependencies if necessary, that's the problem.
>>>
>>> I do not understand what exactly you mean by "call udev dependencies".
>>>
>>> udev is used to create symlinks and set user/group permissions on device
>>> nodes in /dev/ which is created by devtmpfs.  What exactly is not
>>> happening in your /dev/ with the move to a newer kernel?
>>>
>> Would I send my dmesg log with "udev.log-priority=debug" as attachment then?
>>
>>>>> Did you change anything else other than the kernel on your system?  Did
>>>>> you change to a newer version of udev/systemd or anything else?
>>>>>
>>>> I'm using eudev-master from their official mirror github:
>>>> https://github.com/gentoo/eudev
>>>
>>> Have you contacted the eudev developers to see if something different
>>> needs to be set in your kernel when moving 4 years in kernel development
>>> forward?  Are you sure you have all the correct config options enabled?
>>>
>> It's my bad not to contact the eudev developers first. However I'm not quite
>> sure to contact the eudev developers would solve the problem, but CMIIW.
>>
>>> Why such a huge leap forward all at once, how about going from 4.4.y to
>>> 4.9.y and then 4.14.y and then 5.4.y?  That might help narrow things
>>> down a bit easier.
>>>
>> Unfortunately I need to think twice due almost ran out of electricity
>> here every time I power on my laptop for long time. So maybe I can't.
>>
>> But if these steps are necessary, I'll think solution later.
> 
> Why would it take a long time to do this type of change?
> 
It's a weak machine, it took appropriately 2 hours to just compiling
linux kernel. I need to think twice too because electricity is expensive here.
 
> thanks,
> 
> greg k-h
> 


[-- Attachment #2: linux-4.4.221-compilation_log.txt --]
[-- Type: text/plain, Size: 40551 bytes --]

[linux-4.4.221]$ sudo dmesg | grep -i udev
...<snip>...
[  179.985628] udevd[597]: Validate module index
[  179.985738] udevd[597]: seq 3190 queued, 'add' 'usb'
[  179.986082] udevd[597]: seq 3190 forked new worker [2261]
[  179.986562] udevd[2261]: seq 3190 running
[  179.986905] udevd[2261]: no db file to read /run/udev/data/c189:130: No such file or directory
[  179.987221] udevd[2261]: IMPORT builtin 'usb_id' /lib/udev/rules.d/40-libgphoto2.rules:11
[  179.988381] udevd[597]: seq 3191 queued, 'add' 'usb'
[  179.988827] udevd[597]: seq 3192 queued, 'add' 'scsi'
[  179.988889] udevd[597]: seq 3193 queued, 'add' 'scsi_host'
[  179.989999] udevd[2261]: IMPORT builtin skip 'usb_id' /lib/udev/rules.d/50-udev-default.rules:13
[  179.990013] udevd[2261]: IMPORT builtin 'hwdb' /lib/udev/rules.d/50-udev-default.rules:13
[  179.990245] udevd[2261]: MODE 0664 /lib/udev/rules.d/50-udev-default.rules:41
[  179.990326] udevd[2261]: PROGRAM '/usr/sbin/obex-check-device 125f dc1a' /lib/udev/rules.d/60-openobex.rules:3
[  179.991094] udevd[2265]: starting '/usr/sbin/obex-check-device 125f dc1a'
[  179.998059] udevd[2261]: '/usr/sbin/obex-check-device 125f dc1a' [2265] exit with return code 1
[  179.998489] udevd[2261]: PROGRAM 'mtp-probe /sys/devices/pci0000:00/0000:00:14.0/usb2/2-2 2 3' /lib/udev/rules.d/69-libmtp.rules:2041
[  179.998971] udevd[2267]: starting 'mtp-probe /sys/devices/pci0000:00/0000:00:14.0/usb2/2-2 2 3'
[  180.001904] udevd[2261]: 'mtp-probe /sys/devices/pci0000:00/0000:00:14.0/usb2/2-2 2 3'(out) '0'
[  180.002014] udevd[2261]: 'mtp-probe /sys/devices/pci0000:00/0000:00:14.0/usb2/2-2 2 3' [2267] exit with return code 0
[  180.002934] udevd[2261]: handling device node '/dev/bus/usb/002/003', devnum=c189:130, mode=0664, uid=0, gid=0
[  180.002951] udevd[2261]: set permissions /dev/bus/usb/002/003, 020664, uid=0, gid=0
[  180.002990] udevd[2261]: creating symlink '/dev/char/189:130' to '../bus/usb/002/003'
[  180.003099] udevd[2261]: created db file '/run/udev/data/c189:130' for '/devices/pci0000:00/0000:00:14.0/usb2/2-2'
[  180.024941] udevd[2261]: passed device to netlink monitor 0xaeb610
[  180.024949] udevd[2261]: seq 3190 processed
[  180.030287] udevd[597]: passed 294 byte device to netlink monitor 0xae2130
[  180.030335] udevd[2261]: seq 3191 running
[  180.030458] udevd[2261]: no db file to read /run/udev/data/+usb:2-2:1.0: No such file or directory
[  180.030673] udevd[2261]: IMPORT builtin 'hwdb' /lib/udev/rules.d/50-udev-default.rules:15
[  180.030848] udevd[2261]: RUN 'kmod load $env{MODALIAS}' /lib/udev/rules.d/80-drivers.rules:5
[  180.031005] udevd[2261]: created db file '/run/udev/data/+usb:2-2:1.0' for '/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0'
[  180.031019] udevd[2261]: Execute 'load' 'usb:v125FpDC1Ad1100dc00dsc00dp00ic08isc06ip50in00'
[  180.031220] udevd[2261]: Inserted 'uas'
[  180.031247] udevd[2261]: Inserted 'usb_storage'
[  180.031312] udevd[2261]: passed device to netlink monitor 0xaeb610
[  180.031318] udevd[2261]: seq 3191 processed
[  180.031864] udevd[597]: passed 187 byte device to netlink monitor 0xae2130
[  180.032255] udevd[2261]: seq 3192 running
[  180.032336] udevd[2261]: no db file to read /run/udev/data/+scsi:host9: No such file or directory
[  180.032731] udevd[2261]: passed device to netlink monitor 0xaeb610
[  180.032737] udevd[2261]: seq 3192 processed
[  180.032848] udevd[597]: passed 190 byte device to netlink monitor 0xae2130
[  180.033444] udevd[2261]: seq 3193 running
[  180.033514] udevd[2261]: no db file to read /run/udev/data/+scsi_host:host9: No such file or directory
[  180.034120] udevd[2261]: passed device to netlink monitor 0xaeb610
[  180.034127] udevd[2261]: seq 3193 processed
[  181.253295] udevd[597]: seq 3194 queued, 'add' 'scsi'
[  181.253360] udevd[597]: passed 201 byte device to netlink monitor 0xae2130
[  181.253451] udevd[2261]: seq 3194 running
[  181.253492] udevd[597]: seq 3195 queued, 'add' 'scsi'
[  181.253575] udevd[597]: seq 3196 queued, 'add' 'scsi_disk'
[  181.253635] udevd[2261]: no db file to read /run/udev/data/+scsi:target9:0:0: No such file or directory
[  181.253647] udevd[597]: seq 3197 queued, 'add' 'scsi_device'
[  181.253725] udevd[597]: seq 3198 queued, 'add' 'bsg'
[  181.254339] udevd[2261]: passed device to netlink monitor 0xaeb610
[  181.254350] udevd[2261]: seq 3194 processed
[  181.255242] udevd[597]: passed 230 byte device to netlink monitor 0xae2130
[  181.255328] udevd[2261]: seq 3195 running
[  181.255440] udevd[2261]: no db file to read /run/udev/data/+scsi:9:0:0:0: No such file or directory
[  181.255466] udevd[2261]: IMPORT builtin 'hwdb' /lib/udev/rules.d/50-udev-default.rules:15
[  181.255594] udevd[2261]: no db file to read /run/udev/data/+scsi:target9:0:0: No such file or directory
[  181.255680] udevd[2261]: no db file to read /run/udev/data/+scsi:host9: No such file or directory
[  181.255803] udevd[2261]: IMPORT builtin 'hwdb' returned non-zero
[  181.256027] udevd[2261]: RUN 'kmod load $env{MODALIAS}' /lib/udev/rules.d/80-drivers.rules:5
[  181.256268] udevd[2261]: Execute 'load' 'scsi:t-0x00'
[  181.256293] udevd[2261]: No module matches 'scsi:t-0x00'
[  181.256353] udevd[2261]: passed device to netlink monitor 0xaeb610
[  181.256361] udevd[2261]: seq 3195 processed
[  181.256889] udevd[597]: passed 212 byte device to netlink monitor 0xae2130
[  181.257277] udevd[597]: seq 3197 forked new worker [2289]
[  181.257589] udevd[597]: seq 3198 forked new worker [2290]
[  181.258064] udevd[2261]: seq 3196 running
[  181.258177] udevd[2261]: no db file to read /run/udev/data/+scsi_disk:9:0:0:0: No such file or directory
[  181.258996] udevd[2261]: passed device to netlink monitor 0xaeb610
[  181.259006] udevd[2261]: seq 3196 processed
[  181.260725] udevd[2290]: seq 3198 running
[  181.260762] udevd[2289]: seq 3197 running
[  181.260972] udevd[2289]: no db file to read /run/udev/data/+scsi_device:9:0:0:0: No such file or directory
[  181.260974] udevd[2290]: no db file to read /run/udev/data/c250:2: No such file or directory
[  181.261977] udevd[2290]: handling device node '/dev/bsg/9:0:0:0', devnum=c250:2, mode=0600, uid=0, gid=0
[  181.261994] udevd[2290]: preserve permissions /dev/bsg/9:0:0:0, 020600, uid=0, gid=0
[  181.262030] udevd[2290]: creating symlink '/dev/char/250:2' to '../bsg/9:0:0:0'
[  181.262103] udevd[2290]: created empty file '/run/udev/data/c250:2' for '/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/bsg/9:0:0:0'
[  181.262849] udevd[597]: seq 3199 queued, 'add' 'bdi'
[  181.262946] udevd[597]: passed 138 byte device to netlink monitor 0xae2130
[  181.263043] udevd[2261]: seq 3199 running
[  181.263109] udevd[2261]: no db file to read /run/udev/data/+bdi:8:32: No such file or directory
[  181.263311] udevd[2261]: passed device to netlink monitor 0xaeb610
[  181.263319] udevd[2261]: seq 3199 processed
[  181.263996] udevd[2289]: passed device to netlink monitor 0xae44a0
[  181.264004] udevd[2289]: seq 3197 processed
[  181.264116] udevd[2290]: passed device to netlink monitor 0xaf5ce0
[  181.264125] udevd[2290]: seq 3198 processed
[  181.270013] udevd[597]: seq 3200 queued, 'add' 'block'
[  181.270071] udevd[597]: passed 247 byte device to netlink monitor 0xae2130
[  181.270157] udevd[2289]: seq 3200 running
[  181.270185] udevd[597]: seq 3201 queued, 'add' 'block'
[  181.270266] udevd[597]: seq 3202 queued, 'add' 'block'
[  181.271450] udevd[2289]: no db file to read /run/udev/data/b8:32: No such file or directory
[  181.272310] udevd[2289]: GROUP 6 /lib/udev/rules.d/50-udev-default.rules:55
[  181.272551] udevd[2289]: IMPORT builtin 'usb_id' /lib/udev/rules.d/60-persistent-storage.rules:31
[  181.272711] udevd[2289]: /sys/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0: if_class 8 protocol 6
[  181.273055] udevd[2289]: LINK 'disk/by-id/usb-ADATA_USB_Flash_Drive_25B2521060220044-0:0' /lib/udev/rules.d/60-persistent-storage.rules:36
[  181.273147] udevd[2289]: IMPORT builtin 'path_id' /lib/udev/rules.d/60-persistent-storage.rules:54
[  181.273335] udevd[2289]: LINK 'disk/by-path/pci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0' /lib/udev/rules.d/60-persistent-storage.rules:55
[  181.273348] udevd[2289]: IMPORT builtin 'blkid' /lib/udev/rules.d/60-persistent-storage.rules:66
[  181.273874] udevd[2289]: probe /dev/sdc raid offset=0
[  181.331985] udevd[2289]: GROUP 6 /lib/udev/rules.d/65-permissions.rules:13
[  181.332004] udevd[2289]: GROUP 83 /lib/udev/rules.d/65-permissions.rules:16
[  181.332202] udevd[2289]: IMPORT 'udisks-part-id /dev/sdc' /lib/udev/rules.d/80-udisks.rules:84
[  181.332732] udevd[2291]: starting 'udisks-part-id /dev/sdc'
[  181.339628] udevd[2289]: 'udisks-part-id /dev/sdc'(err) 'using device_file=/dev/sdc syspath=/sys/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc, offset=0 ao=0 and number=0 for /dev/sdc'
[  181.339771] udevd[2289]: 'udisks-part-id /dev/sdc'(err) 'Entering MS-DOS parser (offset=0, size=15518924800)'
[  181.339800] udevd[2289]: 'udisks-part-id /dev/sdc'(err) 'MSDOS_MAGIC found'
[  181.339812] udevd[2289]: 'udisks-part-id /dev/sdc'(err) 'looking at part 0 (offset 1048576, size 4293918720, type 0x0b)'
[  181.339818] udevd[2289]: 'udisks-part-id /dev/sdc'(err) 'new part entry'
[  181.339829] udevd[2289]: 'udisks-part-id /dev/sdc'(err) 'looking at part 1 (offset 4294967296, size 11223957504, type 0x83)'
[  181.339835] udevd[2289]: 'udisks-part-id /dev/sdc'(err) 'new part entry'
[  181.339841] udevd[2289]: 'udisks-part-id /dev/sdc'(err) 'looking at part 2 (offset 0, size 0, type 0x00)'
[  181.339852] udevd[2289]: 'udisks-part-id /dev/sdc'(err) 'new part entry'
[  181.339858] udevd[2289]: 'udisks-part-id /dev/sdc'(err) 'looking at part 3 (offset 0, size 0, type 0x00)'
[  181.339864] udevd[2289]: 'udisks-part-id /dev/sdc'(err) 'new part entry'
[  181.339869] udevd[2289]: 'udisks-part-id /dev/sdc'(err) 'Exiting MS-DOS parser'
[  181.339875] udevd[2289]: 'udisks-part-id /dev/sdc'(err) 'MSDOS partition table detected'
[  181.339931] udevd[2289]: 'udisks-part-id /dev/sdc'(out) 'UDISKS_PARTITION_TABLE=1'
[  181.339951] udevd[2289]: 'udisks-part-id /dev/sdc'(out) 'UDISKS_PARTITION_TABLE_SCHEME=mbr'
[  181.339958] udevd[2289]: 'udisks-part-id /dev/sdc'(out) 'UDISKS_PARTITION_TABLE_COUNT=2'
[  181.340528] udevd[2289]: 'udisks-part-id /dev/sdc' [2291] exit with return code 0
[  181.340729] udevd[2289]: handling device node '/dev/sdc', devnum=b8:32, mode=0660, uid=0, gid=83
[  181.340742] udevd[2289]: set permissions /dev/sdc, 060660, uid=0, gid=83
[  181.340773] udevd[2289]: creating symlink '/dev/block/8:32' to '../sdc'
[  181.340804] udevd[2289]: creating link '/dev/disk/by-id/usb-ADATA_USB_Flash_Drive_25B2521060220044-0:0' to '/dev/sdc'
[  181.340816] udevd[2289]: creating symlink '/dev/disk/by-id/usb-ADATA_USB_Flash_Drive_25B2521060220044-0:0' to '../../sdc'
[  181.340864] udevd[2289]: creating link '/dev/disk/by-path/pci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0' to '/dev/sdc'
[  181.340874] udevd[2289]: creating symlink '/dev/disk/by-path/pci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0' to '../../sdc'
[  181.341006] udevd[2289]: created db file '/run/udev/data/b8:32' for '/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc'
[  181.341022] udevd[2289]: adding watch on '/dev/sdc'
[  181.341104] udevd[2289]: created db file '/run/udev/data/b8:32' for '/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc'
[  181.341387] udevd[2289]: passed device to netlink monitor 0xae44a0
[  181.341394] udevd[2289]: seq 3200 processed
[  181.341752] udevd[597]: passed 258 byte device to netlink monitor 0xae2130
[  181.341773] udevd[597]: passed 258 byte device to netlink monitor 0xae2130
[  181.342140] udevd[2290]: seq 3202 running
[  181.342577] udevd[2289]: seq 3201 running
[  181.344183] udevd[2290]: no db file to read /run/udev/data/b8:34: No such file or directory
[  181.344945] udevd[2290]: GROUP 6 /lib/udev/rules.d/50-udev-default.rules:55
[  181.345086] udevd[2290]: LINK 'disk/by-id/usb-ADATA_USB_Flash_Drive_25B2521060220044-0:0-part2' /lib/udev/rules.d/60-persistent-storage.rules:37
[  181.345165] udevd[2290]: LINK 'disk/by-path/pci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0-part2' /lib/udev/rules.d/60-persistent-storage.rules:56
[  181.345174] udevd[2290]: IMPORT builtin 'blkid' /lib/udev/rules.d/60-persistent-storage.rules:66
[  181.345795] udevd[2290]: probe /dev/sdc2 raid offset=0
[  181.348112] udevd[2289]: no db file to read /run/udev/data/b8:33: No such file or directory
[  181.348869] udevd[2289]: GROUP 6 /lib/udev/rules.d/50-udev-default.rules:55
[  181.348987] udevd[2289]: LINK 'disk/by-id/usb-ADATA_USB_Flash_Drive_25B2521060220044-0:0-part1' /lib/udev/rules.d/60-persistent-storage.rules:37
[  181.349064] udevd[2289]: LINK 'disk/by-path/pci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0-part1' /lib/udev/rules.d/60-persistent-storage.rules:56
[  181.349073] udevd[2289]: IMPORT builtin 'blkid' /lib/udev/rules.d/60-persistent-storage.rules:66
[  181.350313] udevd[2289]: probe /dev/sdc1 raid offset=0
[  181.393994] udevd[2289]: LINK 'disk/by-uuid/F200-1CEE' /lib/udev/rules.d/60-persistent-storage.rules:69
[  181.394063] udevd[2289]: GROUP 6 /lib/udev/rules.d/65-permissions.rules:13
[  181.394108] udevd[2289]: GROUP 83 /lib/udev/rules.d/65-permissions.rules:17
[  181.394533] udevd[2289]: IMPORT 'udisks-part-id /dev/sdc1' /lib/udev/rules.d/80-udisks.rules:84
[  181.394890] udevd[2294]: starting 'udisks-part-id /dev/sdc1'
[  181.406063] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) 'using device_file=/dev/sdc syspath=/sys/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc, offset=1048576 ao=0 and number=1 for /dev/sdc1'
[  181.406988] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) 'Entering MS-DOS parser (offset=0, size=15518924800)'
[  181.407016] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) ''
[  181.407057] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) 'MSDOS_MAGIC found'
[  181.407076] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) ''
[  181.407101] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) 'looking at part 0 (offset 1048576, size 4293918720, type 0x0b)'
[  181.407119] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) ''
[  181.407138] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) 'new part entry'
[  181.407156] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) ''
[  181.407188] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) 'looking at part 1 (offset 4294967296, size 11223957504, type 0x83)'
[  181.407207] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) ''
[  181.407235] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) 'new part entry'
[  181.407701] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) ''
[  181.407739] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) 'looking at part 2 (offset 0, size 0, type 0x00)'
[  181.407757] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) ''
[  181.407776] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) 'new part entry'
[  181.407794] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) ''
[  181.407815] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) 'looking at part 3 (offset 0, size 0, type 0x00)'
[  181.407833] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) ''
[  181.407852] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) 'new part entry'
[  181.407870] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) ''
[  181.407890] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) 'Exiting MS-DOS parser'
[  181.407908] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) ''
[  181.407927] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) 'MSDOS partition table detected'
[  181.407945] udevd[2289]: 'udisks-part-id /dev/sdc1'(err) ''
[  181.408033] udevd[2289]: 'udisks-part-id /dev/sdc1'(out) 'UDISKS_PARTITION=1'
[  181.408066] udevd[2289]: 'udisks-part-id /dev/sdc1'(out) 'UDISKS_PARTITION_SCHEME=mbr'
[  181.408092] udevd[2289]: 'udisks-part-id /dev/sdc1'(out) 'UDISKS_PARTITION_NUMBER=1'
[  181.408117] udevd[2289]: 'udisks-part-id /dev/sdc1'(out) 'UDISKS_PARTITION_TYPE=0x0b'
[  181.408142] udevd[2289]: 'udisks-part-id /dev/sdc1'(out) 'UDISKS_PARTITION_SIZE=4293918720'
[  181.408167] udevd[2289]: 'udisks-part-id /dev/sdc1'(out) 'UDISKS_PARTITION_LABEL='
[  181.408192] udevd[2289]: 'udisks-part-id /dev/sdc1'(out) 'UDISKS_PARTITION_UUID='
[  181.408216] udevd[2289]: 'udisks-part-id /dev/sdc1'(out) 'UDISKS_PARTITION_FLAGS='
[  181.408983] udevd[2289]: 'udisks-part-id /dev/sdc1'(out) 'UDISKS_PARTITION_SLAVE=/sys/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc'
[  181.409014] udevd[2289]: 'udisks-part-id /dev/sdc1'(out) 'UDISKS_PARTITION_OFFSET=1048576'
[  181.409050] udevd[2289]: 'udisks-part-id /dev/sdc1'(out) 'UDISKS_PARTITION_ALIGNMENT_OFFSET=0'
[  181.409600] udevd[2289]: 'udisks-part-id /dev/sdc1' [2294] exit with return code 0
[  181.409842] udevd[2289]: handling device node '/dev/sdc1', devnum=b8:33, mode=0660, uid=0, gid=83
[  181.409852] udevd[2289]: set permissions /dev/sdc1, 060660, uid=0, gid=83
[  181.409880] udevd[2289]: creating symlink '/dev/block/8:33' to '../sdc1'
[  181.409907] udevd[2289]: creating link '/dev/disk/by-id/usb-ADATA_USB_Flash_Drive_25B2521060220044-0:0-part1' to '/dev/sdc1'
[  181.409917] udevd[2289]: creating symlink '/dev/disk/by-id/usb-ADATA_USB_Flash_Drive_25B2521060220044-0:0-part1' to '../../sdc1'
[  181.409958] udevd[2289]: creating link '/dev/disk/by-path/pci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0-part1' to '/dev/sdc1'
[  181.409967] udevd[2289]: creating symlink '/dev/disk/by-path/pci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0-part1' to '../../sdc1'
[  181.410001] udevd[2289]: creating link '/dev/disk/by-uuid/F200-1CEE' to '/dev/sdc1'
[  181.410010] udevd[2289]: creating symlink '/dev/disk/by-uuid/F200-1CEE' to '../../sdc1'
[  181.410127] udevd[2289]: created db file '/run/udev/data/b8:33' for '/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc/sdc1'
[  181.410141] udevd[2289]: adding watch on '/dev/sdc1'
[  181.410250] udevd[2289]: created db file '/run/udev/data/b8:33' for '/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc/sdc1'
[  181.410317] udevd[2289]: passed device to netlink monitor 0xae44a0
[  181.410322] udevd[2289]: seq 3201 processed
[  181.441837] udevd[2290]: LINK 'disk/by-uuid/47e5c8f0-10a8-48c6-aafd-d45598c31b6d' /lib/udev/rules.d/60-persistent-storage.rules:69
[  181.441904] udevd[2290]: GROUP 6 /lib/udev/rules.d/65-permissions.rules:13
[  181.441947] udevd[2290]: GROUP 83 /lib/udev/rules.d/65-permissions.rules:17
[  181.442109] udevd[2290]: IMPORT 'udisks-part-id /dev/sdc2' /lib/udev/rules.d/80-udisks.rules:84
[  181.442659] udevd[2297]: starting 'udisks-part-id /dev/sdc2'
[  181.460380] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) 'using device_file=/dev/sdc syspath=/sys/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc, offset=4294967296 ao=0 and number=2 for /dev/sdc2'
[  181.460667] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) 'Entering MS-DOS parser (offset=0, size=15518924800)'
[  181.460693] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) ''
[  181.460737] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) 'MSDOS_MAGIC found'
[  181.460966] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) ''
[  181.460996] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) 'looking at part 0 (offset 1048576, size 4293918720, type 0x0b)'
[  181.461015] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) ''
[  181.461034] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) 'new part entry'
[  181.461421] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) ''
[  181.461461] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) 'looking at part 1 (offset 4294967296, size 11223957504, type 0x83)'
[  181.461480] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) ''
[  181.461499] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) 'new part entry'
[  181.461517] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) ''
[  181.461539] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) 'looking at part 2 (offset 0, size 0, type 0x00)'
[  181.461558] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) ''
[  181.461576] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) 'new part entry'
[  181.461595] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) ''
[  181.461616] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) 'looking at part 3 (offset 0, size 0, type 0x00)'
[  181.461634] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) ''
[  181.461653] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) 'new part entry'
[  181.461670] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) ''
[  181.461691] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) 'Exiting MS-DOS parser'
[  181.461709] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) ''
[  181.461728] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) 'MSDOS partition table detected'
[  181.461746] udevd[2290]: 'udisks-part-id /dev/sdc2'(err) ''
[  181.464076] udevd[2290]: 'udisks-part-id /dev/sdc2'(out) 'UDISKS_PARTITION=1'
[  181.464125] udevd[2290]: 'udisks-part-id /dev/sdc2'(out) 'UDISKS_PARTITION_SCHEME=mbr'
[  181.464154] udevd[2290]: 'udisks-part-id /dev/sdc2'(out) 'UDISKS_PARTITION_NUMBER=2'
[  181.464180] udevd[2290]: 'udisks-part-id /dev/sdc2'(out) 'UDISKS_PARTITION_TYPE=0x83'
[  181.464207] udevd[2290]: 'udisks-part-id /dev/sdc2'(out) 'UDISKS_PARTITION_SIZE=11223957504'
[  181.464250] udevd[2290]: 'udisks-part-id /dev/sdc2'(out) 'UDISKS_PARTITION_LABEL='
[  181.464278] udevd[2290]: 'udisks-part-id /dev/sdc2'(out) 'UDISKS_PARTITION_UUID='
[  181.464304] udevd[2290]: 'udisks-part-id /dev/sdc2'(out) 'UDISKS_PARTITION_FLAGS=boot'
[  181.464333] udevd[2290]: 'udisks-part-id /dev/sdc2'(out) 'UDISKS_PARTITION_SLAVE=/sys/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc'
[  181.464361] udevd[2290]: 'udisks-part-id /dev/sdc2'(out) 'UDISKS_PARTITION_OFFSET=4294967296'
[  181.464391] udevd[2290]: 'udisks-part-id /dev/sdc2'(out) 'UDISKS_PARTITION_ALIGNMENT_OFFSET=0'
[  181.464779] udevd[2290]: 'udisks-part-id /dev/sdc2' [2297] exit with return code 0
[  181.465023] udevd[2290]: handling device node '/dev/sdc2', devnum=b8:34, mode=0660, uid=0, gid=83
[  181.465033] udevd[2290]: set permissions /dev/sdc2, 060660, uid=0, gid=83
[  181.465061] udevd[2290]: creating symlink '/dev/block/8:34' to '../sdc2'
[  181.465088] udevd[2290]: creating link '/dev/disk/by-id/usb-ADATA_USB_Flash_Drive_25B2521060220044-0:0-part2' to '/dev/sdc2'
[  181.465098] udevd[2290]: creating symlink '/dev/disk/by-id/usb-ADATA_USB_Flash_Drive_25B2521060220044-0:0-part2' to '../../sdc2'
[  181.465139] udevd[2290]: creating link '/dev/disk/by-path/pci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0-part2' to '/dev/sdc2'
[  181.465148] udevd[2290]: creating symlink '/dev/disk/by-path/pci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0-part2' to '../../sdc2'
[  181.465181] udevd[2290]: creating link '/dev/disk/by-uuid/47e5c8f0-10a8-48c6-aafd-d45598c31b6d' to '/dev/sdc2'
[  181.465191] udevd[2290]: creating symlink '/dev/disk/by-uuid/47e5c8f0-10a8-48c6-aafd-d45598c31b6d' to '../../sdc2'
[  181.465309] udevd[2290]: created db file '/run/udev/data/b8:34' for '/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc/sdc2'
[  181.465324] udevd[2290]: adding watch on '/dev/sdc2'
[  181.465399] udevd[2290]: created db file '/run/udev/data/b8:34' for '/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc/sdc2'
[  181.465473] udevd[2290]: passed device to netlink monitor 0xaf5ce0
[  181.465478] udevd[2290]: seq 3202 processed
[  184.470471] udevd[597]: cleanup idle workers
[  184.470553] udevd[597]: Validate module index
[  184.470829] udevd[2289]: Unload module index
[  184.470872] udevd[2290]: Unload module index
[  184.471291] udevd[597]: worker [2289] exited
[  184.471340] udevd[597]: worker [2290] exited
[  184.471420] udevd[2261]: Unload module index
[  184.471968] udevd[597]: worker [2261] exited
[  192.508736] udevd[597]: Validate module index
[  192.508816] udevd[597]: seq 3203 queued, 'change' 'block'
[  192.509046] udevd[597]: seq 3203 forked new worker [2311]
[  192.511242] udevd[2311]: seq 3203 running
[  192.513727] udevd[2311]: removing watch on '/dev/sdc'
[  192.514447] udevd[597]: seq 3204 queued, 'remove' 'block'
[  192.514582] udevd[597]: seq 3205 queued, 'remove' 'block'
[  192.514633] udevd[2311]: IMPORT builtin 'usb_id' /lib/udev/rules.d/60-persistent-storage.rules:31
[  192.514757] udevd[2311]: /sys/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0: if_class 8 protocol 6
[  192.515224] udevd[2311]: LINK 'disk/by-id/usb-ADATA_USB_Flash_Drive_25B2521060220044-0:0' /lib/udev/rules.d/60-persistent-storage.rules:36
[  192.521803] udevd[2311]: IMPORT builtin 'path_id' /lib/udev/rules.d/60-persistent-storage.rules:54
[  192.521954] udevd[2311]: LINK 'disk/by-path/pci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0' /lib/udev/rules.d/60-persistent-storage.rules:55
[  192.521965] udevd[2311]: IMPORT builtin 'blkid' /lib/udev/rules.d/60-persistent-storage.rules:66
[  192.525420] udevd[2311]: Failure opening block device /dev/sdc: No medium found
[  192.525498] udevd[2311]: GROUP 6 /lib/udev/rules.d/65-permissions.rules:13
[  192.525507] udevd[2311]: GROUP 83 /lib/udev/rules.d/65-permissions.rules:16
[  192.526826] udevd[2311]: IMPORT 'udisks-part-id /dev/sdc' /lib/udev/rules.d/80-udisks.rules:84
[  192.532851] udevd[2312]: starting 'udisks-part-id /dev/sdc'
[  192.538980] udevd[2311]: 'udisks-part-id /dev/sdc'(err) 'using device_file=/dev/sdc syspath=/sys/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc, offset=0 ao=0 and number=0 for /dev/sdc'
[  192.539760] udevd[2311]: 'udisks-part-id /dev/sdc'(err) 'Error opening /dev/sdc: No medium found'
[  192.540125] udevd[2311]: 'udisks-part-id /dev/sdc' [2312] exit with return code 0
[  192.540302] udevd[2311]: handling device node '/dev/sdc', devnum=b8:32, mode=0660, uid=0, gid=83
[  192.540312] udevd[2311]: preserve permissions /dev/sdc, 060660, uid=0, gid=83
[  192.540333] udevd[2311]: preserve already existing symlink '/dev/block/8:32' to '../sdc'
[  192.540366] udevd[2311]: found 'b8:32' claiming '/run/udev/links/\x2fdisk\x2fby-id\x2fusb-ADATA_USB_Flash_Drive_25B2521060220044-0:0'
[  192.540377] udevd[2311]: creating link '/dev/disk/by-id/usb-ADATA_USB_Flash_Drive_25B2521060220044-0:0' to '/dev/sdc'
[  192.540390] udevd[2311]: preserve already existing symlink '/dev/disk/by-id/usb-ADATA_USB_Flash_Drive_25B2521060220044-0:0' to '../../sdc'
[  192.540420] udevd[2311]: found 'b8:32' claiming '/run/udev/links/\x2fdisk\x2fby-path\x2fpci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0'
[  192.540429] udevd[2311]: creating link '/dev/disk/by-path/pci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0' to '/dev/sdc'
[  192.540440] udevd[2311]: preserve already existing symlink '/dev/disk/by-path/pci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0' to '../../sdc'
[  192.540520] udevd[2311]: created db file '/run/udev/data/b8:32' for '/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc'
[  192.540540] udevd[2311]: adding watch on '/dev/sdc'
[  192.540623] udevd[2311]: created db file '/run/udev/data/b8:32' for '/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc'
[  192.540685] udevd[2311]: passed device to netlink monitor 0xae8a40
[  192.540691] udevd[2311]: seq 3203 processed
[  192.543612] udevd[597]: passed 261 byte device to netlink monitor 0xae2130
[  192.543847] udevd[597]: seq 3205 forked new worker [2313]
[  192.545561] udevd[2311]: seq 3204 running
[  192.545708] udevd[2311]: removing watch on '/dev/sdc1'
[  192.546207] udevd[2311]: no reference left, remove '/dev/disk/by-id/usb-ADATA_USB_Flash_Drive_25B2521060220044-0:0-part1'
[  192.546264] udevd[2311]: no reference left, remove '/dev/disk/by-path/pci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0-part1'
[  192.546290] udevd[2311]: no reference left, remove '/dev/disk/by-uuid/F200-1CEE'
[  192.546369] udevd[2311]: passed device to netlink monitor 0xae8a40
[  192.546376] udevd[2311]: seq 3204 processed
[  192.548629] udevd[2313]: seq 3205 running
[  192.548788] udevd[2313]: removing watch on '/dev/sdc2'
[  192.552831] udevd[2313]: no reference left, remove '/dev/disk/by-id/usb-ADATA_USB_Flash_Drive_25B2521060220044-0:0-part2'
[  192.552873] udevd[2313]: no reference left, remove '/dev/disk/by-path/pci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0-part2'
[  192.552899] udevd[2313]: no reference left, remove '/dev/disk/by-uuid/47e5c8f0-10a8-48c6-aafd-d45598c31b6d'
[  192.555590] udevd[2313]: passed device to netlink monitor 0xaeb310
[  192.555603] udevd[2313]: seq 3205 processed
[  195.310805] udevd[597]: seq 3206 queued, 'remove' 'bsg'
[  195.310961] udevd[597]: passed 246 byte device to netlink monitor 0xae2130
[  195.311102] udevd[597]: seq 3207 queued, 'remove' 'scsi_device'
[  195.311182] udevd[597]: passed 219 byte device to netlink monitor 0xae2130
[  195.311255] udevd[597]: seq 3208 queued, 'remove' 'scsi_disk'
[  195.311698] udevd[597]: seq 3208 forked new worker [2315]
[  195.311796] udevd[2313]: seq 3206 running
[  195.312444] udevd[2313]: passed device to netlink monitor 0xaeb310
[  195.312454] udevd[2313]: seq 3206 processed
[  195.312543] udevd[2311]: seq 3207 running
[  195.312590] udevd[2311]: no db file to read /run/udev/data/+scsi_device:9:0:0:0: No such file or directory
[  195.313199] udevd[2311]: passed device to netlink monitor 0xae8a40
[  195.313211] udevd[2311]: seq 3207 processed
[  195.313760] udevd[2315]: seq 3208 running
[  195.313902] udevd[2315]: no db file to read /run/udev/data/+scsi_disk:9:0:0:0: No such file or directory
[  195.314589] udevd[2315]: passed device to netlink monitor 0xaf35b0
[  195.314601] udevd[2315]: seq 3208 processed
[  195.316654] udevd[597]: seq 3209 queued, 'remove' 'block'
[  195.316710] udevd[597]: passed 250 byte device to netlink monitor 0xae2130
[  195.317160] udevd[2315]: seq 3209 running
[  195.317343] udevd[2315]: removing watch on '/dev/sdc'
[  195.318074] udevd[2315]: no reference left, remove '/dev/disk/by-id/usb-ADATA_USB_Flash_Drive_25B2521060220044-0:0'
[  195.318165] udevd[2315]: no reference left, remove '/dev/disk/by-path/pci-0000:00:14.0-usb-0:2:1.0-scsi-0:0:0:0'
[  195.319033] udevd[2315]: passed device to netlink monitor 0xaf35b0
[  195.319048] udevd[2315]: seq 3209 processed
[  195.321146] udevd[597]: seq 3210 queued, 'remove' 'scsi'
[  195.321189] udevd[597]: passed 233 byte device to netlink monitor 0xae2130
[  195.321391] udevd[2315]: seq 3210 running
[  195.321437] udevd[2315]: no db file to read /run/udev/data/+scsi:9:0:0:0: No such file or directory
[  195.322568] udevd[2315]: passed device to netlink monitor 0xaf35b0
[  195.322618] udevd[2315]: seq 3210 processed
[  195.324052] udevd[597]: seq 3211 queued, 'remove' 'bdi'
[  195.324156] udevd[597]: passed 141 byte device to netlink monitor 0xae2130
[  195.324208] udevd[2315]: seq 3211 running
[  195.324251] udevd[597]: seq 3212 queued, 'remove' 'scsi'
[  195.324263] udevd[2315]: no db file to read /run/udev/data/+bdi:8:32: No such file or directory
[  195.324279] udevd[597]: passed 204 byte device to netlink monitor 0xae2130
[  195.324509] udevd[2313]: seq 3212 running
[  195.324519] udevd[2315]: passed device to netlink monitor 0xaf35b0
[  195.324529] udevd[2315]: seq 3211 processed
[  195.324549] udevd[2313]: no db file to read /run/udev/data/+scsi:target9:0:0: No such file or directory
[  195.324962] udevd[2313]: passed device to netlink monitor 0xaeb310
[  195.324972] udevd[2313]: seq 3212 processed
[  195.337157] udevd[597]: seq 3213 queued, 'remove' 'scsi_host'
[  195.337287] udevd[597]: passed 193 byte device to netlink monitor 0xae2130
[  195.337403] udevd[597]: seq 3214 queued, 'remove' 'scsi'
[  195.338366] udevd[597]: seq 3215 queued, 'remove' 'usb'
[  195.338454] udevd[597]: seq 3216 queued, 'remove' 'usb'
[  195.338502] udevd[2315]: seq 3213 running
[  195.338552] udevd[2315]: no db file to read /run/udev/data/+scsi_host:host9: No such file or directory
[  195.339749] udevd[2315]: passed device to netlink monitor 0xaf35b0
[  195.339763] udevd[2315]: seq 3213 processed
[  195.339873] udevd[597]: passed 190 byte device to netlink monitor 0xae2130
[  195.340384] udevd[2315]: seq 3214 running
[  195.340435] udevd[2315]: no db file to read /run/udev/data/+scsi:host9: No such file or directory
[  195.341159] udevd[2315]: passed device to netlink monitor 0xaf35b0
[  195.341170] udevd[2315]: seq 3214 processed
[  195.341256] udevd[597]: passed 297 byte device to netlink monitor 0xae2130
[  195.341866] udevd[2315]: seq 3215 running
[  195.342952] udevd[2315]: passed device to netlink monitor 0xaf35b0
[  195.342962] udevd[2315]: seq 3215 processed
[  195.343044] udevd[597]: passed 281 byte device to netlink monitor 0xae2130
[  195.343379] udevd[2315]: seq 3216 running
[  195.356321] udevd[2315]: passed device to netlink monitor 0xaf35b0
[  195.356329] udevd[2315]: seq 3216 processed
[  198.360090] udevd[597]: cleanup idle workers
[  198.360212] udevd[597]: Validate module index
[  198.360435] udevd[2315]: Unload module index
[  198.360485] udevd[2311]: Unload module index
[  198.361128] udevd[2313]: Unload module index
[  198.361452] udevd[597]: worker [2311] exited
[  198.361492] udevd[597]: worker [2313] exited
[  198.361512] udevd[597]: worker [2315] exited

[linux-4.4.221]$ udevadm monitor
monitor will print the received events for:                                                                                            
UDEV - the event which udev sends out after rule processing                                                                            
KERNEL - the kernel uevent                                                                                                             
                                                                                                                                       
KERNEL[179.968349] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2 (usb)                                                            
KERNEL[179.971025] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0 (usb)                                                    
KERNEL[179.971803] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9 (scsi)                                             
KERNEL[179.971845] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/scsi_host/host9 (scsi_host)                        
UDEV  [180.007808] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2 (usb)                                                            
UDEV  [180.014520] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0 (usb)                                                    
UDEV  [180.015556] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9 (scsi)                                             
UDEV  [180.016946] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/scsi_host/host9 (scsi_host)                        
KERNEL[181.235551] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0 (scsi)                                 
KERNEL[181.235643] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0 (scsi)                         
KERNEL[181.235693] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/scsi_disk/9:0:0:0 (scsi_disk)  
KERNEL[181.235859] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/scsi_device/9:0:0:0 (scsi_devic
e)                                                                                                                                     
KERNEL[181.237516] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/bsg/9:0:0:0 (bsg)              
UDEV  [181.237558] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0 (scsi)                                 
UDEV  [181.239223] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0 (scsi)                         
UDEV  [181.241877] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/scsi_disk/9:0:0:0 (scsi_disk)  
KERNEL[181.245467] add      /devices/virtual/bdi/8:32 (bdi)                                                                            
UDEV  [181.245520] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/bsg/9:0:0:0 (bsg)              
UDEV  [181.246144] add      /devices/virtual/bdi/8:32 (bdi)                                                                            
UDEV  [181.246733] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/scsi_device/9:0:0:0 (scsi_device)                                                                                                                                     
KERNEL[181.252544] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc (block)              
KERNEL[181.252618] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc/sdc1 (block)         
KERNEL[181.252665] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc/sdc2 (block)         
UDEV  [181.324316] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc (block)
UDEV  [181.393395] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc/sdc1 (block)
UDEV  [181.448493] add      /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc/sdc2 (block)
KERNEL[192.491802] change   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc (block)
KERNEL[192.495169] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc/sdc1 (block)
UDEV  [192.535497] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc/sdc2 (block)
KERNEL[195.292684] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/bsg/9:0:0:0 (bsg)
KERNEL[195.292758] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/scsi_device/9:0:0:0 (scsi_device)
KERNEL[195.292803] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/scsi_disk/9:0:0:0 (scsi_disk)
UDEV  [195.297493] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/bsg/9:0:0:0 (bsg)
UDEV  [195.297551] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/scsi_device/9:0:0:0 (scsi_device)
UDEV  [195.297583] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/scsi_disk/9:0:0:0 (scsi_disk)
KERNEL[195.298954] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc (block)
UDEV  [195.300748] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0/block/sdc (block)
KERNEL[195.302153] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0 (scsi)
UDEV  [195.304384] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0/9:0:0:0 (scsi)
KERNEL[195.306367] remove   /devices/virtual/bdi/8:32 (bdi)
KERNEL[195.306431] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0 (scsi)
UDEV  [195.306823] remove   /devices/virtual/bdi/8:32 (bdi)
UDEV  [195.307661] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/target9:0:0 (scsi)
KERNEL[195.319442] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/scsi_host/host9 (scsi_host)
KERNEL[195.319509] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9 (scsi)
KERNEL[195.320220] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0 (usb)
KERNEL[195.320662] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2 (usb)
UDEV  [195.322037] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9/scsi_host/host9 (scsi_host)
UDEV  [195.323158] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0/host9 (scsi)
UDEV  [195.324609] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2:1.0 (usb)
UDEV  [195.338750] remove   /devices/pci0000:00/0000:00:14.0/usb2/2-2 (usb)


[linux-4.4.221]$ lsblk | grep sdc
sdc      8:32   1  14.5G  0 disk 
|-sdc1   8:33   1     4G  0 part /run/media/dioput/F200-1CEE
`-sdc2   8:34   1  10.5G  0 part

[-- Attachment #3: linux-5.4.39-compilation_log.txt --]
[-- Type: text/plain, Size: 6454 bytes --]

$ sudo dmesg | grep -i udev
...<snip>...
[  355.780264] udevd[659]: Validate module index
[  355.780607] udevd[659]: seq 4158 queued, 'add' 'usb'
[  355.781220] udevd[659]: seq 4158 forked new worker [2436]
[  355.782401] udevd[2436]: seq 4158 running
[  355.782729] udevd[2436]: no db file to read /run/udev/data/c189:257: No such file or directory
[  355.782856] udevd[2436]: IMPORT builtin 'usb_id' /lib/udev/rules.d/40-libgphoto2.rules:9
[  355.783937] udevd[659]: seq 4159 queued, 'add' 'usb'
[  355.784125] udevd[659]: seq 4160 queued, 'bind' 'usb'
[  355.784754] udevd[2436]: IMPORT builtin skip 'usb_id' /lib/udev/rules.d/50-udev-default.rules:13
[  355.784765] udevd[2436]: IMPORT builtin 'hwdb' /lib/udev/rules.d/50-udev-default.rules:13
[  365.648261] udevd[659]: Validate module index
[  365.648410] udevd[659]: seq 4178 queued, 'remove' 'bsg'
[  365.648901] udevd[659]: seq 4178 forked new worker [2454]
[  365.649301] udevd[659]: seq 4179 queued, 'remove' 'scsi_device'
[  365.649724] udevd[659]: seq 4179 forked new worker [2455]
[  365.649941] udevd[659]: seq 4180 queued, 'remove' 'scsi_disk'
[  365.649951] udevd[2454]: seq 4178 running
[  365.650385] udevd[659]: seq 4180 forked new worker [2456]
[  365.651134] udevd[2455]: seq 4179 running
[  365.651236] udevd[2455]: no db file to read /run/udev/data/+scsi_device:5:0:0:0: No such file or directory

$ udevadm monitor
monitor will print the received events for:                                                                                            
UDEV - the event which udev sends out after rule processing                                                                            
KERNEL - the kernel uevent                                                                                                             
                                                                                                                                       
KERNEL[355.829048] add      /devices/pci0000:00/0000:00:14.0/usb3/3-2 (usb)                                                            
KERNEL[355.832118] add      /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0 (usb)                                                    
KERNEL[355.832388] bind     /devices/pci0000:00/0000:00:14.0/usb3/3-2 (usb)                                                            
KERNEL[355.919912] add      /module/usb_storage (module)                                                                               
KERNEL[355.921133] add      /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5 (scsi)                                             
KERNEL[355.921180] add      /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/scsi_host/host5 (scsi_host)                        
KERNEL[355.922414] bind     /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0 (usb)
KERNEL[355.922461] add      /bus/usb/drivers/usb-storage (drivers)                                                                     
KERNEL[355.933664] add      /module/uas (module)                                                                                       
KERNEL[355.933968] add      /bus/usb/drivers/uas (drivers)                                                                             
KERNEL[357.206092] add      /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0 (scsi)
KERNEL[357.206156] add      /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0 (scsi)
KERNEL[357.206183] add      /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0/scsi_device/5:0:0:0 (scsi_device)                               
KERNEL[357.206933] add      /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0/scsi_disk/5:0:0:0 (scsi_disk)
KERNEL[357.207906] add      /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0/bsg/5:0:0:0 (bsg)
KERNEL[357.215925] add      /devices/virtual/bdi/8:32 (bdi)                                                                            
KERNEL[357.220995] add      /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0/block/sdc (block)
KERNEL[357.221049] add      /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0/block/sdc/sdc1 (block)
KERNEL[357.221078] add      /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0/block/sdc/sdc2 (block)
KERNEL[357.223736] bind     /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0 (scsi)
KERNEL[365.696363] remove   /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0/bsg/5:0:0:0 (bsg)
KERNEL[365.696523] remove   /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0/scsi_device/5:0:0:0 (scsi_device)                               
KERNEL[365.696989] remove   /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0/scsi_disk/5:0:0:0 (scsi_disk)
KERNEL[365.703826] change   /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0/block/sdc (block)
KERNEL[365.704161] remove   /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0/block/sdc/sdc2 (block)
KERNEL[365.704284] remove   /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0/block/sdc/sdc1 (block)
KERNEL[365.704740] remove   /devices/virtual/bdi/8:32 (bdi)
KERNEL[365.704873] remove   /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0/block/sdc (block)
KERNEL[365.712037] unbind   /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0 (scsi)
KERNEL[365.712094] remove   /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0/5:0:0:0 (scsi)
KERNEL[365.728351] remove   /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/target5:0:0 (scsi)
KERNEL[365.728419] remove   /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5/scsi_host/host5 (scsi_host)
KERNEL[365.728446] remove   /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0/host5 (scsi)
KERNEL[365.737169] unbind   /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0 (usb)
KERNEL[365.737264] remove   /devices/pci0000:00/0000:00:14.0/usb3/3-2/3-2:1.0 (usb)
KERNEL[365.737881] unbind   /devices/pci0000:00/0000:00:14.0/usb3/3-2 (usb)
KERNEL[365.737940] remove   /devices/pci0000:00/0000:00:14.0/usb3/3-2 (usb)

$ lsblk | grep sdc
sdc      8:32   1  14.5G  0 disk 
|-sdc1   8:33   1     4G  0 part
`-sdc2   8:34   1  10.5G  0 part

  reply	other threads:[~2020-05-10  9:48 UTC|newest]

Thread overview: 10+ messages / expand[flat|nested]  mbox.gz  Atom feed  top
2020-05-10  2:55 USB Attached SCSI breakage due no udev involvement Dio Putra
2020-05-10  5:47 ` Greg KH
2020-05-10  6:48   ` Dio Putra
2020-05-10  6:54     ` Greg KH
2020-05-10  7:10       ` Dio Putra
2020-05-10  7:32         ` Greg KH
2020-05-10  8:35           ` Dio Putra
2020-05-10  8:48             ` Greg KH
2020-05-10  9:48               ` Dio Putra [this message]
2020-05-10 13:15                 ` Dio Putra

Reply instructions:

You may reply publicly to this message via plain-text email
using any one of the following methods:

* Save the following mbox file, import it into your mail client,
  and reply-to-all from there: mbox

  Avoid top-posting and favor interleaved quoting:
  https://en.wikipedia.org/wiki/Posting_style#Interleaved_style

* Reply using the --to, --cc, and --in-reply-to
  switches of git-send-email(1):

  git send-email \
    --in-reply-to=80d4f4d9-91be-b7e8-1f64-13c2fe74f496@gmail.com \
    --to=dioput12@gmail.com \
    --cc=gregkh@linuxfoundation.org \
    --cc=linux-kernel@vger.kernel.org \
    --cc=linux-scsi@vger.kernel.org \
    --cc=linux-usb@vger.kernel.org \
    --cc=oneukum@suse.com \
    --cc=stern@rowland.harvard.edu \
    --cc=usb-storage@lists.one-eyed-alien.net \
    /path/to/YOUR_REPLY

  https://kernel.org/pub/software/scm/git/docs/git-send-email.html

* If your mail client supports setting the In-Reply-To header
  via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line before the message body.
This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.