Sunday, 2 May 2021

Copy photos from phone to laptop, mtp device "mount" failed, solution: install gmtp?(why?)

... wherein we trawl the logs try find root cause and ... fail. :-P

But it was hopefully somewhat educational.


Once upon a time ...

Plug in phone to laptop (to transfer photos).

Files(nautilus) in ubuntu showed "EVA L09" device,

But Files(nautilus) dialog window popped up and showed an error "unhandled error message: The name 1.1630 was not provided by any .service files" after "Allow access to files on device" was clicked on phone.

Recent upgrade to ubuntu 20.04.
mtp was working fine before upgrade.
My phone is a HuaweiP9.
We google for similar problems. 
Similar error message to what I see mentioned here: https://askubuntu.com/questions/721483/how-to-fix-unable-to-open-mtp-device-usb004-010-in-ubuntu-1v

To try and fix it I install mtp-tools then gmtp.

Using gmtp directly doesn't seem to work.

Quit and restart Files(nautilus).

"EVA L09" device shows up and after Allow access I can browse files inside, transfer photos, delete.

Later on, thinking a simple turn it off then on again solution might have worked. Reboot. The install and messing might have resulted in the restart of something that resulted in things starting to work? 


More detail

When the phone is plugged into USB in Files(nautilus) the device "EVA L09" appears and a "My CDROM" device also appears as if a different sector of the USB device is being mounted as a CD.

When the  "Allow access to files on device" is clicked on phone the devices "FLICK".
They disappear and .. reappear one by one.
At this stage the error popped up (when it was happening).

The "My CDROM" stuff is a bit annoying but seems fine.
 

WHY did installing gmtp work (if it was that that was the solution(which is unclear))?

EXECUTIVE SUMMARY/TLDR: I don't know. 
There are various gnome-shell crashes and a libgvfscommon.so general protection fault. And later a "usb 1-2: reset high-speed USB device" message before it starts working.
Maybe that install or the several plug-ins and outs OR crash and restart eventually restarted something (gvfsd?) cleanly and things started working.

General Exploration:

https://askubuntu.com/questions/146529/how-to-connect-mtp-devices-via-usb

https://bugs.launchpad.net/ubuntu/+source/gvfs/+bug/1792085

dmesg - nothing much


syslog - yes - LOTS of stuff in syslog:

There were several attempts to plug in phone - error. Unplug.

Connect again - error. Fiddle.

Swap cables, plug in again.

Eventually device connects ok, file transfer & cleanup.

Finally a civilised unmount of device in Files(nautilus).

Later unplug cable.


syslog - Things seen:  ... see below comments among log  ... 

Plug in. 

usb 1-2: new high-speed USB device number 8 using xhci_hcd

gvfsd[1069625]: Error 1: Get Storage information failed.

dbus-daemon[2409]: [session uid=1000 pid=2409] Activating service name='org.gnome.Shell.HotplugSniffer' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")

kernel: [563724.004226] scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2

udisksd[1070]: Mounted /dev/sr1 at /media/james/My CDROM on behalf of uid 1000

dbus-daemon[1315]: [session uid=124 pid=1315] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.1' (uid=124 pid=1309 comm="/usr/libexec/tracker-miner-fs " label="unconfined")


Disconnect and reconnect happens probably when the Allow access is selected

usb 1-2: USB disconnect, device number 8

Error cleaning up mount point /media/james/My CDROM

gvfsd[1069625]: PTP: reading event an error 0x05 occurred

tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed

usb 1-2: new high-speed USB device number 9 using xhci_hcd

scsi host2: usb-storage 1-2:1.1

tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed

colord[1142]: CdMain: failed to emit DeviceAdded: failed to register object: An object is already exported for the interface org.freedesktop.ColorManager.Device at /org/freedesktop/ColorManager/devices/sysfs__null_

Power-on or device reset occurred

udisksd[1070]: Mounted /dev/sr1 at /media/james/My CDROM on behalf of uid 1000


?

JS ERROR: TypeError from gnome-shell]


Several gnome-shell crashes. Related to USB disconnect/unmounting/.. 

automountManager.js:190 and g_volume_mount_finish: assertion 'G_IS_VOLUME (volume)' failed

gnome-shell[3057]: Object .Gjs_components_autorunManager_AutorunSource (0x55ebe8543e40), has been already deallocated and 4 messageTray.js stack traces and 
gnome-shell[3057]: Object Gio.Settings (0x55ebed0242b0), has been already deallocated  and
messageTray.js:887 and g_object_run_dispose: assertion 'G_IS_OBJECT (object)' failed

colord[1142]: CdMain: failed to emit DeviceAdded: failed to register object: An object is already exported for the interface org.freedesktop.ColorManager.Device at /org/freedesktop/ColorManager/devices/sysfs__null_
.
kernel: [564152.944382] usb 1-2: USB disconnect, device number 13
gvfsd[1072375]: PTP: reading event an error 0x05 occurred
gvfsd-mtp[1072375]: invalid unclassed pointer in cast to 'GVfsBackend'
 DITTO/similar
kernel: [564152.990514] traps: pool[1072384] general protection fault ip:7f49d289ccd8 sp:7f49caffca88 error:0 in libgvfscommon.so[7f49d2887000+1a000]
tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
systemd[1]: Starting Process error reports when automatic reporting is enabled...
gvfsd[1071306]: Device 0 (VID=12d1 and PID=107e) is a Huawei P9 Plus.
.
.
gvfsd[1073421]: Error 1: Get Storage information failed.
whoopsie-upload-all[1072398]: Collecting info for /var/crash/_usr_libexec_gvfsd-mtp.1000.crash...


nautilus restart, and THIS: May  2 12:06:59 pog kernel: [564463.099766] usb 1-2: reset high-speed USB device number 17 using xhci_hcd


syslog - Explorations/Suppositions/Conclusions:

My CDROM device stuff, dismount errors - just some part of hotplug devices

Why only one crash seen? When there were a few plug ins/allow access .. and unmount/plug out.

MAYBE rebooting would have worked!! ??  (probably because gvfsd would restart)

Maybe just restarting Files(nautilus)

What is this tracker-store hotplug stuff?

"tracker-store is part of tracker, a program that scans certain specified locations on your hard drive (and other places like your emails) and indexes the contents into a database. This allows you to do fast file contents searches. Whereas, tracker-miner-* are programs that scan data and tracker-store is the program that stores the metadata in a database for fast access later."

https://unix.stackexchange.com/questions/482390/usr-lib-tracker-tracker-store-causes-very-heavy-cpu-load-on-debian-buster



less /var/log/syslog |grep -C30 -iE "mtp|usb|huaw|phone|raw" |sanitize |less

Initial usb plug-in connect of phone: 

May  2 11:54:39 pog kernel: [563722.803519] usb 1-2: new high-speed USB device number 8 using xhci_hcd

May  2 11:54:39 pog kernel: [563722.957145] usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99

May  2 11:54:39 pog kernel: [563722.957148] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3

May  2 11:54:39 pog kernel: [563722.957150] usb 1-2: Product: EVA-L09

May  2 11:54:39 pog kernel: [563722.957151] usb 1-2: Manufacturer: HUAWEI

May  2 11:54:39 pog kernel: [563722.957153] usb 1-2: SerialNumber: MWS0216A31001549

May  2 11:54:39 pog kernel: [563722.983033] usb-storage 1-2:1.1: USB Mass Storage device detected

May  2 11:54:39 pog kernel: [563722.986397] scsi host2: usb-storage 1-2:1.1

May  2 11:54:39 pog kernel: [563722.986720] usbcore: registered new interface driver usb-storage

May  2 11:54:39 pog colord[1142]: CdMain: failed to emit DeviceAdded: failed to register object: An object is already exported for the interface org.freedesktop.ColorManager.Device at /org/freedesktop/ColorManager/devices/sysfs__null_

May  2 11:54:39 pog kernel: [563722.988474] usbcore: registered new interface driver uas

May  2 11:54:39 pog gvfsd[1069625]: Error 1: Get Storage information failed.

May  2 11:54:39 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating service name='org.gnome.Shell.HotplugSniffer' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")

May  2 11:54:39 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.gnome.Shell.HotplugSniffer'

May  2 11:54:40 pog kernel: [563724.004226] scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2

May  2 11:54:40 pog kernel: [563724.004834] sr 2:0:0:0: Power-on or device reset occurred

May  2 11:54:40 pog kernel: [563724.005372] sr 2:0:0:0: [sr1] scsi-1 drive

May  2 11:54:40 pog kernel: [563724.035623] sr 2:0:0:0: Attached scsi CD-ROM sr1

May  2 11:54:40 pog kernel: [563724.035703] sr 2:0:0:0: Attached scsi generic sg2 type 5

May  2 11:54:40 pog kernel: [563724.219613] ISO 9660 Extensions: Microsoft Joliet Level 1

May  2 11:54:40 pog kernel: [563724.222463] ISOFS: changing to secondary root

May  2 11:54:40 pog systemd[1]: Created slice system-clean\x2dmount\x2dpoint.slice.

May  2 11:54:40 pog systemd[1]: Finished Clean the /media/james/My CDROM mount point.

May  2 11:54:40 pog udisksd[1070]: Mounted /dev/sr1 at /media/james/My CDROM on behalf of uid 1000

May  2 11:54:40 pog dbus-daemon[1315]: [session uid=124 pid=1315] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.1' (uid=124 pid=1309 comm="/usr/libexec/tracker-miner-fs " label="unconfined")

May  2 11:54:40 pog systemd[1298]: Starting Tracker metadata database store and lookup manager...

May  2 11:54:40 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.2' (uid=1000 pid=2405 comm="/usr/libexec/tracker-miner-fs " label="unconfined")

May  2 11:54:40 pog systemd[2384]: Starting Tracker metadata database store and lookup manager...

May  2 11:54:40 pog dbus-daemon[1315]: [session uid=124 pid=1315] Successfully activated service 'org.freedesktop.Tracker1'

May  2 11:54:40 pog systemd[1298]: Started Tracker metadata database store and lookup manager.

May  2 11:54:40 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.freedesktop.Tracker1'

May  2 11:54:40 pog systemd[2384]: Started Tracker metadata database store and lookup manager.


Disconnect and reconnect happens probably when the Allow access is selected

May  2 11:54:43 pog kernel: [563726.871311] usb 1-2: USB disconnect, device number 8

May  2 11:54:43 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)

May  2 11:54:43 pog systemd[1]: Unmounting /media/james/My CDROM...

May  2 11:54:43 pog systemd[1298]: media-james-My\x20CDROM.mount: Succeeded.

May  2 11:54:43 pog systemd[2384]: media-james-My\x20CDROM.mount: Succeeded.

May  2 11:54:43 pog systemd[1]: media-james-My\x20CDROM.mount: Succeeded.

May  2 11:54:43 pog systemd[1]: Unmounted /media/james/My CDROM.

May  2 11:54:43 pog udisksd[1070]: Error cleaning up mount point /media/james/My CDROM: Error unmounting: Command-line `umount -l '/media/james/My CDROM'' exited with non-zero exit status 32: umount: /media/james/My CDROM: not mounted.

May  2 11:54:43 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)

May  2 11:54:43 pog systemd[1]: Stopping Clean the /media/james/My CDROM mount point...

May  2 11:54:43 pog systemd[1]: clean-mount-point@media-james-My\x20CDROM.service: Succeeded.

May  2 11:54:43 pog systemd[1]: Stopped Clean the /media/james/My CDROM mount point.

May  2 11:54:43 pog nautilus[7672]: Failed to measure available space: Error getting filesystem info for /media/james/My CDROM: No such file or directory

May  2 11:54:43 pog nautilus[7672]: Failed to measure available space: Error getting filesystem info for /media/james/My CDROM: No such file or directory

May  2 11:54:43 pog gvfsd[1069625]: PTP: reading event an error 0x05 occurred

May  2 11:54:43 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed

May  2 11:54:43 pog kernel: [563727.379555] usb 1-2: new high-speed USB device number 9 using xhci_hcd

May  2 11:54:43 pog kernel: [563727.528900] usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99

May  2 11:54:43 pog kernel: [563727.528903] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3

May  2 11:54:43 pog kernel: [563727.528905] usb 1-2: Product: EVA-L09

May  2 11:54:43 pog kernel: [563727.528906] usb 1-2: Manufacturer: HUAWEI

May  2 11:54:43 pog kernel: [563727.528907] usb 1-2: SerialNumber: MWS0216A31001549

May  2 11:54:43 pog kernel: [563727.532715] usb-storage 1-2:1.1: USB Mass Storage device detected

May  2 11:54:43 pog kernel: [563727.532991] scsi host2: usb-storage 1-2:1.1

May  2 11:54:43 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed

May  2 11:54:43 pog colord[1142]: CdMain: failed to emit DeviceAdded: failed to register object: An object is already exported for the interface org.freedesktop.ColorManager.Device at /org/freedesktop/ColorManager/devices/sysfs__null_

May  2 11:54:44 pog gvfsd[1069625]: Device 0 (VID=12d1 and PID=107e) is a Huawei P9 Plus.

May  2 11:54:44 pog gvfsd[1069625]: Android device detected, assigning default bug flags

May  2 11:54:44 pog gvfsd[1069625]: Received event PTP_EC_DevicePropChanged in session 1

May  2 11:54:44 pog kernel: [563728.544565] scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2

May  2 11:54:44 pog kernel: [563728.545244] sr 2:0:0:0: Power-on or device reset occurred

May  2 11:54:44 pog kernel: [563728.545899] sr 2:0:0:0: [sr1] scsi-1 drive

May  2 11:54:44 pog kernel: [563728.563909] sr 2:0:0:0: Attached scsi CD-ROM sr1

May  2 11:54:44 pog kernel: [563728.564101] sr 2:0:0:0: Attached scsi generic sg2 type 5

May  2 11:54:44 pog kernel: [563728.726944] ISO 9660 Extensions: Microsoft Joliet Level 1

May  2 11:54:44 pog kernel: [563728.727117] ISOFS: changing to secondary root

May  2 11:54:45 pog systemd[1]: Finished Clean the /media/james/My CDROM mount point.

May  2 11:54:45 pog udisksd[1070]: Mounted /dev/sr1 at /media/james/My CDROM on behalf of uid 1000


Shotwell photo manager started . . or does something . . 

May  2 11:55:11 pog dbus-daemon[1021]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4530' (uid=1000 pid=1069226 comm="shotwell " label="unconfined")
May  2 11:55:11 pog systemd[1]: Starting Hostname Service...
May  2 11:55:11 pog dbus-daemon[1021]: [system] Successfully activated service 'org.freedesktop.hostname1'
May  2 11:55:11 pog systemd[1]: Started Hostname Service.
May  2 11:55:14 pog tracker-store[1069683]: OK
May  2 11:55:14 pog systemd[1298]: tracker-store.service: Succeeded.
May  2 11:55:15 pog tracker-store[1069687]: OK
May  2 11:55:15 pog systemd[2384]: tracker-store.service: Succeeded.
May  2 11:55:41 pog systemd[1]: systemd-hostnamed.service: Succeeded.

May  2 11:55:52 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.2' (uid=1000 pid=2405 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 11:55:52 pog systemd[2384]: Starting Tracker metadata database store and lookup manager...
May  2 11:55:52 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.freedesktop.Tracker1'
May  2 11:55:52 pog systemd[2384]: Started Tracker metadata database store and lookup manager.
May  2 11:55:52 pog gvfsd-mtp[1069729]: attempting to add an interface (GLoadableIcon) to class (GVfsIcon) after class_init
May  2 11:55:52 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating via systemd: service name='org.freedesktop.Tracker1.Miner.Extract' unit='tracker-extract.service' requested by ':1.2' (uid=1000 pid=2405 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 11:55:52 pog systemd[2384]: Starting Tracker metadata extractor...
May  2 11:55:52 pog tracker-extract[1069960]: Set scheduler policy to SCHED_IDLE
May  2 11:55:52 pog tracker-extract[1069960]: Setting priority nice level to 19
May  2 11:55:52 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.freedesktop.Tracker1.Miner.Extract'
May  2 11:55:52 pog systemd[2384]: Started Tracker metadata extractor.
May  2 11:55:52 pog tracker-extract[1069960]: Warning: using insecure memory!

May  2 11:55:59 pog nautilus[7672]: Called "net usershare info" but it failed: Failed to execute child process “net” (No such file or directory)

May  2 11:56:13 pog gnome-shell[3057]: JS ERROR: TypeError: this._workspacesViews[i] is undefined#012_syncWorkspacesActualGeometry@resource:///org/gnome/shell/ui/workspacesView.js:782:13#012_updateWorkspacesActualGeometry@resource:///org/gnome/shell/ui/workspacesView.js:772:14#012vfunc_allocate@resource:///org/gnome/shell/ui/overviewControls.js:401:15#012_computeWindowCenter@resource:///org/gnome/shell/ui/workspace.js:302:35#012_init@resource:///org/gnome/shell/ui/workspace.js:160:14#012_addWindowClone@resource:///org/gnome/shell/ui/workspace.js:1856:21#012_init@resource:///org/gnome/shell/ui/workspace.js:1174:22#012_updateWorkspaces@resource:///org/gnome/shell/ui/workspacesView.js:232:29#012_init@resource:///org/gnome/shell/ui/workspacesView.js:91:14#012_updateWorkspacesViews@resource:///org/gnome/shell/ui/workspacesView.js:686:24#012show@resource:///org/gnome/shell/ui/workspacesView.js:613:14#012show@resource:///org/gnome/shell/ui/viewSelector.js:276:33#012_animateVisible@resource:///org/gnome/shell/ui/overview.js:580:27#012show@resource:///org/gnome/shell/ui/overview.js:566:14#012toggle@resource:///org/gnome/shell/ui/overview.js:689:18#012_initializeUI/<@resource:///org/gnome/shell/ui/main.js:223:22
May  2 11:56:13 pog gnome-shell[3057]: JS ERROR: TypeError: this._workspacesViews[i] is undefined#012_syncWorkspacesFullGeometry@resource:///org/gnome/shell/ui/workspacesView.js:762:13#012setWorkspacesFullGeometry@resource:///org/gnome/shell/ui/workspacesView.js:752:14#012setWorkspacesFullGeometry@resource:///org/gnome/shell/ui/viewSelector.js:301:33#012_updateWorkspacesGeometry@resource:///org/gnome/shell/ui/overviewControls.js:498:27#012vfunc_allocate@resource:///org/gnome/shell/ui/overviewControls.js:402:14#012_computeWindowCenter@resource:///org/gnome/shell/ui/workspace.js:302:35#012_init@resource:///org/gnome/shell/ui/workspace.js:160:14#012_addWindowClone@resource:///org/gnome/shell/ui/workspace.js:1856:21#012_init@resource:///org/gnome/shell/ui/workspace.js:1174:22#012_updateWorkspaces@resource:///org/gnome/shell/ui/workspacesView.js:232:29#012_init@resource:///org/gnome/shell/ui/workspacesView.js:91:14#012_updateWorkspacesViews@resource:///org/gnome/shell/ui/workspacesView.js:686:24#012show@resource:///org/gnome/shell/ui/workspacesView.js:613:14#012show@resource:///org/gnome/shell/ui/viewSelector.js:276:33#012_animateVisible@resource:///org/gnome/shell/ui/overview.js:580:27#012show@resource:///org/gnome/shell/ui/overview.js:566:14#012toggle@resource:///org/gnome/shell/ui/overview.js:689:18#012_initializeUI/<@resource:///org/gnome/shell/ui/main.js:223:22

May  2 11:56:17 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating service name='org.gnome.ControlCenter.SearchProvider' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")
May  2 11:56:17 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating service name='org.gnome.Calculator.SearchProvider' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")
May  2 11:56:17 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating service name='org.gnome.Characters.BackgroundService' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")
May  2 11:56:17 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating via systemd: service name='org.gnome.Terminal' unit='gnome-terminal-server.service' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")
May  2 11:56:17 pog systemd[2384]: Starting GNOME Terminal Server...
May  2 11:56:17 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.gnome.ControlCenter.SearchProvider'
May  2 11:56:17 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.gnome.Characters.BackgroundService'
May  2 11:56:17 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.gnome.Calculator.SearchProvider'
May  2 11:56:17 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.gnome.Terminal'
May  2 11:56:17 pog systemd[2384]: Started GNOME Terminal Server.

[chomp *WiFi funny stuff*, ath, more JS ERROR: TypeError from gnome-shell]
--
May  2 11:58:49 pog systemd[2384]: gnome-launched-shotwell.desktop-1069226.scope: Succeeded.
--
May  2 11:58:58 pog systemd[2384]: Started GNOME Terminal Server.
--

Unplug, maybe:

May  2 11:59:07 pog kernel: [563991.368972] usb 1-2: USB disconnect, device number 9
May  2 11:59:07 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 11:59:07 pog systemd[1]: Unmounting /media/james/My CDROM...
May  2 11:59:07 pog systemd[2384]: media-james-My\x20CDROM.mount: Succeeded.
May  2 11:59:07 pog systemd[1298]: media-james-My\x20CDROM.mount: Succeeded.
May  2 11:59:07 pog systemd[1]: media-james-My\x20CDROM.mount: Succeeded.
May  2 11:59:07 pog systemd[1]: Unmounted /media/james/My CDROM.
May  2 11:59:07 pog systemd[1]: Stopping Clean the /media/james/My CDROM mount point...
May  2 11:59:07 pog systemd[1]: clean-mount-point@media-james-My\x20CDROM.service: Succeeded.
May  2 11:59:07 pog udisksd[1070]: Error cleaning up mount point /media/james/My CDROM: Error unmounting: Command-line `umount -l '/media/james/My CDROM'' exited with non-zero exit status 32: umount: /media/james/My CDROM: not mounted.
May  2 11:59:07 pog udisksd[1070]: mountpoint /media/james/My CDROM is invalid, cannot recover the canonical path 
May  2 11:59:07 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 11:59:07 pog systemd[1]: Stopped Clean the /media/james/My CDROM mount point.
May  2 11:59:07 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.2' (uid=1000 pid=2405 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 11:59:07 pog systemd[2384]: Starting Tracker metadata database store and lookup manager...
May  2 11:59:07 pog dbus-daemon[1315]: [session uid=124 pid=1315] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.1' (uid=124 pid=1309 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 11:59:07 pog systemd[1298]: Starting Tracker metadata database store and lookup manager...
May  2 11:59:07 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.freedesktop.Tracker1'
May  2 11:59:07 pog systemd[2384]: Started Tracker metadata database store and lookup manager.
May  2 11:59:07 pog dbus-daemon[1315]: [session uid=124 pid=1315] Successfully activated service 'org.freedesktop.Tracker1'
May  2 11:59:07 pog systemd[1298]: Started Tracker metadata database store and lookup manager.
May  2 11:59:07 pog gvfsd[1069729]: PTP: reading event an error 0x05 occurred
May  2 11:59:07 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed

Allow access maybe ? probably ?

May  2 11:59:08 pog kernel: [563991.767526] usb 1-2: new high-speed USB device number 10 using xhci_hcd
May  2 11:59:08 pog kernel: [563991.920439] usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 11:59:08 pog kernel: [563991.920443] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 11:59:08 pog kernel: [563991.920446] usb 1-2: Product: EVA-L09
May  2 11:59:08 pog kernel: [563991.920448] usb 1-2: Manufacturer: HUAWEI
May  2 11:59:08 pog kernel: [563991.920450] usb 1-2: SerialNumber: MWS0216A31001549
May  2 11:59:08 pog kernel: [563991.924352] usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 11:59:08 pog kernel: [563991.924717] scsi host2: usb-storage 1-2:1.1
May  2 11:59:07 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 11:59:08 pog colord[1142]: CdMain: failed to emit DeviceAdded: failed to register object: An object is already exported for the interface org.freedesktop.ColorManager.Device at /org/freedesktop/ColorManager/devices/sysfs__null_
May  2 11:59:08 pog kernel: [563991.953164] usb 1-2: USB disconnect, device number 10
May  2 11:59:08 pog gnome-shell[3057]: Object .GProxyVolume (0x55ebec57cef0), has been already deallocated — impossible to access it. This might be caused by the object having been destroyed from C code using something such as destroy(), dispose(), or remove() vfuncs.
May  2 11:59:08 pog gnome-shell[3057]: == Stack trace for context 0x55ebdaab3900 ==
May  2 11:59:08 pog gnome-shell[3057]: #0   55ebece45688 i   resource:///org/gnome/shell/ui/components/automountManager.js:190 (3fb79a007808 @ 38)
May  2 11:59:08 pog gnome-shell[3057]: #1   7fff83c657a0 b   self-hosted:1011 (10835a23088 @ 454)
May  2 11:59:08 pog gnome-shell[3057]: g_volume_mount_finish: assertion 'G_IS_VOLUME (volume)' failed
May  2 11:59:08 pog systemd[2384]: gnome-terminal-server.service: Succeeded.

May  2 11:59:09 pog gvfsd[1069729]: Device 0 (VID=12d1 and PID=107e) is a Huawei P9 Plus.
May  2 11:59:09 pog gvfsd[1069729]: Android device detected, assigning default bug flags
May  2 11:59:09 pog gvfsd[1069729]: Received event PTP_EC_DevicePropChanged in session 1
May  2 11:59:12 pog kernel: [563995.951507] usb 1-2: new high-speed USB device number 11 using xhci_hcd
May  2 11:59:12 pog kernel: [563996.100780] usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 11:59:12 pog kernel: [563996.100783] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 11:59:12 pog kernel: [563996.100784] usb 1-2: Product: EVA-L09
May  2 11:59:12 pog kernel: [563996.100786] usb 1-2: Manufacturer: HUAWEI
May  2 11:59:12 pog kernel: [563996.100787] usb 1-2: SerialNumber: MWS0216A31001549
May  2 11:59:12 pog kernel: [563996.104305] usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 11:59:12 pog kernel: [563996.104705] scsi host2: usb-storage 1-2:1.1
May  2 11:59:12 pog colord[1142]: CdMain: failed to emit DeviceAdded: failed to register object: An object is already exported for the interface org.freedesktop.ColorManager.Device at /org/freedesktop/ColorManager/devices/sysfs__null_
May  2 11:59:12 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating service name='org.gnome.Shell.HotplugSniffer' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")
May  2 11:59:12 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.gnome.Shell.HotplugSniffer'
May  2 11:59:13 pog kernel: [563997.120332] scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 11:59:13 pog kernel: [563997.123954] sr 2:0:0:0: Power-on or device reset occurred
May  2 11:59:13 pog kernel: [563997.125583] sr 2:0:0:0: [sr1] scsi-1 drive
May  2 11:59:13 pog kernel: [563997.152051] sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 11:59:13 pog kernel: [563997.152260] sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 11:59:13 pog kernel: [563997.491366] ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 11:59:13 pog kernel: [563997.491819] ISOFS: changing to secondary root
May  2 11:59:13 pog systemd[1]: Finished Clean the /media/james/My CDROM mount point.
May  2 11:59:13 pog udisksd[1070]: Mounted /dev/sr1 at /media/james/My CDROM on behalf of uid 1000


May  2 11:59:16 pog kernel: [564000.315587] mce: CPU2: Package temperature above threshold, cpu clock throttled (total events = 1155421)
[chomp similar]
clock throttled (total events = 1155420)
May  2 11:59:16 pog kernel: [564000.348607] mce: CPU5: Core temperature/speed normal
May  2 11:59:16 pog kernel: [564000.348609] mce: CPU1: Core temperature/speed normal


May  2 11:59:17 pog kernel: [564001.332531] usb 1-2: USB disconnect, device number 11
May  2 11:59:17 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 11:59:17 pog systemd[1]: Unmounting /media/james/My CDROM...
May  2 11:59:17 pog systemd[1298]: media-james-My\x20CDROM.mount: Succeeded.
May  2 11:59:17 pog systemd[2384]: media-james-My\x20CDROM.mount: Succeeded.
May  2 11:59:17 pog udisksd[1070]: Error cleaning up mount point /media/james/My CDROM: Error unmounting: Command-line `umount -l '/media/james/My CDROM'' exited with non-zero exit status 32: umount: /media/james/My CDROM: not mounted.
May  2 11:59:17 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 11:59:17 pog gvfsd[1071188]: PTP: reading event an error 0x05 occurred
May  2 11:59:17 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 11:59:17 pog systemd[1]: media-james-My\x20CDROM.mount: Succeeded.
May  2 11:59:17 pog systemd[1]: Unmounted /media/james/My CDROM.
May  2 11:59:17 pog systemd[1]: Stopping Clean the /media/james/My CDROM mount point...
May  2 11:59:17 pog systemd[1]: clean-mount-point@media-james-My\x20CDROM.service: Succeeded.
May  2 11:59:17 pog systemd[1]: Stopped Clean the /media/james/My CDROM mount point.

May  2 11:59:18 pog kernel: [564001.807531] usb 1-2: new high-speed USB device number 12 using xhci_hcd
May  2 11:59:18 pog kernel: [564001.961275] usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 11:59:18 pog kernel: [564001.961279] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 11:59:18 pog kernel: [564001.961281] usb 1-2: Product: EVA-L09
May  2 11:59:18 pog kernel: [564001.961282] usb 1-2: Manufacturer: HUAWEI
May  2 11:59:18 pog kernel: [564001.961283] usb 1-2: SerialNumber: MWS0216A31001549
May  2 11:59:18 pog kernel: [564001.965625] usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 11:59:18 pog kernel: [564001.965857] scsi host2: usb-storage 1-2:1.1
May  2 11:59:18 pog colord[1142]: CdMain: failed to emit DeviceAdded: failed to register object: An object is already exported for the interface org.freedesktop.ColorManager.Device at /org/freedesktop/ColorManager/devices/sysfs__null_
May  2 11:59:18 pog gvfsd[1071188]: Device 0 (VID=12d1 and PID=107e) is a Huawei P9 Plus.
May  2 11:59:18 pog gvfsd[1071188]: Android device detected, assigning default bug flags
May  2 11:59:19 pog kernel: [564002.976168] scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 11:59:19 pog kernel: [564002.976701] sr 2:0:0:0: Power-on or device reset occurred
May  2 11:59:19 pog kernel: [564002.977118] sr 2:0:0:0: [sr1] scsi-1 drive
May  2 11:59:19 pog kernel: [564003.020062] sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 11:59:19 pog kernel: [564003.020303] sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 11:59:19 pog kernel: [564003.193468] ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 11:59:19 pog kernel: [564003.193669] ISOFS: changing to secondary root
May  2 11:59:19 pog systemd[1]: Finished Clean the /media/james/My CDROM mount point.
May  2 11:59:19 pog udisksd[1070]: Mounted /dev/sr1 at /media/james/My CDROM on behalf of uid 1000
May  2 11:59:22 pog dbus-daemon[1021]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.126' (uid=1000 pid=7672 comm="/usr/bin/nautilus --gapplication-service " label="unconfined")
May  2 11:59:22 pog systemd[1]: Starting Hostname Service...
May  2 11:59:23 pog dbus-daemon[1021]: [system] Successfully activated service 'org.freedesktop.hostname1'
May  2 11:59:23 pog systemd[1]: Started Hostname Service.
May  2 11:59:49 pog tracker-store[1071133]: OK
May  2 11:59:49 pog systemd[2384]: tracker-store.service: Succeeded.
May  2 11:59:49 pog tracker-store[1071137]: OK
May  2 11:59:49 pog systemd[1298]: tracker-store.service: Succeeded.

[chomp 2 * JS ERROR and wifi/networkManager stuff + 1 more JS ERROR]

May  2 12:01:35 pog dbus-daemon[1021]: [system] Activating via systemd: service name='org.freedesktop.PackageKit' unit='packagekit.service' requested by ':1.4545' (uid=0 pid=1072121 comm="/usr/bin/gdbus call --system --dest org.freedeskto" label="unconfined")
May  2 12:01:35 pog systemd[1]: Starting PackageKit Daemon...
May  2 12:01:35 pog PackageKit: daemon start
May  2 12:01:35 pog dbus-daemon[1021]: [system] Successfully activated service 'org.freedesktop.PackageKit'
May  2 12:01:35 pog systemd[1]: Started PackageKit Daemon.

May  2 12:01:48 pog kernel: [564152.080478] usb 1-2: USB disconnect, device number 12
May  2 12:01:48 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 12:01:48 pog systemd[1]: Unmounting /media/james/My CDROM...
May  2 12:01:48 pog systemd[2384]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:01:48 pog gvfsd[1071306]: PTP: reading event an error 0x05 occurred
May  2 12:01:48 pog systemd[1298]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:01:48 pog udisksd[1070]: Error cleaning up mount point /media/james/My CDROM: Error unmounting: Command-line `umount -l '/media/james/My CDROM'' exited with non-zero exit status 32: umount: /media/james/My CDROM: not mounted.
May  2 12:01:48 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 12:01:48 pog gnome-shell[3057]: Object .Gjs_components_autorunManager_AutorunSource (0x55ebe8543e40), has been already deallocated — impossible to emit any signal on it. This might be caused by the object having been destroyed from C code using something such as destroy(), dispose(), or remove() vfuncs.
May  2 12:01:48 pog gnome-shell[3057]: == Stack trace for context 0x55ebdaab3900 ==
May  2 12:01:48 pog gnome-shell[3057]: #0   55ebedb0d168 i   resource:///org/gnome/shell/ui/messageTray.js:884 (26ac46a7a3d0 @ 155)
May  2 12:01:48 pog gnome-shell[3057]: #1   55ebedb0d0b0 i   resource:///org/gnome/shell/ui/components/autorunManager.js:271 (2031b1e76808 @ 69)
May  2 12:01:48 pog gnome-shell[3057]: #2   55ebedb0d018 i   resource:///org/gnome/shell/ui/components/autorunManager.js:177 (2031b1e764c0 @ 25)
May  2 12:01:48 pog gnome-shell[3057]: #3   7fff83c652c0 b   self-hosted:1011 (10835a23088 @ 454)
May  2 12:01:48 pog gnome-shell[3057]: == Stack trace for context 0x55ebdaab3900 ==
May  2 12:01:48 pog gnome-shell[3057]: #0   55ebedb0d218 i   resource:///org/gnome/shell/ui/messageTray.js:249 (26ac46a775b0 @ 22)
May  2 12:01:48 pog gnome-shell[3057]: #1   55ebedb0d168 i   resource:///org/gnome/shell/ui/messageTray.js:886 (26ac46a7a3d0 @ 175)
May  2 12:01:48 pog gnome-shell[3057]: #2   55ebedb0d0b0 i   resource:///org/gnome/shell/ui/components/autorunManager.js:271 (2031b1e76808 @ 69)
May  2 12:01:48 pog gnome-shell[3057]: #3   55ebedb0d018 i   resource:///org/gnome/shell/ui/components/autorunManager.js:177 (2031b1e764c0 @ 25)
May  2 12:01:48 pog gnome-shell[3057]: #4   7fff83c652c0 b   self-hosted:1011 (10835a23088 @ 454)
May  2 12:01:48 pog gnome-shell[3057]: == Stack trace for context 0x55ebdaab3900 ==
May  2 12:01:48 pog gnome-shell[3057]: #0   55ebedb0d218 i   resource:///org/gnome/shell/ui/messageTray.js:250 (26ac46a775b0 @ 42)
May  2 12:01:48 pog gnome-shell[3057]: #1   55ebedb0d168 i   resource:///org/gnome/shell/ui/messageTray.js:886 (26ac46a7a3d0 @ 175)
May  2 12:01:48 pog gnome-shell[3057]: #2   55ebedb0d0b0 i   resource:///org/gnome/shell/ui/components/autorunManager.js:271 (2031b1e76808 @ 69)
May  2 12:01:48 pog gnome-shell[3057]: #3   55ebedb0d018 i   resource:///org/gnome/shell/ui/components/autorunManager.js:177 (2031b1e764c0 @ 25)
May  2 12:01:48 pog gnome-shell[3057]: #4   7fff83c652c0 b   self-hosted:1011 (10835a23088 @ 454)
May  2 12:01:48 pog gnome-shell[3057]: == Stack trace for context 0x55ebdaab3900 ==
May  2 12:01:48 pog gnome-shell[3057]: #0   55ebedb0d2b0 i   resource:///org/gnome/shell/ui/messageTray.js:162 (26ac46a6fe98 @ 17)
May  2 12:01:48 pog gnome-shell[3057]: #1   55ebedb0d218 i   resource:///org/gnome/shell/ui/messageTray.js:252 (26ac46a775b0 @ 59)
May  2 12:01:48 pog gnome-shell[3057]: #2   55ebedb0d168 i   resource:///org/gnome/shell/ui/messageTray.js:886 (26ac46a7a3d0 @ 175)
May  2 12:01:48 pog gnome-shell[3057]: #3   55ebedb0d0b0 i   resource:///org/gnome/shell/ui/components/autorunManager.js:271 (2031b1e76808 @ 69)
--
May  2 12:01:48 pog gnome-shell[3057]: == Stack trace for context 0x55ebdaab3900 ==
May  2 12:01:48 pog gnome-shell[3057]: Object Gio.Settings (0x55ebed0242b0), has been already deallocated — impossible to access it. This might be caused by the object having been destroyed from C code using something such as destroy(), dispose(), or remove() vfuncs.
May  2 12:01:48 pog gnome-shell[3057]: #0   55ebedb0d168 i   resource:///org/gnome/shell/ui/messageTray.js:887 (26ac46a7a3d0 @ 190)
May  2 12:01:48 pog gnome-shell[3057]: #1   55ebedb0d0b0 i   resource:///org/gnome/shell/ui/components/autorunManager.js:271 (2031b1e76808 @ 69)
May  2 12:01:48 pog gnome-shell[3057]: #2   55ebedb0d018 i   resource:///org/gnome/shell/ui/components/autorunManager.js:177 (2031b1e764c0 @ 25)
May  2 12:01:48 pog gnome-shell[3057]: #3   7fff83c652c0 b   self-hosted:1011 (10835a23088 @ 454)
May  2 12:01:48 pog gnome-shell[3057]: g_object_run_dispose: assertion 'G_IS_OBJECT (object)' failed
May  2 12:01:48 pog gnome-shell[3057]: Object Gio.Settings (0x55ebf06014d0), has been already deallocated — impossible to access it. This might be caused by the object having been destroyed from C code using something such as destroy(), dispose(), or remove() vfuncs.
May  2 12:01:48 pog gnome-shell[3057]: g_object_run_dispose: assertion 'G_IS_OBJECT (object)' failed
May  2 12:01:48 pog gnome-shell[3057]: Object .Gjs_ui_messageTray_NotificationApplicationPolicy (0x55ebe8543e00), has been already deallocated — impossible to access it. This might be caused by the object having been destroyed from C code using something such as destroy(), dispose(), or remove() vfuncs.
May  2 12:01:48 pog gnome-shell[3057]: g_object_run_dispose: assertion 'G_IS_OBJECT (object)' failed
May  2 12:01:48 pog gnome-shell[3057]: Object .Gjs_components_autorunManager_AutorunSource (0x55ebe8543e40), has been already deallocated — impossible to access it. This might be caused by the object having been destroyed from C code using something such as destroy(), dispose(), or remove() vfuncs.
May  2 12:01:48 pog gnome-shell[3057]: g_object_run_dispose: assertion 'G_IS_OBJECT (object)' failed
May  2 12:01:48 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:01:48 pog tracker-miner-f[2405]: g_str_has_prefix: assertion 'str != NULL' failed
May  2 12:01:48 pog dbus-daemon[1315]: [session uid=124 pid=1315] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.1' (uid=124 pid=1309 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 12:01:48 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:01:48 pog tracker-miner-f[2405]: g_str_has_prefix: assertion 'str != NULL' failed
May  2 12:01:48 pog systemd[1298]: Starting Tracker metadata database store and lookup manager...
May  2 12:01:48 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.2' (uid=1000 pid=2405 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 12:01:48 pog systemd[2384]: Starting Tracker metadata database store and lookup manager...
May  2 12:01:48 pog dbus-daemon[1315]: [session uid=124 pid=1315] Successfully activated service 'org.freedesktop.Tracker1'
May  2 12:01:48 pog systemd[1298]: Started Tracker metadata database store and lookup manager.
May  2 12:01:48 pog systemd[1]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:01:48 pog systemd[1]: Unmounted /media/james/My CDROM.
May  2 12:01:48 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.freedesktop.Tracker1'
May  2 12:01:48 pog systemd[2384]: Started Tracker metadata database store and lookup manager.
May  2 12:01:48 pog systemd[1]: Stopping Clean the /media/james/My CDROM mount point...
May  2 12:01:48 pog systemd[1]: clean-mount-point@media-james-My\x20CDROM.service: Succeeded.
May  2 12:01:48 pog systemd[1]: Stopped Clean the /media/james/My CDROM mount point.


May  2 12:01:48 pog kernel: [564152.383554] usb 1-2: new high-speed USB device number 13 using xhci_hcd
May  2 12:01:48 pog kernel: [564152.536865] usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 12:01:48 pog kernel: [564152.536869] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 12:01:48 pog kernel: [564152.536870] usb 1-2: Product: EVA-L09
May  2 12:01:48 pog kernel: [564152.536872] usb 1-2: Manufacturer: HUAWEI
May  2 12:01:48 pog kernel: [564152.536873] usb 1-2: SerialNumber: MWS0216A31001549
May  2 12:01:48 pog kernel: [564152.540689] usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 12:01:48 pog kernel: [564152.540929] scsi host2: usb-storage 1-2:1.1
May  2 12:01:48 pog colord[1142]: CdMain: failed to emit DeviceAdded: failed to register object: An object is already exported for the interface org.freedesktop.ColorManager.Device at /org/freedesktop/ColorManager/devices/sysfs__null_
May  2 12:01:48 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating service name='org.gnome.Shell.HotplugSniffer' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")
May  2 12:01:48 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.gnome.Shell.HotplugSniffer'
May  2 12:01:49 pog kernel: [564152.944382] usb 1-2: USB disconnect, device number 13
May  2 12:01:49 pog gvfsd[1072375]: PTP: reading event an error 0x05 occurred
May  2 12:01:49 pog gvfsd-mtp[1072375]: invalid unclassed pointer in cast to 'GVfsBackend'
May  2 12:01:49 pog gvfsd-mtp[1072375]: invalid unclassed pointer in cast to 'GVfsBackendMtp'
May  2 12:01:49 pog gvfsd-mtp[1072375]: invalid unclassed pointer in cast to 'GVfsBackend'
May  2 12:01:49 pog gvfsd-mtp[1072375]: invalid unclassed pointer in cast to 'GVfsBackendMtp'
May  2 12:01:49 pog gvfsd-mtp[1072375]: invalid unclassed pointer in cast to 'GVfsBackend'
May  2 12:01:49 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:01:49 pog gvfsd-mtp[1072375]: invalid unclassed pointer in cast to 'GVfsBackendMtp'
May  2 12:01:49 pog gvfsd-mtp[1072375]: invalid unclassed pointer in cast to 'GVfsBackend'
May  2 12:01:49 pog gvfsd-mtp[1072375]: invalid unclassed pointer in cast to 'GVfsBackendMtp'
May  2 12:01:49 pog gvfsd-mtp[1072375]: invalid unclassed pointer in cast to 'GVfsBackend'
May  2 12:01:49 pog kernel: [564152.990514] traps: pool[1072384] general protection fault ip:7f49d289ccd8 sp:7f49caffca88 error:0 in libgvfscommon.so[7f49d2887000+1a000]
May  2 12:01:49 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:01:49 pog systemd[1]: Starting Process error reports when automatic reporting is enabled...
May  2 12:01:49 pog gvfsd[1071306]: Device 0 (VID=12d1 and PID=107e) is a Huawei P9 Plus.
May  2 12:01:49 pog gvfsd[1071306]: Android device detected, assigning default bug flags
May  2 12:01:49 pog gvfsd[1071306]: Received event PTP_EC_DevicePropChanged in session 1

May  2 12:01:54 pog kernel: [564158.567488] usb 1-2: new high-speed USB device number 14 using xhci_hcd
May  2 12:01:54 pog kernel: [564158.716311] usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 12:01:54 pog kernel: [564158.716314] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 12:01:54 pog kernel: [564158.716316] usb 1-2: Product: EVA-L09
May  2 12:01:54 pog kernel: [564158.716317] usb 1-2: Manufacturer: HUAWEI
May  2 12:01:54 pog kernel: [564158.716319] usb 1-2: SerialNumber: MWS0216A31001549
May  2 12:01:54 pog kernel: [564158.719836] usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 12:01:54 pog kernel: [564158.720156] scsi host2: usb-storage 1-2:1.1
May  2 12:01:49 pog gvfsd[1071306]: Received event PTP_EC_DevicePropChanged in session 1
May  2 12:01:54 pog colord[1142]: CdMain: failed to emit DeviceAdded: failed to register object: An object is already exported for the interface org.freedesktop.ColorManager.Device at /org/freedesktop/ColorManager/devices/sysfs__null_
May  2 12:01:55 pog gvfsd[1073421]: Error 1: Get Storage information failed.
May  2 12:01:55 pog whoopsie-upload-all[1072398]: Collecting info for /var/crash/_usr_libexec_gvfsd-mtp.1000.crash...
May  2 12:01:55 pog whoopsie-upload-all[1072398]: Marking /var/crash/_usr_libexec_gvfsd-mtp.1000.crash for whoopsie upload
May  2 12:01:55 pog whoopsie-upload-all[1072398]: /var/crash/_usr_bin_guvcview.1000.crash already marked for upload, skipping
May  2 12:01:55 pog whoopsie-upload-all[1072398]: /var/crash/_opt_zoom_zoom.1000.crash already marked for upload, skipping
May  2 12:01:55 pog whoopsie-upload-all[1072398]: /var/crash/_opt_google_chrome_chrome.1000.crash already marked for upload, skipping
May  2 12:01:55 pog whoopsie-upload-all[1072398]: /var/crash/_usr_lib_systemd_systemd-udevd.0.crash already marked for upload, skipping
May  2 12:01:55 pog whoopsie-upload-all[1072398]: All reports processed
May  2 12:01:55 pog systemd[1]: apport-autoreport.service: Succeeded.
May  2 12:01:55 pog systemd[1]: Finished Process error reports when automatic reporting is enabled.
May  2 12:01:55 pog whoopsie[2155]: [12:01:55] Parsing /var/crash/_usr_libexec_gvfsd-mtp.1000.crash.
May  2 12:01:55 pog whoopsie[2155]: [12:01:55] Uploading /var/crash/_usr_libexec_gvfsd-mtp.1000.crash.
May  2 12:01:56 pog kernel: [564159.744362] scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 12:01:56 pog kernel: [564159.744875] sr 2:0:0:0: Power-on or device reset occurred
May  2 12:01:56 pog kernel: [564159.745437] sr 2:0:0:0: [sr1] scsi-1 drive
May  2 12:01:56 pog kernel: [564159.771999] sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 12:01:56 pog kernel: [564159.772181] sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 12:01:56 pog kernel: [564159.966353] ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 12:01:56 pog kernel: [564159.966532] ISOFS: changing to secondary root
May  2 12:01:56 pog systemd[1]: Finished Clean the /media/james/My CDROM mount point.
May  2 12:01:56 pog udisksd[1070]: Mounted /dev/sr1 at /media/james/My CDROM on behalf of uid 1000
May  2 12:01:56 pog whoopsie[2155]: [12:01:56] Sent; server replied with: No error
May  2 12:01:56 pog whoopsie[2155]: [12:01:56] Response code: 200
May  2 12:01:56 pog whoopsie[2155]: [12:01:56] Reported OOPS ID cf1bc77a-ab35-11eb-a153-fa163e983629
May  2 12:01:56 pog systemd[1]: Starting Process error reports when automatic reporting is enabled...
May  2 12:01:56 pog whoopsie-upload-all[1073491]: /var/crash/_usr_libexec_gvfsd-mtp.1000.crash already marked for upload, skipping
May  2 12:01:56 pog whoopsie-upload-all[1073491]: /var/crash/_usr_bin_guvcview.1000.crash already marked for upload, skipping
May  2 12:01:56 pog whoopsie-upload-all[1073491]: /var/crash/_opt_zoom_zoom.1000.crash already marked for upload, skipping
May  2 12:01:56 pog whoopsie-upload-all[1073491]: /var/crash/_opt_google_chrome_chrome.1000.crash already marked for upload, skipping
May  2 12:01:56 pog whoopsie-upload-all[1073491]: /var/crash/_usr_lib_systemd_systemd-udevd.0.crash already marked for upload, skipping
May  2 12:01:56 pog whoopsie-upload-all[1073491]: All reports processed
May  2 12:01:56 pog systemd[1]: apport-autoreport.service: Succeeded.
May  2 12:01:56 pog systemd[1]: Finished Process error reports when automatic reporting is enabled.


May  2 12:02:12 pog kernel: [564176.730316] usb 1-2: USB disconnect, device number 14
May  2 12:02:12 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 12:02:13 pog systemd[1]: Unmounting /media/james/My CDROM...
May  2 12:02:13 pog systemd[1298]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:02:13 pog systemd[2384]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:02:13 pog systemd[1]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:02:13 pog systemd[1]: Unmounted /media/james/My CDROM.
May  2 12:02:13 pog systemd[1]: Stopping Clean the /media/james/My CDROM mount point...
May  2 12:02:13 pog systemd[1]: clean-mount-point@media-james-My\x20CDROM.service: Succeeded.
May  2 12:02:13 pog systemd[1]: Stopped Clean the /media/james/My CDROM mount point.
May  2 12:02:13 pog udisksd[1070]: Error cleaning up mount point /media/james/My CDROM: Error unmounting: Command-line `umount -l '/media/james/My CDROM'' exited with non-zero exit status 32: umount: /media/james/My CDROM: no mount point specified.
May  2 12:02:13 pog udisksd[1070]: mountpoint /media/james/My CDROM is invalid, cannot recover the canonical path 
May  2 12:02:13 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 12:02:13 pog gvfsd[1073421]: PTP: reading event an error 0x05 occurred
May  2 12:02:13 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed

May  2 12:02:13 pog kernel: [564177.231521] usb 1-2: new high-speed USB device number 15 using xhci_hcd
May  2 12:02:13 pog kernel: [564177.380738] usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 12:02:13 pog kernel: [564177.380741] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 12:02:13 pog kernel: [564177.380743] usb 1-2: Product: EVA-L09
May  2 12:02:13 pog kernel: [564177.380744] usb 1-2: Manufacturer: HUAWEI
May  2 12:02:13 pog kernel: [564177.380745] usb 1-2: SerialNumber: MWS0216A31001549
May  2 12:02:13 pog kernel: [564177.384086] usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 12:02:13 pog kernel: [564177.384497] scsi host2: usb-storage 1-2:1.1
May  2 12:02:13 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:02:13 pog colord[1142]: CdMain: failed to emit DeviceAdded: failed to register object: An object is already exported for the interface org.freedesktop.ColorManager.Device at /org/freedesktop/ColorManager/devices/sysfs__null_
May  2 12:02:13 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating service name='org.gnome.Shell.HotplugSniffer' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")
May  2 12:02:13 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.gnome.Shell.HotplugSniffer'
May  2 12:02:14 pog gvfsd[1073421]: Device 0 (VID=12d1 and PID=107e) is a Huawei P9 Plus.
May  2 12:02:14 pog gvfsd[1073421]: Android device detected, assigning default bug flags
May  2 12:02:14 pog gvfsd[1073421]: Received event PTP_EC_DevicePropChanged in session 1
May  2 12:02:14 pog kernel: [564178.399781] scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 12:02:14 pog kernel: [564178.400085] sr 2:0:0:0: Power-on or device reset occurred
May  2 12:02:14 pog kernel: [564178.400432] sr 2:0:0:0: [sr1] scsi-1 drive
May  2 12:02:14 pog kernel: [564178.423564] sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 12:02:14 pog kernel: [564178.423638] sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 12:02:14 pog kernel: [564178.581593] ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 12:02:14 pog kernel: [564178.581789] ISOFS: changing to secondary root
May  2 12:02:14 pog systemd[1]: Finished Clean the /media/james/My CDROM mount point.
May  2 12:02:14 pog udisksd[1070]: Mounted /dev/sr1 at /media/james/My CDROM on behalf of uid 1000
May  2 12:02:36 pog kernel: [564200.349701] mce: CPU3: Core temperature above threshold, cpu clock throttled (total events = 580427)
May  2 12:02:36 pog kernel: [564200.349703] mce: CPU7: Core temperature above threshold, cpu clock throttled (total events = 580427)
May  2 12:02:36 pog kernel: [564200.350649] mce: CPU3: Core temperature/speed normal
May  2 12:02:36 pog kernel: [564200.350653] mce: CPU7: Core temperature/speed normal
May  2 12:02:44 pog tracker-store[1072344]: OK
May  2 12:02:44 pog systemd[1298]: tracker-store.service: Succeeded.
May  2 12:02:45 pog tracker-store[1072346]: OK
May  2 12:02:45 pog systemd[2384]: tracker-store.service: Succeeded.

May  2 12:03:41 pog gnome-shell[3057]: JS ERROR: TypeError: yaddah yaddah

May  2 12:03:47 pog dbus-daemon[1315]: [session uid=124 pid=1315] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.1' (uid=124 pid=1309 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 12:03:47 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.2' (uid=1000 pid=2405 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 12:03:47 pog systemd[1298]: Starting Tracker metadata database store and lookup manager...
May  2 12:03:47 pog systemd[2384]: Starting Tracker metadata database store and lookup manager...
May  2 12:03:47 pog dbus-daemon[1315]: [session uid=124 pid=1315] Successfully activated service 'org.freedesktop.Tracker1'
May  2 12:03:47 pog systemd[1298]: Started Tracker metadata database store and lookup manager.
May  2 12:03:47 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.freedesktop.Tracker1'
May  2 12:03:47 pog systemd[2384]: Started Tracker metadata database store and lookup manager.
May  2 12:03:47 pog dbus-daemon[1315]: [session uid=124 pid=1315] Activating via systemd: service name='org.freedesktop.Tracker1.Miner.Extract' unit='tracker-extract.service' requested by ':1.1' (uid=124 pid=1309 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 12:03:47 pog systemd[1298]: Starting Tracker metadata extractor...
--

May  2 12:04:19 pog tracker-store[1074027]: OK
May  2 12:04:19 pog systemd[2384]: tracker-store.service: Succeeded.
May  2 12:04:19 pog tracker-store[1074026]: OK
May  2 12:04:19 pog systemd[1298]: tracker-store.service: Succeeded.
May  2 12:04:47 pog gnome-shell[3057]: JS ERROR: TypeError: yaddah yaddah yaddah ....
--

May  2 12:05:24 pog kernel: [564368.724206] usb 1-2: USB disconnect, device number 15
May  2 12:05:24 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 12:05:24 pog systemd[1]: Unmounting /media/james/My CDROM...
May  2 12:05:25 pog systemd[1298]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:05:25 pog systemd[2384]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:05:25 pog systemd[1]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:05:25 pog systemd[1]: Unmounted /media/james/My CDROM.
May  2 12:05:25 pog systemd[1]: Stopping Clean the /media/james/My CDROM mount point...
May  2 12:05:25 pog systemd[1]: clean-mount-point@media-james-My\x20CDROM.service: Succeeded.
May  2 12:05:25 pog systemd[1]: Stopped Clean the /media/james/My CDROM mount point.
May  2 12:05:25 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.2' (uid=1000 pid=2405 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 12:05:25 pog systemd[2384]: Starting Tracker metadata database store and lookup manager...
May  2 12:05:25 pog udisksd[1070]: Error cleaning up mount point /media/james/My CDROM: Error unmounting: Command-line `umount -l '/media/james/My CDROM'' exited with non-zero exit status 32: umount: /media/james/My CDROM: no mount point specified.
May  2 12:05:25 pog udisksd[1070]: mountpoint /media/james/My CDROM is invalid, cannot recover the canonical path 
May  2 12:05:25 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 12:05:25 pog dbus-daemon[1315]: [session uid=124 pid=1315] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.1' (uid=124 pid=1309 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 12:05:25 pog systemd[1298]: Starting Tracker metadata database store and lookup manager...
May  2 12:05:25 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.freedesktop.Tracker1'
May  2 12:05:25 pog systemd[2384]: Started Tracker metadata database store and lookup manager.
May  2 12:05:25 pog dbus-daemon[1315]: [session uid=124 pid=1315] Successfully activated service 'org.freedesktop.Tracker1'
May  2 12:05:25 pog systemd[1298]: Started Tracker metadata database store and lookup manager.
May  2 12:05:25 pog gvfsd[1073545]: PTP: reading event an error 0x05 occurred
May  2 12:05:25 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:05:25 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:05:26 pog gvfsd[1073545]: Device 0 (VID=12d1 and PID=107e) is a Huawei P9 Plus.
May  2 12:05:26 pog gvfsd[1073545]: Android device detected, assigning default bug flags
May  2 12:05:26 pog gvfsd[1073545]: Received event PTP_EC_DevicePropChanged in session 1

May  2 12:05:28 pog systemd[2384]: gnome-terminal-server.service: Succeeded.
May  2 12:05:28 pog kernel: [564371.987504] usb 1-2: new high-speed USB device number 16 using xhci_hcd
May  2 12:05:28 pog kernel: [564372.140936] usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 12:05:28 pog kernel: [564372.140939] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 12:05:28 pog kernel: [564372.140941] usb 1-2: Product: EVA-L09
May  2 12:05:28 pog kernel: [564372.140943] usb 1-2: Manufacturer: HUAWEI
May  2 12:05:28 pog kernel: [564372.140944] usb 1-2: SerialNumber: MWS0216A31001549
May  2 12:05:28 pog kernel: [564372.144604] usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 12:05:28 pog kernel: [564372.144915] scsi host2: usb-storage 1-2:1.1
May  2 12:05:28 pog colord[1142]: CdMain: failed to emit DeviceAdded: failed to register object: An object is already exported for the interface org.freedesktop.ColorManager.Device at /org/freedesktop/ColorManager/devices/sysfs__null_
May  2 12:05:28 pog gvfsd[1074998]: Error 1: Get Storage information failed.
May  2 12:05:28 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating service name='org.gnome.Shell.HotplugSniffer' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")
May  2 12:05:28 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.gnome.Shell.HotplugSniffer'
May  2 12:05:29 pog kernel: [564373.152326] scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 12:05:29 pog kernel: [564373.153081] sr 2:0:0:0: Power-on or device reset occurred
May  2 12:05:29 pog kernel: [564373.153612] sr 2:0:0:0: [sr1] scsi-1 drive
May  2 12:05:29 pog kernel: [564373.176056] sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 12:05:29 pog kernel: [564373.176268] sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 12:05:29 pog kernel: [564373.370382] ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 12:05:29 pog kernel: [564373.370559] ISOFS: changing to secondary root
May  2 12:05:29 pog systemd[1]: Finished Clean the /media/james/My CDROM mount point.
May  2 12:05:29 pog udisksd[1070]: Mounted /dev/sr1 at /media/james/My CDROM on behalf of uid 1000

May  2 12:05:38 pog kernel: [564382.246425] usb 1-2: USB disconnect, device number 16
May  2 12:05:38 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 12:05:38 pog systemd[1]: Unmounting /media/james/My CDROM...
May  2 12:05:38 pog systemd[1298]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:05:38 pog systemd[2384]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:05:38 pog systemd[1]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:05:38 pog systemd[1]: Unmounted /media/james/My CDROM.
May  2 12:05:38 pog systemd[1]: Stopping Clean the /media/james/My CDROM mount point...
May  2 12:05:38 pog systemd[1]: clean-mount-point@media-james-My\x20CDROM.service: Succeeded.
May  2 12:05:38 pog systemd[1]: Stopped Clean the /media/james/My CDROM mount point.
May  2 12:05:38 pog udisksd[1070]: Error cleaning up mount point /media/james/My CDROM: Error unmounting: Command-line `umount -l '/media/james/My CDROM'' exited with non-zero exit status 32: umount: /media/james/My CDROM: no mount point specified.
May  2 12:05:38 pog udisksd[1070]: mountpoint /media/james/My CDROM is invalid, cannot recover the canonical path 
May  2 12:05:38 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 12:05:38 pog gvfsd[1074998]: PTP: reading event an error 0x05 occurred
May  2 12:05:38 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:05:39 pog kernel: [564382.747498] usb 1-2: new high-speed USB device number 17 using xhci_hcd
May  2 12:05:39 pog kernel: [564382.900897] usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 12:05:39 pog kernel: [564382.900900] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 12:05:39 pog kernel: [564382.900902] usb 1-2: Product: EVA-L09
May  2 12:05:39 pog kernel: [564382.900904] usb 1-2: Manufacturer: HUAWEI
May  2 12:05:39 pog kernel: [564382.900905] usb 1-2: SerialNumber: MWS0216A31001549
May  2 12:05:39 pog kernel: [564382.904781] usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 12:05:39 pog kernel: [564382.905211] scsi host2: usb-storage 1-2:1.1
May  2 12:05:38 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:05:39 pog colord[1142]: CdMain: failed to emit DeviceAdded: failed to register object: An object is already exported for the interface org.freedesktop.ColorManager.Device at /org/freedesktop/ColorManager/devices/sysfs__null_
May  2 12:05:39 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating service name='org.gnome.Shell.HotplugSniffer' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")
May  2 12:05:39 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.gnome.Shell.HotplugSniffer'
May  2 12:05:39 pog gvfsd[1074998]: Device 0 (VID=12d1 and PID=107e) is a Huawei P9 Plus.
May  2 12:05:39 pog gvfsd[1074998]: Android device detected, assigning default bug flags
May  2 12:05:39 pog gvfsd[1074998]: Received event PTP_EC_DevicePropChanged in session 1

May  2 12:05:40 pog kernel: [564383.935714] scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 12:05:40 pog kernel: [564383.936110] sr 2:0:0:0: Power-on or device reset occurred
May  2 12:05:40 pog kernel: [564383.936443] sr 2:0:0:0: [sr1] scsi-1 drive
May  2 12:05:40 pog kernel: [564383.963647] sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 12:05:40 pog kernel: [564383.963734] sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 12:05:40 pog gnome-shell[3057]: JS ERROR: TypeError: yaddah yaddah yaddah ...
May  2 12:05:40 pog gnome-shell[3057]: JS ERROR: TypeError:  yaddah yaddah yaddah ... 
May  2 12:05:40 pog kernel: [564384.120924] ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 12:05:40 pog kernel: [564384.121077] ISOFS: changing to secondary root
May  2 12:05:40 pog systemd[1]: Finished Clean the /media/james/My CDROM mount point.
May  2 12:05:40 pog udisksd[1070]: Mounted /dev/sr1 at /media/james/My CDROM on behalf of uid 1000


Maybe nautilus restarted at this point?

May  2 12:05:44 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating service name='org.gnome.Nautilus' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")
May  2 12:05:44 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating service name='org.gnome.Calculator.SearchProvider' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")
May  2 12:05:44 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating via systemd: service name='org.gnome.Terminal' unit='gnome-terminal-server.service' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")
May  2 12:05:44 pog systemd[2384]: Starting GNOME Terminal Server...
May  2 12:05:44 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.gnome.Nautilus'
May  2 12:05:44 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.gnome.Calculator.SearchProvider'
May  2 12:05:44 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.gnome.Terminal'
May  2 12:05:44 pog systemd[2384]: Started GNOME Terminal Server.

May  2 12:05:45 pog nautilus[1075193]: Called "net usershare info" but it failed: Failed to execute child process “net” (No such file or directory)

May  2 12:05:54 pog systemd[2384]: gnome-terminal-server.service: Succeeded.

May  2 12:06:10 pog tracker-store[1074957]: OK
May  2 12:06:10 pog systemd[2384]: tracker-store.service: Succeeded.
May  2 12:06:10 pog tracker-store[1074958]: OK
May  2 12:06:10 pog systemd[1298]: tracker-store.service: Succeeded.

May  2 12:06:15 pog systemd[1]: systemd-hostnamed.service: Succeeded.

May  2 12:06:59 pog kernel: [564463.099766] usb 1-2: reset high-speed USB device number 17 using xhci_hcd
May  2 12:06:59 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:06:59 pog tracker-miner-f[2405]: g_str_has_prefix: assertion 'str != NULL' failed
May  2 12:06:59 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:06:59 pog tracker-miner-f[2405]: g_str_has_prefix: assertion 'str != NULL' failed
May  2 12:07:00 pog gvfsd[1075119]: Device 0 (VID=12d1 and PID=107e) is a Huawei P9 Plus.
May  2 12:07:00 pog gvfsd[1075119]: Android device detected, assigning default bug flags
May  2 12:07:01 pog kernel: [564464.772683] sr 2:0:0:0: Power-on or device reset occurred
May  2 12:07:01 pog kernel: [564464.779308] VFS: busy inodes on changed media or resized disk sr1

A bit more from nautilus/HotplugSniffer

May  2 12:07:04 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating service name='org.gnome.Shell.HotplugSniffer' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")
May  2 12:07:04 pog nautilus[1075193]: gtk_widget_set_visible: assertion 'GTK_IS_WIDGET (widget)' failed
May  2 12:07:04 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.gnome.Shell.HotplugSniffer'

May  2 12:07:10 pog kernel: [564474.310144] usb 1-2: USB disconnect, device number 17
May  2 12:07:10 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 12:07:10 pog systemd[1]: Unmounting /media/james/My CDROM...
May  2 12:07:10 pog systemd[1298]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:07:10 pog systemd[2384]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:07:10 pog systemd[1]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:07:10 pog systemd[1]: Unmounted /media/james/My CDROM.
May  2 12:07:10 pog systemd[1]: Stopping Clean the /media/james/My CDROM mount point...
May  2 12:07:10 pog systemd[1]: clean-mount-point@media-james-My\x20CDROM.service: Succeeded.
May  2 12:07:10 pog systemd[1]: Stopped Clean the /media/james/My CDROM mount point.
May  2 12:07:10 pog udisksd[1070]: Error cleaning up mount point /media/james/My CDROM: Error unmounting: Command-line `umount -l '/media/james/My CDROM'' exited with non-zero exit status 32: umount: /media/james/My CDROM: not mounted.
May  2 12:07:10 pog udisksd[1070]: mountpoint /media/james/My CDROM is invalid, cannot recover the canonical path 
May  2 12:07:10 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 12:07:10 pog dbus-daemon[1315]: [session uid=124 pid=1315] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.1' (uid=124 pid=1309 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 12:07:10 pog systemd[1298]: Starting Tracker metadata database store and lookup manager...
May  2 12:07:10 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.2' (uid=1000 pid=2405 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 12:07:10 pog systemd[2384]: Starting Tracker metadata database store and lookup manager...
May  2 12:07:10 pog dbus-daemon[1315]: [session uid=124 pid=1315] Successfully activated service 'org.freedesktop.Tracker1'
May  2 12:07:10 pog systemd[1298]: Started Tracker metadata database store and lookup manager.
May  2 12:07:10 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.freedesktop.Tracker1'
May  2 12:07:10 pog systemd[2384]: Started Tracker metadata database store and lookup manager.
May  2 12:07:10 pog gvfsd[1075570]: PTP: reading event an error 0x05 occurred
May  2 12:07:10 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:07:10 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:07:11 pog gvfsd[1075570]: Device 0 (VID=12d1 and PID=107e) is a Huawei P9 Plus.
May  2 12:07:11 pog gvfsd[1075570]: Android device detected, assigning default bug flags

May  2 12:07:15 pog kernel: [564479.219496] usb 1-2: new high-speed USB device number 18 using xhci_hcd
May  2 12:07:15 pog kernel: [564479.368914] usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 12:07:15 pog kernel: [564479.368917] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 12:07:15 pog kernel: [564479.368919] usb 1-2: Product: EVA-L09
May  2 12:07:15 pog kernel: [564479.368921] usb 1-2: Manufacturer: HUAWEI
May  2 12:07:15 pog kernel: [564479.368922] usb 1-2: SerialNumber: MWS0216A31001549
May  2 12:07:15 pog kernel: [564479.372343] usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 12:07:15 pog kernel: [564479.372836] scsi host2: usb-storage 1-2:1.1
May  2 12:07:15 pog colord[1142]: CdMain: failed to emit DeviceAdded: failed to register object: An object is already exported for the interface org.freedesktop.ColorManager.Device at /org/freedesktop/ColorManager/devices/sysfs__null_
May  2 12:07:15 pog gvfsd[1075647]: Error 1: Get Storage information failed.
May  2 12:07:15 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating service name='org.gnome.Shell.HotplugSniffer' requested by ':1.38' (uid=1000 pid=3057 comm="/usr/bin/gnome-shell " label="unconfined")
May  2 12:07:15 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.gnome.Shell.HotplugSniffer'
May  2 12:07:16 pog kernel: [564480.387775] scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 12:07:16 pog kernel: [564480.388134] sr 2:0:0:0: Power-on or device reset occurred
May  2 12:07:16 pog kernel: [564480.388625] sr 2:0:0:0: [sr1] scsi-1 drive
May  2 12:07:16 pog kernel: [564480.411664] sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 12:07:16 pog kernel: [564480.411818] sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 12:07:16 pog kernel: [564480.616041] ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 12:07:16 pog kernel: [564480.616223] ISOFS: changing to secondary root
May  2 12:07:16 pog systemd[1]: Finished Clean the /media/james/My CDROM mount point.
May  2 12:07:16 pog udisksd[1070]: Mounted /dev/sr1 at /media/james/My CDROM on behalf of uid 1000

May  2 12:07:20 pog kernel: [564484.011862] usb 1-2: USB disconnect, device number 18
May  2 12:07:20 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 12:07:20 pog systemd[1]: Unmounting /media/james/My CDROM...
May  2 12:07:20 pog systemd[2384]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:07:20 pog systemd[1298]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:07:20 pog systemd[1]: media-james-My\x20CDROM.mount: Succeeded.
May  2 12:07:20 pog systemd[1]: Unmounted /media/james/My CDROM.
May  2 12:07:20 pog udisksd[1070]: Error cleaning up mount point /media/james/My CDROM: Error unmounting: Command-line `umount -l '/media/james/My CDROM'' exited with non-zero exit status 32: umount: /media/james/My CDROM: not mounted.
May  2 12:07:20 pog systemd[1]: Stopping Clean the /media/james/My CDROM mount point...
May  2 12:07:20 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 12:07:20 pog systemd[1]: clean-mount-point@media-james-My\x20CDROM.service: Succeeded.
May  2 12:07:20 pog systemd[1]: Stopped Clean the /media/james/My CDROM mount point.
May  2 12:07:20 pog gvfsd[1075647]: PTP: reading event an error 0x05 occurred
May  2 12:07:20 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:07:20 pog kernel: [564484.519401] usb 1-2: new high-speed USB device number 19 using xhci_hcd
May  2 12:07:20 pog kernel: [564484.674159] usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 12:07:20 pog kernel: [564484.674162] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 12:07:20 pog kernel: [564484.674164] usb 1-2: Product: EVA-L09
May  2 12:07:20 pog kernel: [564484.674166] usb 1-2: Manufacturer: HUAWEI
May  2 12:07:20 pog kernel: [564484.674167] usb 1-2: SerialNumber: MWS0216A31001549
May  2 12:07:20 pog kernel: [564484.678293] usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 12:07:20 pog kernel: [564484.678576] scsi host2: usb-storage 1-2:1.1
May  2 12:07:20 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:07:20 pog colord[1142]: CdMain: failed to emit DeviceAdded: failed to register object: An object is already exported for the interface org.freedesktop.ColorManager.Device at /org/freedesktop/ColorManager/devices/sysfs__null_
May  2 12:07:21 pog gvfsd[1075647]: Device 0 (VID=12d1 and PID=107e) is a Huawei P9 Plus.
May  2 12:07:21 pog gvfsd[1075647]: Android device detected, assigning default bug flags
May  2 12:07:21 pog gvfsd[1075647]: Received event PTP_EC_DevicePropChanged in session 1
May  2 12:07:21 pog kernel: [564485.697115] scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 12:07:21 pog kernel: [564485.698206] sr 2:0:0:0: Power-on or device reset occurred
May  2 12:07:21 pog kernel: [564485.699184] sr 2:0:0:0: [sr1] scsi-1 drive
May  2 12:07:21 pog kernel: [564485.715912] sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 12:07:21 pog kernel: [564485.716072] sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 12:07:22 pog kernel: [564485.896946] ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 12:07:22 pog kernel: [564485.897145] ISOFS: changing to secondary root
May  2 12:07:22 pog systemd[1]: Finished Clean the /media/james/My CDROM mount point.
May  2 12:07:22 pog udisksd[1070]: Mounted /dev/sr1 at /media/james/My CDROM on behalf of uid 1000
May  2 12:07:52 pog tracker-store[1075622]: OK
May  2 12:07:52 pog systemd[2384]: tracker-store.service: Succeeded.
May  2 12:07:52 pog tracker-store[1075618]: OK
May  2 12:07:52 pog systemd[1298]: tracker-store.service: Succeeded.
--

At this point device works fine.
Photos copied.
And deleted.

UNMOUNT the device in Files(nautilis):


May  2 12:46:12 pog kernel: [566815.767629] usb 1-2: reset high-speed USB device number 19 using xhci_hcd
May  2 12:46:12 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:46:12 pog tracker-miner-f[2405]: g_str_has_prefix: assertion 'str != NULL' failed
May  2 12:46:12 pog tracker-miner-f[2405]: g_str_has_suffix: assertion 'str != NULL' failed
May  2 12:46:12 pog tracker-miner-f[2405]: g_str_has_prefix: assertion 'str != NULL' failed
May  2 12:46:12 pog kernel: [566816.388631] sr 2:0:0:0: Power-on or device reset occurred
May  2 12:46:12 pog kernel: [566816.395103] VFS: busy inodes on changed media or resized disk sr1
May  2 12:46:13 pog gvfsd[1075773]: Device 0 (VID=12d1 and PID=107e) is a Huawei P9 Plus.
May  2 12:46:13 pog gvfsd[1075773]: Android device detected, assigning default bug flags
May  2 12:46:13 pog gvfsd[1075773]: Received event PTP_EC_DevicePropChanged in session 1
May  2 12:46:15 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.2' (uid=1000 pid=2405 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 12:46:15 pog systemd[2384]: Starting Tracker metadata database store and lookup manager...
May  2 12:46:15 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.freedesktop.Tracker1'
May  2 12:46:15 pog systemd[2384]: Started Tracker metadata database store and lookup manager.
May  2 12:46:45 pog tracker-store[1080626]: OK
May  2 12:46:45 pog systemd[2384]: tracker-store.service: Succeeded.
--

LATER, unplug cable:



May  2 13:12:45 pog kernel: [568408.864181] usb 1-2: USB disconnect, device number 19
May  2 13:12:45 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 13:12:45 pog systemd[1]: Unmounting /media/james/My CDROM...
May  2 13:12:45 pog systemd[2384]: media-james-My\x20CDROM.mount: Succeeded.
May  2 13:12:45 pog systemd[1298]: media-james-My\x20CDROM.mount: Succeeded.
May  2 13:12:45 pog systemd[1]: media-james-My\x20CDROM.mount: Succeeded.
May  2 13:12:45 pog systemd[1]: Unmounted /media/james/My CDROM.
May  2 13:12:45 pog systemd[1]: Stopping Clean the /media/james/My CDROM mount point...
May  2 13:12:45 pog systemd[1]: clean-mount-point@media-james-My\x20CDROM.service: Succeeded.
May  2 13:12:45 pog systemd[1]: Stopped Clean the /media/james/My CDROM mount point.
May  2 13:12:45 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.2' (uid=1000 pid=2405 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 13:12:45 pog udisksd[1070]: Error cleaning up mount point /media/james/My CDROM: Error unmounting: Command-line `umount -l '/media/james/My CDROM'' exited with non-zero exit status 32: umount: /media/james/My CDROM: no mount point specified.
May  2 13:12:45 pog udisksd[1070]: mountpoint /media/james/My CDROM is invalid, cannot recover the canonical path 
May  2 13:12:45 pog udisksd[1070]: Cleaning up mount point /media/james/My CDROM (device 11:1 no longer exists)
May  2 13:12:45 pog systemd[2384]: Starting Tracker metadata database store and lookup manager...
May  2 13:12:45 pog dbus-daemon[1315]: [session uid=124 pid=1315] Activating via systemd: service name='org.freedesktop.Tracker1' unit='tracker-store.service' requested by ':1.1' (uid=124 pid=1309 comm="/usr/libexec/tracker-miner-fs " label="unconfined")
May  2 13:12:45 pog systemd[1298]: Starting Tracker metadata database store and lookup manager...
May  2 13:12:45 pog dbus-daemon[2409]: [session uid=1000 pid=2409] Successfully activated service 'org.freedesktop.Tracker1'
May  2 13:12:45 pog systemd[2384]: Started Tracker metadata database store and lookup manager.
May  2 13:12:45 pog dbus-daemon[1315]: [session uid=124 pid=1315] Successfully activated service 'org.freedesktop.Tracker1'
May  2 13:12:45 pog systemd[1298]: Started Tracker metadata database store and lookup manager.



From kern.log

Chunk of log showing connect, allow access, when there is a problem:

May  2 11:54:39  usb 1-2: new high-speed USB device number 8 using xhci_hcd
May  2 11:54:39  usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 11:54:39  usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 11:54:39  usb 1-2: Product: EVA-L09
May  2 11:54:39  usb 1-2: Manufacturer: HUAWEI
May  2 11:54:39  usb 1-2: SerialNumber: MWS0216A31001549
May  2 11:54:39  usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 11:54:39  scsi host2: usb-storage 1-2:1.1
May  2 11:54:39  usbcore: registered new interface driver usb-storage
May  2 11:54:39  usbcore: registered new interface driver uas
May  2 11:54:40  scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 11:54:40  sr 2:0:0:0: Power-on or device reset occurred
May  2 11:54:40  sr 2:0:0:0: [sr1] scsi-1 drive
May  2 11:54:40  sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 11:54:40  sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 11:54:40  ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 11:54:40  ISOFS: changing to secondary root
May  2 11:54:43  usb 1-2: USB disconnect, device number 8
May  2 11:54:43  usb 1-2: new high-speed USB device number 9 using xhci_hcd
May  2 11:54:43  usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 11:54:43  usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 11:54:43  usb 1-2: Product: EVA-L09
May  2 11:54:43  usb 1-2: Manufacturer: HUAWEI
May  2 11:54:43  usb 1-2: SerialNumber: MWS0216A31001549
May  2 11:54:43  usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 11:54:43  scsi host2: usb-storage 1-2:1.1
May  2 11:54:44  scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 11:54:44  sr 2:0:0:0: Power-on or device reset occurred
May  2 11:54:44  sr 2:0:0:0: [sr1] scsi-1 drive
May  2 11:54:44  sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 11:54:44  sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 11:54:44  ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 11:54:44  ISOFS: changing to secondary root




May  2 11:59:07  usb 1-2: USB disconnect, device number 9
May  2 11:59:08  usb 1-2: new high-speed USB device number 10 using xhci_hcd
May  2 11:59:08  usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 11:59:08  usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 11:59:08  usb 1-2: Product: EVA-L09
May  2 11:59:08  usb 1-2: Manufacturer: HUAWEI
May  2 11:59:08  usb 1-2: SerialNumber: MWS0216A31001549
May  2 11:59:08  usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 11:59:08  scsi host2: usb-storage 1-2:1.1
May  2 11:59:08  usb 1-2: USB disconnect, device number 10
May  2 11:59:12  usb 1-2: new high-speed USB device number 11 using xhci_hcd
May  2 11:59:12  usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 11:59:12  usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 11:59:12  usb 1-2: Product: EVA-L09
May  2 11:59:12  usb 1-2: Manufacturer: HUAWEI
May  2 11:59:12  usb 1-2: SerialNumber: MWS0216A31001549
May  2 11:59:12  usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 11:59:12  scsi host2: usb-storage 1-2:1.1
May  2 11:59:13  scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 11:59:13  sr 2:0:0:0: Power-on or device reset occurred
May  2 11:59:13  sr 2:0:0:0: [sr1] scsi-1 drive
May  2 11:59:13  sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 11:59:13  sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 11:59:13  ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 11:59:13  ISOFS: changing to secondary root

May  2 11:59:17  usb 1-2: USB disconnect, device number 11
May  2 11:59:18  usb 1-2: new high-speed USB device number 12 using xhci_hcd
May  2 11:59:18  usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 11:59:18  usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 11:59:18  usb 1-2: Product: EVA-L09
May  2 11:59:18  usb 1-2: Manufacturer: HUAWEI
May  2 11:59:18  usb 1-2: SerialNumber: MWS0216A31001549
May  2 11:59:18  usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 11:59:18  scsi host2: usb-storage 1-2:1.1
May  2 11:59:19  scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 11:59:19  sr 2:0:0:0: Power-on or device reset occurred
May  2 11:59:19  sr 2:0:0:0: [sr1] scsi-1 drive
May  2 11:59:19  sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 11:59:19  sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 11:59:19  ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 11:59:19  ISOFS: changing to secondary root


May  2 12:01:48  usb 1-2: USB disconnect, device number 12
May  2 12:01:48  usb 1-2: new high-speed USB device number 13 using xhci_hcd
May  2 12:01:48  usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 12:01:48  usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 12:01:48  usb 1-2: Product: EVA-L09
May  2 12:01:48  usb 1-2: Manufacturer: HUAWEI
May  2 12:01:48  usb 1-2: SerialNumber: MWS0216A31001549
May  2 12:01:48  usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 12:01:48  scsi host2: usb-storage 1-2:1.1
May  2 12:01:49  usb 1-2: USB disconnect, device number 13
May  2 12:01:49  traps: pool[1072384] general protection fault ip:7f49d289ccd8 sp:7f49caffca88 error:0 in libgvfscommon.so[7f49d2887000+1a000]
May  2 12:01:54  usb 1-2: new high-speed USB device number 14 using xhci_hcd
May  2 12:01:54  usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 12:01:54  usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 12:01:54  usb 1-2: Product: EVA-L09
May  2 12:01:54  usb 1-2: Manufacturer: HUAWEI
May  2 12:01:54  usb 1-2: SerialNumber: MWS0216A31001549
May  2 12:01:54  usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 12:01:54  scsi host2: usb-storage 1-2:1.1

May  2 12:01:56  scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 12:01:56  sr 2:0:0:0: Power-on or device reset occurred
May  2 12:01:56  sr 2:0:0:0: [sr1] scsi-1 drive
May  2 12:01:56  sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 12:01:56  sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 12:01:56  ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 12:01:56  ISOFS: changing to secondary root

May  2 12:02:12  usb 1-2: USB disconnect, device number 14
May  2 12:02:13  usb 1-2: new high-speed USB device number 15 using xhci_hcd
May  2 12:02:13  usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 12:02:13  usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 12:02:13  usb 1-2: Product: EVA-L09
May  2 12:02:13  usb 1-2: Manufacturer: HUAWEI
May  2 12:02:13  usb 1-2: SerialNumber: MWS0216A31001549
May  2 12:02:13  usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 12:02:13  scsi host2: usb-storage 1-2:1.1
May  2 12:02:14  scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 12:02:14  sr 2:0:0:0: Power-on or device reset occurred
May  2 12:02:14  sr 2:0:0:0: [sr1] scsi-1 drive
May  2 12:02:14  sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 12:02:14  sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 12:02:14  ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 12:02:14  ISOFS: changing to secondary root

And later ...

May  2 12:05:24  usb 1-2: USB disconnect, device number 15

May  2 12:05:28  usb 1-2: new high-speed USB device number 16 using xhci_hcd
May  2 12:05:28  usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 12:05:28  usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 12:05:28  usb 1-2: Product: EVA-L09
May  2 12:05:28  usb 1-2: Manufacturer: HUAWEI
May  2 12:05:28  usb 1-2: SerialNumber: MWS0216A31001549
May  2 12:05:28  usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 12:05:28  scsi host2: usb-storage 1-2:1.1
May  2 12:05:29  scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 12:05:29  sr 2:0:0:0: Power-on or device reset occurred
May  2 12:05:29  sr 2:0:0:0: [sr1] scsi-1 drive
May  2 12:05:29  sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 12:05:29  sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 12:05:29  ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 12:05:29  ISOFS: changing to secondary root

May  2 12:05:38  usb 1-2: USB disconnect, device number 16
May  2 12:05:39  usb 1-2: new high-speed USB device number 17 using xhci_hcd
May  2 12:05:39  usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 12:05:39  usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 12:05:39  usb 1-2: Product: EVA-L09
May  2 12:05:39  usb 1-2: Manufacturer: HUAWEI
May  2 12:05:39  usb 1-2: SerialNumber: MWS0216A31001549
May  2 12:05:39  usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 12:05:39  scsi host2: usb-storage 1-2:1.1
May  2 12:05:40  scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 12:05:40  sr 2:0:0:0: Power-on or device reset occurred
May  2 12:05:40  sr 2:0:0:0: [sr1] scsi-1 drive
May  2 12:05:40  sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 12:05:40  sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 12:05:40  ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 12:05:40  ISOFS: changing to secondary root


And later when problem is solved:
APART from the "reset" the log chunk is exactly the same as before when there was a problem.

May  2 12:06:59  usb 1-2: reset high-speed USB device number 17 using xhci_hcd
May  2 12:07:01  sr 2:0:0:0: Power-on or device reset occurred
May  2 12:07:01  VFS: busy inodes on changed media or resized disk sr1
May  2 12:07:10  usb 1-2: USB disconnect, device number 17

May  2 12:07:15  usb 1-2: new high-speed USB device number 18 using xhci_hcd
May  2 12:07:15  usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 12:07:15  usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 12:07:15  usb 1-2: Product: EVA-L09
May  2 12:07:15  usb 1-2: Manufacturer: HUAWEI
May  2 12:07:15  usb 1-2: SerialNumber: MWS0216A31001549
May  2 12:07:15  usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 12:07:15  scsi host2: usb-storage 1-2:1.1
 .. no usbcore stuff 
May  2 12:07:16  scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 12:07:16  sr 2:0:0:0: Power-on or device reset occurred
May  2 12:07:16  sr 2:0:0:0: [sr1] scsi-1 drive
May  2 12:07:16  sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 12:07:16  sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 12:07:16  ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 12:07:16  ISOFS: changing to secondary root
May  2 12:07:20  usb 1-2: USB disconnect, device number 18
May  2 12:07:20  usb 1-2: new high-speed USB device number 19 using xhci_hcd
May  2 12:07:20  usb 1-2: New USB device found, idVendor=12d1, idProduct=107e, bcdDevice= 2.99
May  2 12:07:20  usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May  2 12:07:20  usb 1-2: Product: EVA-L09
May  2 12:07:20  usb 1-2: Manufacturer: HUAWEI
May  2 12:07:20  usb 1-2: SerialNumber: MWS0216A31001549
May  2 12:07:20  usb-storage 1-2:1.1: USB Mass Storage device detected
May  2 12:07:20  scsi host2: usb-storage 1-2:1.1
May  2 12:07:21  scsi 2:0:0:0: CD-ROM            Linux    File-CD Gadget   0401 PQ: 0 ANSI: 2
May  2 12:07:21  sr 2:0:0:0: Power-on or device reset occurred
May  2 12:07:21  sr 2:0:0:0: [sr1] scsi-1 drive
May  2 12:07:21  sr 2:0:0:0: Attached scsi CD-ROM sr1
May  2 12:07:21  sr 2:0:0:0: Attached scsi generic sg2 type 5
May  2 12:07:22  ISO 9660 Extensions: Microsoft Joliet Level 1
May  2 12:07:22  ISOFS: changing to secondary root


LATER:

May  2 12:46:12  usb 1-2: reset high-speed USB device number 19 using xhci_hcd
May  2 12:46:12  sr 2:0:0:0: Power-on or device reset occurred
May  2 12:46:12  VFS: busy inodes on changed media or resized disk sr1

May  2 13:12:45  usb 1-2: USB disconnect, device number 19




No comments: