-- Logs begin at Thu 2019-02-14 18:12:00 +08, end at Mon 2024-07-15 09:28:42 +08. --
Jul 15 09:27:01 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 15 09:27:01 volumio volumio[921]: info: CURURI: playlists/y
Jul 15 09:27:01 volumio volumio[921]: info: Preload queue cleared
Jul 15 09:27:01 volumio volumio[921]: info: Preloading song: mnt/USB/0E0E-F3F2/aa/天长地久 - 周启生.mp3
Jul 15 09:27:01 volumio volumio[921]: info: Exploding uri mnt/USB/0E0E-F3F2/aa/天长地久 - 周启生.mp3 in service mpd
Jul 15 09:27:01 volumio volumio[921]: error: scanFolder - failure to stat '/mnt/USB/0E0E-F3F2/aa/天长地久 - 周启生.mp3'
Jul 15 09:27:05 volumio volumio[921]: info: Preload queue cleared
Jul 15 09:27:05 volumio volumio[921]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 15 09:27:05 volumio volumio[921]: info: CoreStateMachine::ClearQueue
Jul 15 09:27:05 volumio volumio[921]: info: CoreStateMachine::stop
Jul 15 09:27:05 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 15 09:27:05 volumio volumio[921]: info: CorePlayQueue::clearPlayQueue
Jul 15 09:27:05 volumio volumio[921]: info: CorePlayQueue::saveQueue
Jul 15 09:27:05 volumio volumio[921]: info: CoreCommandRouter::volumioPushQueue
Jul 15 09:27:05 volumio volumio[921]: info: CoreStateMachine::addQueueItems
Jul 15 09:27:05 volumio volumio[921]: info: CorePlayQueue::addQueueItems
Jul 15 09:27:05 volumio volumio[921]: info: Preload queue cleared
Jul 15 09:27:05 volumio volumio[921]: info: Adding Item to queue: mnt/USB/0E0E-F3F2/aa/天长地久 - 周启生.mp3
Jul 15 09:27:05 volumio volumio[921]: info: Using cached record of: mnt/USB/0E0E-F3F2/aa/天长地久 - 周启生.mp3
Jul 15 09:27:05 volumio volumio[921]: info: CoreCommandRouter::volumioPushQueue
Jul 15 09:27:05 volumio volumio[921]: info: CorePlayQueue::saveQueue
Jul 15 09:27:05 volumio volumio[921]: info: CoreStateMachine::updateTrackBlock
Jul 15 09:27:05 volumio volumio[921]: info: CorePlayQueue::getTrackBlock
Jul 15 09:27:05 volumio volumio[921]: info: CoreCommandRouter::volumioPlay
Jul 15 09:27:05 volumio volumio[921]: info: CoreStateMachine::play index 0
Jul 15 09:27:05 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 15 09:27:05 volumio volumio[921]: info: CoreStateMachine::stop
Jul 15 09:27:05 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 15 09:27:05 volumio volumio[921]: info: CoreStateMachine::play index undefined
Jul 15 09:27:05 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 15 09:27:05 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:32 volumio volumio[921]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 15 09:27:32 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Jul 15 09:27:32 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 15 09:27:32 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 15 09:27:32 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 15 09:27:32 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 15 09:27:32 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 15 09:27:32 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 15 09:27:32 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 15 09:27:32 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 15 09:27:32 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 15 09:27:32 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Jul 15 09:27:32 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jul 15 09:27:36 volumio kernel: usb 1-1.2: USB disconnect, device number 18
Jul 15 09:27:36 volumio volumio[921]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-Mass_Storage_Device_121220130416-0:0-part1 /dev/disk/by-uuid/080B-0044 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.2:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"42","ID_BUS":"usb","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"080B-0044","ID_FS_UUID_ENC":"080B-0044","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"Storage_Device","ID_MODEL_ENC":"Storage\\x20Device\\x20\\x20","ID_MODEL_ID":"1212","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"135","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"3854201","ID_PART_ENTRY_TYPE":"0x6","ID_PART_TABLE_TYPE":"dos","ID_PATH":"platform-3f980000.usb-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"Mass_Storage_Device_121220130416-0:0","ID_SERIAL_SHORT":"121220130416","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Mass","ID_VENDOR_ENC":"Mass\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"14cd","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"2237","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"335668921"}
Jul 15 09:27:36 volumio sudo[1843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1
Jul 15 09:27:36 volumio sudo[1843]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 09:27:36 volumio sudo[1843]: pam_unix(sudo:session): session closed for user root
Jul 15 09:27:40 volumio volumio[921]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/080B-0044
Jul 15 09:27:41 volumio volumio[921]: info: Scanning removed location : "USB/080B-0044"
Jul 15 09:27:41 volumio kernel: fat__get_entry: 14 callbacks suppressed
Jul 15 09:27:41 volumio kernel: FAT-fs (sda1): Directory bread(block 3796) failed
Jul 15 09:27:41 volumio kernel: FAT-fs (sda1): Directory bread(block 3797) failed
Jul 15 09:27:41 volumio kernel: FAT-fs (sda1): Directory bread(block 3798) failed
Jul 15 09:27:41 volumio kernel: FAT-fs (sda1): Directory bread(block 3799) failed
Jul 15 09:27:41 volumio kernel: FAT-fs (sda1): Directory bread(block 3800) failed
Jul 15 09:27:41 volumio kernel: FAT-fs (sda1): Directory bread(block 3801) failed
Jul 15 09:27:41 volumio kernel: FAT-fs (sda1): Directory bread(block 3802) failed
Jul 15 09:27:41 volumio kernel: FAT-fs (sda1): Directory bread(block 3803) failed
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:27:41 volumio volumio[921]: info:
Jul 15 09:27:41 volumio volumio[921]: ---------------------------- MPD announces state update: update
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:27:41 volumio volumio[921]: info:
Jul 15 09:27:41 volumio volumio[921]: ---------------------------- MPD announces state update: update
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:27:41 volumio volumio[921]: info:
Jul 15 09:27:41 volumio volumio[921]: ---------------------------- MPD announces state update: update
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:27:41 volumio volumio[921]: info: MPD Database updated - AlbumList cache refreshed
Jul 15 09:27:41 volumio volumio[921]: info:
Jul 15 09:27:41 volumio volumio[921]: ---------------------------- MPD announces state update: database
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:27:41 volumio volumio[921]: info:
Jul 15 09:27:41 volumio volumio[921]: ---------------------------- MPD announces state update: update
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand status took 16 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand status took 9 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand status took 8 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand status took 7 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand status took 6 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand status took 5 milliseconds
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:27:41 volumio volumio[921]: info: Command Router : Notfying DB Updatefalse
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:27:41 volumio volumio[921]: info: Command Router : Notfying DB Updatefalse
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:27:41 volumio volumio[921]: info: Command Router : Notfying DB Updatefalse
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:27:41 volumio volumio[921]: info: MPD Database updated - AlbumList cache refreshed
Jul 15 09:27:41 volumio volumio[921]: info:
Jul 15 09:27:41 volumio volumio[921]: ---------------------------- MPD announces state update: database
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:27:41 volumio volumio[921]: info:
Jul 15 09:27:41 volumio volumio[921]: ---------------------------- MPD announces state update: update
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:27:41 volumio volumio[921]: info: MPD Database updated - AlbumList cache refreshed
Jul 15 09:27:41 volumio volumio[921]: info:
Jul 15 09:27:41 volumio volumio[921]: ---------------------------- MPD announces state update: database
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:27:41 volumio volumio[921]: info:
Jul 15 09:27:41 volumio volumio[921]: ---------------------------- MPD announces state update: update
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand status took 147 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand status took 146 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand playlistinfo took 93 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand playlistinfo took 72 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand playlistinfo took 52 milliseconds
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:27:41 volumio volumio[921]: info: Command Router : Notfying DB Updatefalse
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:27:41 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: No code
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:27:41 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: No code
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:27:41 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: No code
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: ------------------------------ 271ms
Jul 15 09:27:41 volumio volumio[921]: info: ------------------------------ 264ms
Jul 15 09:27:41 volumio volumio[921]: info: ------------------------------ 263ms
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand status took 188 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand status took 183 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand status took 183 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand status took 181 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand status took 176 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand status took 176 milliseconds
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:27:41 volumio volumio[921]: info: Command Router : Notfying DB Updatefalse
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:27:41 volumio volumio[921]: info: Command Router : Notfying DB Updatefalse
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand playlistinfo took 190 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand playlistinfo took 191 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand playlistinfo took 33 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand playlistinfo took 33 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand playlistinfo took 12 milliseconds
Jul 15 09:27:41 volumio volumio[921]: info: sendMpdCommand playlistinfo took 12 milliseconds
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:27:41 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:27:41 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: No code
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:27:41 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: No code
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:27:41 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: No code
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:27:41 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: No code
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:27:41 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: No code
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:27:41 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: No code
Jul 15 09:27:41 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:27:41 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:27:41 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:27:41 volumio volumio[921]: info: ------------------------------ 496ms
Jul 15 09:27:41 volumio volumio[921]: info: ------------------------------ 497ms
Jul 15 09:27:41 volumio volumio[921]: info: ------------------------------ 382ms
Jul 15 09:27:41 volumio volumio[921]: info: ------------------------------ 383ms
Jul 15 09:27:41 volumio volumio[921]: info: ------------------------------ 376ms
Jul 15 09:27:41 volumio volumio[921]: info: ------------------------------ 377ms
Jul 15 09:27:42 volumio kernel: usb 1-1.2: new high-speed USB device number 19 using dwc_otg
Jul 15 09:27:42 volumio kernel: usb 1-1.2: New USB device found, idVendor=14cd, idProduct=1212, bcdDevice= 1.00
Jul 15 09:27:42 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Jul 15 09:27:42 volumio kernel: usb 1-1.2: Product: Mass Storage Device
Jul 15 09:27:42 volumio kernel: usb 1-1.2: Manufacturer: Generic
Jul 15 09:27:42 volumio kernel: usb 1-1.2: SerialNumber: 121220130416
Jul 15 09:27:42 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected
Jul 15 09:27:42 volumio kernel: scsi host1: usb-storage 1-1.2:1.0
Jul 15 09:27:43 volumio kernel: scsi 1:0:0:0: Direct-Access Mass Storage Device 1.00 PQ: 0 ANSI: 0 CCS
Jul 15 09:27:43 volumio kernel: sd 1:0:0:0: Attached scsi generic sg0 type 0
Jul 15 09:27:43 volumio kernel: sd 1:0:0:0: [sdb] 3854336 512-byte logical blocks: (1.97 GB/1.84 GiB)
Jul 15 09:27:43 volumio kernel: sd 1:0:0:0: [sdb] Write Protect is off
Jul 15 09:27:43 volumio kernel: sd 1:0:0:0: [sdb] Mode Sense: 03 00 00 00
Jul 15 09:27:43 volumio kernel: sd 1:0:0:0: [sdb] No Caching mode page found
Jul 15 09:27:43 volumio kernel: sd 1:0:0:0: [sdb] Assuming drive cache: write through
Jul 15 09:27:43 volumio kernel: sdb: sdb1
Jul 15 09:27:43 volumio kernel: sd 1:0:0:0: [sdb] Attached SCSI removable disk
Jul 15 09:27:44 volumio volumio[921]: info: Mounting Device 080B-0044
Jul 15 09:27:44 volumio sudo[1873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/080B-0044 -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Jul 15 09:27:44 volumio sudo[1873]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 09:27:44 volumio kernel: usb 1-1.2: reset high-speed USB device number 19 using dwc_otg
Jul 15 09:27:44 volumio sudo[1873]: pam_unix(sudo:session): session closed for user root
Jul 15 09:27:44 volumio volumio[921]: mount: /media/080B-0044: special device /dev/sdb1 does not exist.
Jul 15 09:27:44 volumio kernel: usb 1-1.2: device firmware changed
Jul 15 09:27:44 volumio kernel: sd 1:0:0:0: [sdb] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s
Jul 15 09:27:44 volumio kernel: sd 1:0:0:0: [sdb] tag#0 CDB: opcode=0x28 28 00 00 3a ce 77 00 00 10 00
Jul 15 09:27:44 volumio kernel: blk_print_req_error: 10 callbacks suppressed
Jul 15 09:27:44 volumio kernel: I/O error, dev sdb, sector 3853943 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2
Jul 15 09:27:44 volumio kernel: usb 1-1.2: USB disconnect, device number 19
Jul 15 09:27:44 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853568, async page read
Jul 15 09:27:44 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853569, async page read
Jul 15 09:27:44 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853570, async page read
Jul 15 09:27:44 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853571, async page read
Jul 15 09:27:44 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853572, async page read
Jul 15 09:27:44 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853573, async page read
Jul 15 09:27:44 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853574, async page read
Jul 15 09:27:44 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853575, async page read
Jul 15 09:27:44 volumio kernel: Buffer I/O error on dev sdb1, logical block 4096, async page read
Jul 15 09:27:44 volumio kernel: Buffer I/O error on dev sdb1, logical block 4097, async page read
Jul 15 09:27:44 volumio kernel: ext3: Unknown parameter 'dmask'
Jul 15 09:27:44 volumio kernel: ext2: Unknown parameter 'dmask'
Jul 15 09:27:44 volumio kernel: ext4: Unknown parameter 'dmask'
Jul 15 09:27:44 volumio volumio[921]: error: Failed to mount 080B-0044: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdb1" "/mnt/USB/080B-0044" -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Jul 15 09:27:44 volumio volumio[921]: mount: /media/080B-0044: special device /dev/sdb1 does not exist.
Jul 15 09:27:44 volumio volumio[921]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-Mass_Storage_Device_121220130416-0:0-part1 /dev/disk/by-uuid/080B-0044 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.2:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"43","ID_BUS":"usb","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"080B-0044","ID_FS_UUID_ENC":"080B-0044","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"Storage_Device","ID_MODEL_ENC":"Storage\\x20Device\\x20\\x20","ID_MODEL_ID":"1212","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"135","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"3854201","ID_PART_ENTRY_TYPE":"0x6","ID_PART_TABLE_TYPE":"dos","ID_PATH":"platform-3f980000.usb-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"Mass_Storage_Device_121220130416-0:0","ID_SERIAL_SHORT":"121220130416","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Mass","ID_VENDOR_ENC":"Mass\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"14cd","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"2271","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"431748673"}
Jul 15 09:27:44 volumio sudo[1876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1
Jul 15 09:27:44 volumio sudo[1876]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 09:27:44 volumio sudo[1876]: pam_unix(sudo:session): session closed for user root
Jul 15 09:27:44 volumio volumio[921]: umount: /dev/sdb1: no mount point specified.
Jul 15 09:27:44 volumio volumio[921]: error: Failed to umount 080B-0044: Error: Command failed: /usr/bin/sudo /bin/umount -f "/dev/sdb1"
Jul 15 09:27:44 volumio volumio[921]: umount: /dev/sdb1: no mount point specified.
Jul 15 09:27:45 volumio kernel: usb 1-1.2: new high-speed USB device number 20 using dwc_otg
Jul 15 09:27:45 volumio kernel: usb 1-1.2: New USB device found, idVendor=14cd, idProduct=1212, bcdDevice= 1.00
Jul 15 09:27:45 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Jul 15 09:27:45 volumio kernel: usb 1-1.2: Product: Mass Storage Device
Jul 15 09:27:45 volumio kernel: usb 1-1.2: Manufacturer: Generic
Jul 15 09:27:45 volumio kernel: usb 1-1.2: SerialNumber: 121220130416
Jul 15 09:27:45 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected
Jul 15 09:27:45 volumio kernel: scsi host1: usb-storage 1-1.2:1.0
Jul 15 09:27:45 volumio ntpd[754]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jul 15 09:27:46 volumio kernel: usb 1-1.2: USB disconnect, device number 20
Jul 15 09:27:46 volumio kernel: usb 1-1.2: new high-speed USB device number 21 using dwc_otg
Jul 15 09:27:46 volumio kernel: usb 1-1.2: New USB device found, idVendor=14cd, idProduct=1212, bcdDevice= 1.00
Jul 15 09:27:46 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Jul 15 09:27:46 volumio kernel: usb 1-1.2: Product: Mass Storage Device
Jul 15 09:27:46 volumio kernel: usb 1-1.2: Manufacturer: Generic
Jul 15 09:27:46 volumio kernel: usb 1-1.2: SerialNumber: 121220130416
Jul 15 09:27:46 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected
Jul 15 09:27:46 volumio kernel: scsi host1: usb-storage 1-1.2:1.0
Jul 15 09:27:48 volumio kernel: usb 1-1.2: reset high-speed USB device number 21 using dwc_otg
Jul 15 09:27:49 volumio kernel: usb 1-1.2: device descriptor read/all, error -71
Jul 15 09:27:50 volumio kernel: usb 1-1.2: USB disconnect, device number 21
Jul 15 09:27:52 volumio kernel: usb 1-1.2: new high-speed USB device number 22 using dwc_otg
Jul 15 09:27:52 volumio kernel: usb 1-1.2: New USB device found, idVendor=14cd, idProduct=1212, bcdDevice= 1.00
Jul 15 09:27:52 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Jul 15 09:27:52 volumio kernel: usb 1-1.2: Product: Mass Storage Device
Jul 15 09:27:52 volumio kernel: usb 1-1.2: Manufacturer: Generic
Jul 15 09:27:52 volumio kernel: usb 1-1.2: SerialNumber: 121220130416
Jul 15 09:27:52 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected
Jul 15 09:27:52 volumio kernel: scsi host1: usb-storage 1-1.2:1.0
Jul 15 09:27:54 volumio kernel: usb 1-1.2: USB disconnect, device number 22
Jul 15 09:28:06 volumio kernel: usb 1-1.2: new high-speed USB device number 23 using dwc_otg
Jul 15 09:28:06 volumio kernel: usb 1-1.2: New USB device found, idVendor=14cd, idProduct=1212, bcdDevice= 1.00
Jul 15 09:28:06 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Jul 15 09:28:06 volumio kernel: usb 1-1.2: Product: Mass Storage Device
Jul 15 09:28:06 volumio kernel: usb 1-1.2: Manufacturer: Generic
Jul 15 09:28:06 volumio kernel: usb 1-1.2: SerialNumber: 121220130416
Jul 15 09:28:06 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected
Jul 15 09:28:06 volumio kernel: scsi host1: usb-storage 1-1.2:1.0
Jul 15 09:28:08 volumio kernel: usb 1-1.2: reset high-speed USB device number 23 using dwc_otg
Jul 15 09:28:09 volumio kernel: usb 1-1.2: reset high-speed USB device number 23 using dwc_otg
Jul 15 09:28:10 volumio kernel: usb 1-1.2: USB disconnect, device number 23
Jul 15 09:28:11 volumio kernel: usb 1-1.2: new high-speed USB device number 24 using dwc_otg
Jul 15 09:28:11 volumio kernel: usb 1-1.2: New USB device found, idVendor=14cd, idProduct=1212, bcdDevice= 1.00
Jul 15 09:28:11 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Jul 15 09:28:11 volumio kernel: usb 1-1.2: Product: Mass Storage Device
Jul 15 09:28:11 volumio kernel: usb 1-1.2: Manufacturer: Generic
Jul 15 09:28:11 volumio kernel: usb 1-1.2: SerialNumber: 121220130416
Jul 15 09:28:11 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected
Jul 15 09:28:11 volumio kernel: scsi host1: usb-storage 1-1.2:1.0
Jul 15 09:28:12 volumio kernel: scsi 1:0:0:0: Direct-Access Mass Storage Device 1.00 PQ: 0 ANSI: 0 CCS
Jul 15 09:28:12 volumio kernel: sd 1:0:0:0: Attached scsi generic sg0 type 0
Jul 15 09:28:12 volumio kernel: sd 1:0:0:0: [sdb] 3854336 512-byte logical blocks: (1.97 GB/1.84 GiB)
Jul 15 09:28:12 volumio kernel: sd 1:0:0:0: [sdb] Write Protect is off
Jul 15 09:28:12 volumio kernel: sd 1:0:0:0: [sdb] Mode Sense: 03 00 00 00
Jul 15 09:28:12 volumio kernel: sd 1:0:0:0: [sdb] No Caching mode page found
Jul 15 09:28:12 volumio kernel: sd 1:0:0:0: [sdb] Assuming drive cache: write through
Jul 15 09:28:12 volumio kernel: sdb: sdb1
Jul 15 09:28:12 volumio kernel: sd 1:0:0:0: [sdb] Attached SCSI removable disk
Jul 15 09:28:13 volumio kernel: usb 1-1.2: reset high-speed USB device number 24 using dwc_otg
Jul 15 09:28:13 volumio kernel: sd 1:0:0:0: [sdb] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s
Jul 15 09:28:13 volumio kernel: sd 1:0:0:0: [sdb] tag#0 CDB: opcode=0x28 28 00 00 3a cf 07 00 00 08 00
Jul 15 09:28:13 volumio kernel: I/O error, dev sdb, sector 3854087 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2
Jul 15 09:28:13 volumio kernel: usb 1-1.2: reset high-speed USB device number 24 using dwc_otg
Jul 15 09:28:13 volumio kernel: usb 1-1.2: reset high-speed USB device number 24 using dwc_otg
Jul 15 09:28:13 volumio kernel: usb 1-1.2: device firmware changed
Jul 15 09:28:13 volumio kernel: usb 1-1.2: USB disconnect, device number 24
Jul 15 09:28:13 volumio volumio[921]: error: Cannot associate FS Label, not mounting
Jul 15 09:28:13 volumio volumio[921]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-Mass_Storage_Device_121220130416-0:0-part1 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.2:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"44","ID_BUS":"usb","ID_INSTANCE":"0:0","ID_MODEL":"Storage_Device","ID_MODEL_ENC":"Storage\\x20Device\\x20\\x20","ID_MODEL_ID":"1212","ID_PART_TABLE_TYPE":"dos","ID_PATH":"platform-3f980000.usb-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"Mass_Storage_Device_121220130416-0:0","ID_SERIAL_SHORT":"121220130416","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Mass","ID_VENDOR_ENC":"Mass\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"14cd","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"2361","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"461430978"}
Jul 15 09:28:13 volumio volumio[921]: error: Cannot associate FS Label, not mounting
Jul 15 09:28:13 volumio kernel: buffer_io_error: 6 callbacks suppressed
Jul 15 09:28:13 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853952, async page read
Jul 15 09:28:13 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853953, async page read
Jul 15 09:28:13 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853954, async page read
Jul 15 09:28:13 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853955, async page read
Jul 15 09:28:13 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853956, async page read
Jul 15 09:28:13 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853957, async page read
Jul 15 09:28:13 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853958, async page read
Jul 15 09:28:13 volumio kernel: Buffer I/O error on dev sdb1, logical block 3853959, async page read
Jul 15 09:28:13 volumio kernel: usb 1-1.2: new high-speed USB device number 25 using dwc_otg
Jul 15 09:28:14 volumio kernel: usb 1-1.2: New USB device found, idVendor=14cd, idProduct=1212, bcdDevice= 1.00
Jul 15 09:28:14 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Jul 15 09:28:14 volumio kernel: usb 1-1.2: Product: Mass Storage Device
Jul 15 09:28:14 volumio kernel: usb 1-1.2: Manufacturer: Generic
Jul 15 09:28:14 volumio kernel: usb 1-1.2: SerialNumber: 121220130416
Jul 15 09:28:14 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected
Jul 15 09:28:14 volumio kernel: scsi host1: usb-storage 1-1.2:1.0
Jul 15 09:28:15 volumio kernel: scsi 1:0:0:0: Direct-Access Mass Storage Device 1.00 PQ: 0 ANSI: 0 CCS
Jul 15 09:28:15 volumio kernel: sd 1:0:0:0: Attached scsi generic sg0 type 0
Jul 15 09:28:15 volumio kernel: sd 1:0:0:0: [sdb] 3854336 512-byte logical blocks: (1.97 GB/1.84 GiB)
Jul 15 09:28:15 volumio kernel: sd 1:0:0:0: [sdb] Write Protect is off
Jul 15 09:28:15 volumio kernel: sd 1:0:0:0: [sdb] Mode Sense: 03 00 00 00
Jul 15 09:28:15 volumio kernel: sd 1:0:0:0: [sdb] No Caching mode page found
Jul 15 09:28:15 volumio kernel: sd 1:0:0:0: [sdb] Assuming drive cache: write through
Jul 15 09:28:15 volumio kernel: sdb: sdb1
Jul 15 09:28:15 volumio kernel: sd 1:0:0:0: [sdb] Attached SCSI removable disk
Jul 15 09:28:15 volumio volumio[921]: info: Mounting Device 080B-0044
Jul 15 09:28:15 volumio sudo[1950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/080B-0044 -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Jul 15 09:28:15 volumio sudo[1950]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 09:28:15 volumio kernel: FAT-fs (sdb1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
Jul 15 09:28:15 volumio kernel: FAT-fs (sdb1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Jul 15 09:28:15 volumio sudo[1950]: pam_unix(sudo:session): session closed for user root
Jul 15 09:28:15 volumio volumio[921]: info: Scanning new location : "USB/080B-0044"
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:15 volumio volumio[921]: info:
Jul 15 09:28:15 volumio volumio[921]: ---------------------------- MPD announces state update: update
Jul 15 09:28:15 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:15 volumio volumio[921]: info:
Jul 15 09:28:15 volumio volumio[921]: ---------------------------- MPD announces state update: update
Jul 15 09:28:15 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:15 volumio volumio[921]: info:
Jul 15 09:28:15 volumio volumio[921]: ---------------------------- MPD announces state update: update
Jul 15 09:28:15 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:15 volumio volumio[921]: info: sendMpdCommand status took 11 milliseconds
Jul 15 09:28:15 volumio volumio[921]: info: sendMpdCommand status took 10 milliseconds
Jul 15 09:28:15 volumio volumio[921]: info: sendMpdCommand status took 9 milliseconds
Jul 15 09:28:15 volumio volumio[921]: info: sendMpdCommand status took 7 milliseconds
Jul 15 09:28:15 volumio volumio[921]: info: sendMpdCommand status took 7 milliseconds
Jul 15 09:28:15 volumio volumio[921]: info: sendMpdCommand status took 6 milliseconds
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:15 volumio volumio[921]: info: Command Router : Notfying DB Updatetrue
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:15 volumio volumio[921]: info: Command Router : Notfying DB Updatetrue
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:15 volumio volumio[921]: info: Command Router : Notfying DB Updatetrue
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:28:15 volumio volumio[921]: info: sendMpdCommand playlistinfo took 63 milliseconds
Jul 15 09:28:15 volumio volumio[921]: info: sendMpdCommand playlistinfo took 38 milliseconds
Jul 15 09:28:15 volumio volumio[921]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:28:15 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:28:15 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:28:15 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:15 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:15 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:15 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:28:15 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:28:15 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:28:15 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:28:15 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:15 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:15 volumio volumio[921]: info: No code
Jul 15 09:28:15 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:15 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:15 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:28:15 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:15 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:15 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:15 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:28:15 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:28:15 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:28:15 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:28:15 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:15 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:15 volumio volumio[921]: info: No code
Jul 15 09:28:15 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:15 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:15 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:28:15 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:15 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:15 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:15 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:28:15 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:28:15 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:28:15 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:28:15 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:15 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:15 volumio volumio[921]: info: No code
Jul 15 09:28:15 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:15 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:15 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:15 volumio volumio[921]: info: ------------------------------ 204ms
Jul 15 09:28:15 volumio volumio[921]: info: ------------------------------ 208ms
Jul 15 09:28:15 volumio volumio[921]: info: ------------------------------ 206ms
Jul 15 09:28:16 volumio kernel: usb 1-1.2: reset high-speed USB device number 25 using dwc_otg
Jul 15 09:28:16 volumio kernel: sd 1:0:0:0: [sdb] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s
Jul 15 09:28:16 volumio kernel: sd 1:0:0:0: [sdb] tag#0 CDB: opcode=0x28 28 00 00 22 3a bb 00 00 07 00
Jul 15 09:28:16 volumio kernel: I/O error, dev sdb, sector 2243259 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 3
Jul 15 09:28:16 volumio kernel: usb 1-1.2: reset high-speed USB device number 25 using dwc_otg
Jul 15 09:28:16 volumio kernel: usb 1-1.2: reset high-speed USB device number 25 using dwc_otg
Jul 15 09:28:16 volumio kernel: usb 1-1.2: reset high-speed USB device number 25 using dwc_otg
Jul 15 09:28:17 volumio kernel:
Jul 15 09:28:17 volumio kernel: WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Jul 15 09:28:17 volumio kernel: usb 1-1.2: reset high-speed USB device number 25 using dwc_otg
Jul 15 09:28:17 volumio kernel: sd 1:0:0:0: [sdb] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s
Jul 15 09:28:17 volumio kernel: sd 1:0:0:0: [sdb] tag#0 CDB: opcode=0x28 28 00 00 24 16 fb 00 00 f0 00
Jul 15 09:28:17 volumio kernel: I/O error, dev sdb, sector 2365179 op 0x0:(READ) flags 0x84700 phys_seg 3 prio class 3
Jul 15 09:28:17 volumio kernel: usb 1-1.2: reset high-speed USB device number 25 using dwc_otg
Jul 15 09:28:17 volumio kernel: sd 1:0:0:0: [sdb] Unaligned partial completion (resid=7682, sector_sz=512)
Jul 15 09:28:17 volumio kernel: sd 1:0:0:0: [sdb] tag#0 CDB: opcode=0x28 28 00 00 24 17 eb 00 00 10 00
Jul 15 09:28:17 volumio kernel: sd 1:0:0:0: [sdb] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s
Jul 15 09:28:17 volumio kernel: sd 1:0:0:0: [sdb] tag#0 CDB: opcode=0x28 28 00 00 24 17 eb 00 00 10 00
Jul 15 09:28:17 volumio kernel: I/O error, dev sdb, sector 2365419 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 3
Jul 15 09:28:17 volumio kernel: usb 1-1.2: reset high-speed USB device number 25 using dwc_otg
Jul 15 09:28:18 volumio kernel: usb 1-1.2: reset high-speed USB device number 25 using dwc_otg
Jul 15 09:28:19 volumio kernel: usb 1-1.2: reset high-speed USB device number 25 using dwc_otg
Jul 15 09:28:20 volumio kernel: usb 1-1.2: reset high-speed USB device number 25 using dwc_otg
Jul 15 09:28:21 volumio kernel: usb 1-1.2: device descriptor read/64, error -71
Jul 15 09:28:22 volumio kernel: usb 1-1.2: reset high-speed USB device number 25 using dwc_otg
Jul 15 09:28:22 volumio kernel: usb 1-1.2: reset high-speed USB device number 25 using dwc_otg
Jul 15 09:28:22 volumio kernel: usb 1-1.2: reset high-speed USB device number 25 using dwc_otg
Jul 15 09:28:22 volumio kernel: usb 1-1.2: USB disconnect, device number 25
Jul 15 09:28:22 volumio kernel: sdb: detected capacity change from 3854336 to 0
Jul 15 09:28:22 volumio kernel: device offline error, dev sdb, sector 2365179 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:22 volumio kernel: device offline error, dev sdb, sector 2365179 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:22 volumio kernel: device offline error, dev sdb, sector 2474 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:22 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2339)
Jul 15 09:28:22 volumio kernel: device offline error, dev sdb, sector 2474 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:22 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2339)
Jul 15 09:28:22 volumio kernel: device offline error, dev sdb, sector 2474 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:22 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2339)
Jul 15 09:28:22 volumio kernel: device offline error, dev sdb, sector 2474 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:22 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2339)
Jul 15 09:28:22 volumio kernel: device offline error, dev sdb, sector 2474 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:22 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2339)
Jul 15 09:28:22 volumio kernel: device offline error, dev sdb, sector 2474 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:22 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2339)
Jul 15 09:28:22 volumio kernel: device offline error, dev sdb, sector 2474 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:22 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2339)
Jul 15 09:28:22 volumio kernel: device offline error, dev sdb, sector 2474 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:22 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2339)
Jul 15 09:28:22 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2339)
Jul 15 09:28:22 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2339)
Jul 15 09:28:22 volumio volumio[921]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-Mass_Storage_Device_121220130416-0:0-part1 /dev/disk/by-uuid/080B-0044 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.2:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"46","ID_BUS":"usb","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"080B-0044","ID_FS_UUID_ENC":"080B-0044","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"Storage_Device","ID_MODEL_ENC":"Storage\\x20Device\\x20\\x20","ID_MODEL_ID":"1212","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"135","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"3854201","ID_PART_ENTRY_TYPE":"0x6","ID_PART_TABLE_TYPE":"dos","ID_PATH":"platform-3f980000.usb-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"Mass_Storage_Device_121220130416-0:0","ID_SERIAL_SHORT":"121220130416","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Mass","ID_VENDOR_ENC":"Mass\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"14cd","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"2396","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"463034019"}
Jul 15 09:28:23 volumio sudo[1966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1
Jul 15 09:28:23 volumio sudo[1966]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 09:28:23 volumio sudo[1966]: pam_unix(sudo:session): session closed for user root
Jul 15 09:28:23 volumio volumio[921]: info: MPD Database updated - AlbumList cache refreshed
Jul 15 09:28:23 volumio volumio[921]: info:
Jul 15 09:28:23 volumio volumio[921]: ---------------------------- MPD announces state update: database
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:23 volumio volumio[921]: info:
Jul 15 09:28:23 volumio volumio[921]: ---------------------------- MPD announces state update: update
Jul 15 09:28:23 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:23 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:23 volumio volumio[921]: info: MPD Database updated - AlbumList cache refreshed
Jul 15 09:28:23 volumio volumio[921]: info:
Jul 15 09:28:23 volumio volumio[921]: ---------------------------- MPD announces state update: database
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:23 volumio volumio[921]: info:
Jul 15 09:28:23 volumio volumio[921]: ---------------------------- MPD announces state update: update
Jul 15 09:28:23 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:23 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:23 volumio volumio[921]: info: MPD Database updated - AlbumList cache refreshed
Jul 15 09:28:23 volumio volumio[921]: info:
Jul 15 09:28:23 volumio volumio[921]: ---------------------------- MPD announces state update: database
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:23 volumio volumio[921]: info:
Jul 15 09:28:23 volumio volumio[921]: ---------------------------- MPD announces state update: update
Jul 15 09:28:23 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:23 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:23 volumio volumio[921]: info: sendMpdCommand status took 64 milliseconds
Jul 15 09:28:23 volumio volumio[921]: info: sendMpdCommand status took 63 milliseconds
Jul 15 09:28:23 volumio volumio[921]: info: sendMpdCommand status took 63 milliseconds
Jul 15 09:28:23 volumio volumio[921]: info: sendMpdCommand status took 62 milliseconds
Jul 15 09:28:23 volumio volumio[921]: info: sendMpdCommand status took 62 milliseconds
Jul 15 09:28:23 volumio volumio[921]: info: sendMpdCommand status took 61 milliseconds
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:23 volumio volumio[921]: info: Command Router : Notfying DB Updatefalse
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:23 volumio volumio[921]: info: Command Router : Notfying DB Updatefalse
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:28:23 volumio volumio[921]: info: sendMpdCommand status took 164 milliseconds
Jul 15 09:28:23 volumio volumio[921]: info: sendMpdCommand status took 164 milliseconds
Jul 15 09:28:23 volumio volumio[921]: info: sendMpdCommand status took 164 milliseconds
Jul 15 09:28:23 volumio volumio[921]: info: sendMpdCommand playlistinfo took 54 milliseconds
Jul 15 09:28:23 volumio volumio[921]: info: sendMpdCommand playlistinfo took 54 milliseconds
Jul 15 09:28:23 volumio volumio[921]: info: sendMpdCommand playlistinfo took 33 milliseconds
Jul 15 09:28:23 volumio volumio[921]: info: sendMpdCommand playlistinfo took 34 milliseconds
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:23 volumio volumio[921]: info: Command Router : Notfying DB Updatefalse
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:28:23 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:28:23 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: No code
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:28:23 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: No code
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio kernel: usb 1-1.2: new high-speed USB device number 26 using dwc_otg
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:28:23 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: No code
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:28:23 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: No code
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: ------------------------------ 291ms
Jul 15 09:28:23 volumio volumio[921]: info: ------------------------------ 292ms
Jul 15 09:28:23 volumio volumio[921]: info: ------------------------------ 291ms
Jul 15 09:28:23 volumio volumio[921]: info: ------------------------------ 291ms
Jul 15 09:28:23 volumio volumio[921]: info: sendMpdCommand playlistinfo took 100 milliseconds
Jul 15 09:28:23 volumio volumio[921]: info: sendMpdCommand playlistinfo took 101 milliseconds
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:28:23 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo
Jul 15 09:28:23 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:28:23 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: No code
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream2.mp3","artist":null,"album":null,"uri":"http://119.15.96.188/stream2.mp3","trackType":"mp3"}
Jul 15 09:28:23 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: No code
Jul 15 09:28:23 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:23 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:23 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:23 volumio volumio[921]: info: ------------------------------ 337ms
Jul 15 09:28:23 volumio volumio[921]: info: ------------------------------ 338ms
Jul 15 09:28:23 volumio kernel: usb 1-1.2: New USB device found, idVendor=14cd, idProduct=1212, bcdDevice= 1.00
Jul 15 09:28:23 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Jul 15 09:28:23 volumio kernel: usb 1-1.2: Product: Mass Storage Device
Jul 15 09:28:23 volumio kernel: usb 1-1.2: Manufacturer: Generic
Jul 15 09:28:23 volumio kernel: usb 1-1.2: SerialNumber: 121220130416
Jul 15 09:28:23 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected
Jul 15 09:28:23 volumio kernel: scsi host1: usb-storage 1-1.2:1.0
Jul 15 09:28:24 volumio kernel: usb 1-1.2: reset high-speed USB device number 26 using dwc_otg
Jul 15 09:28:24 volumio volumio[921]: info: CALLMETHOD: audio_interface alsa_controller saveResamplingOpts [object Object]
Jul 15 09:28:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveResamplingOpts
Jul 15 09:28:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions
Jul 15 09:28:24 volumio sudo[1978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 15 09:28:24 volumio sudo[1978]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 09:28:24 volumio sudo[1978]: pam_unix(sudo:session): session closed for user root
Jul 15 09:28:24 volumio volumio[921]: info: MPD Permissions set
Jul 15 09:28:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 09:28:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 09:28:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 09:28:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 09:28:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 09:28:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 09:28:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 09:28:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 09:28:24 volumio sudo[1981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 15 09:28:24 volumio sudo[1981]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 09:28:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 15 09:28:24 volumio systemd[1]: Stopping Music Player Daemon...
Jul 15 09:28:24 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 09:28:24 volumio kernel: scsi 1:0:0:0: Direct-Access Mass Storage Device 1.00 PQ: 0 ANSI: 0 CCS
Jul 15 09:28:24 volumio kernel: sd 1:0:0:0: Attached scsi generic sg0 type 0
Jul 15 09:28:24 volumio kernel: sd 1:0:0:0: [sdb] 3854336 512-byte logical blocks: (1.97 GB/1.84 GiB)
Jul 15 09:28:24 volumio kernel: sd 1:0:0:0: [sdb] Write Protect is off
Jul 15 09:28:24 volumio kernel: sd 1:0:0:0: [sdb] Mode Sense: 03 00 00 00
Jul 15 09:28:24 volumio kernel: sd 1:0:0:0: [sdb] No Caching mode page found
Jul 15 09:28:24 volumio kernel: sd 1:0:0:0: [sdb] Assuming drive cache: write through
Jul 15 09:28:24 volumio kernel: sdb: sdb1
Jul 15 09:28:24 volumio kernel: sd 1:0:0:0: [sdb] Attached SCSI removable disk
Jul 15 09:28:25 volumio systemd[1]: mpd.service: Succeeded.
Jul 15 09:28:25 volumio systemd[1]: Stopped Music Player Daemon.
Jul 15 09:28:25 volumio systemd[1]: Starting Music Player Daemon...
Jul 15 09:28:25 volumio sudo[1987]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 15 09:28:25 volumio sudo[1987]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 09:28:25 volumio sudo[1987]: pam_unix(sudo:session): session closed for user root
Jul 15 09:28:25 volumio volumio[921]: info: Mounting Device 080B-0044
Jul 15 09:28:25 volumio sudo[1997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/080B-0044 -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Jul 15 09:28:25 volumio sudo[1997]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 09:28:25 volumio kernel: FAT-fs (sdb1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
Jul 15 09:28:25 volumio kernel: FAT-fs (sdb1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Jul 15 09:28:25 volumio sudo[1997]: pam_unix(sudo:session): session closed for user root
Jul 15 09:28:26 volumio mpd[1996]: Jul 15 09:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 15 09:28:26 volumio systemd[1]: Started Music Player Daemon.
Jul 15 09:28:26 volumio sudo[1981]: pam_unix(sudo:session): session closed for user root
Jul 15 09:28:26 volumio volumio[921]: error: updateQueue error: null
Jul 15 09:28:27 volumio volumio[921]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/080B-0044
Jul 15 09:28:28 volumio volumio[921]: info: Scanning removed location : "USB/080B-0044"
Jul 15 09:28:28 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:28 volumio volumio[921]: info:
Jul 15 09:28:28 volumio volumio[921]: ---------------------------- MPD announces state update: update
Jul 15 09:28:28 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:28:28 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:28 volumio volumio[921]: info: sendMpdCommand status took 2 milliseconds
Jul 15 09:28:28 volumio volumio[921]: info: sendMpdCommand status took 1 milliseconds
Jul 15 09:28:28 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:28 volumio volumio[921]: info: Command Router : Notfying DB Updatetrue
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent
Jul 15 09:28:28 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:28 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:28:28 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:28 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:28 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:28 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 15 09:28:28 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:28:28 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:28:28 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:28:28 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:28 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:28 volumio volumio[921]: info: No code
Jul 15 09:28:28 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:28 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:28 volumio volumio[921]: info: ------------------------------ 76ms
Jul 15 09:28:28 volumio volumio[921]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-Mass_Storage_Device_121220130416-0:0-part1 /dev/disk/by-uuid/080B-0044 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.2:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"47","ID_BUS":"usb","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"080B-0044","ID_FS_UUID_ENC":"080B-0044","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"Storage_Device","ID_MODEL_ENC":"Storage\\x20Device\\x20\\x20","ID_MODEL_ID":"1212","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"135","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"3854201","ID_PART_ENTRY_TYPE":"0x6","ID_PART_TABLE_TYPE":"dos","ID_PATH":"platform-3f980000.usb-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"Mass_Storage_Device_121220130416-0:0","ID_SERIAL_SHORT":"121220130416","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Mass","ID_VENDOR_ENC":"Mass\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"14cd","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"2430","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"472894942"}
Jul 15 09:28:28 volumio kernel: sd 1:0:0:0: [sdb] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s
Jul 15 09:28:28 volumio kernel: sd 1:0:0:0: [sdb] tag#0 CDB: opcode=0x28 28 00 00 24 aa d3 00 00 06 00
Jul 15 09:28:28 volumio kernel: blk_print_req_error: 23 callbacks suppressed
Jul 15 09:28:28 volumio kernel: I/O error, dev sdb, sector 2403027 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 3
Jul 15 09:28:28 volumio kernel: usb 1-1.2: USB disconnect, device number 26
Jul 15 09:28:28 volumio kernel: device offline error, dev sdb, sector 2403027 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:28 volumio kernel: device offline error, dev sdb, sector 2510 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:28 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2375)
Jul 15 09:28:28 volumio kernel: device offline error, dev sdb, sector 2403035 op 0x0:(READ) flags 0x80700 phys_seg 2 prio class 3
Jul 15 09:28:28 volumio kernel: device offline error, dev sdb, sector 2510 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:28 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2375)
Jul 15 09:28:28 volumio kernel: device offline error, dev sdb, sector 2510 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:28 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2375)
Jul 15 09:28:28 volumio kernel: device offline error, dev sdb, sector 2510 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:28 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2375)
Jul 15 09:28:28 volumio kernel: device offline error, dev sdb, sector 2510 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:28 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2375)
Jul 15 09:28:28 volumio kernel: device offline error, dev sdb, sector 2510 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:28 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2375)
Jul 15 09:28:28 volumio kernel: device offline error, dev sdb, sector 2510 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 3
Jul 15 09:28:28 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2375)
Jul 15 09:28:28 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2375)
Jul 15 09:28:28 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2375)
Jul 15 09:28:28 volumio kernel: FAT-fs (sdb1): FAT read failed (blocknr 2375)
Jul 15 09:28:28 volumio sudo[2007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1
Jul 15 09:28:28 volumio sudo[2007]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 09:28:28 volumio sudo[2007]: pam_unix(sudo:session): session closed for user root
Jul 15 09:28:28 volumio volumio[921]: info: MPD Database updated - AlbumList cache refreshed
Jul 15 09:28:28 volumio volumio[921]: info:
Jul 15 09:28:28 volumio volumio[921]: ---------------------------- MPD announces state update: database
Jul 15 09:28:28 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:28 volumio volumio[921]: info:
Jul 15 09:28:28 volumio volumio[921]: ---------------------------- MPD announces state update: update
Jul 15 09:28:28 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:28:28 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:28 volumio volumio[921]: info: ControllerMpd::getState
Jul 15 09:28:28 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 09:28:28 volumio volumio[921]: info: sendMpdCommand status took 27 milliseconds
Jul 15 09:28:28 volumio volumio[921]: info: sendMpdCommand status took 26 milliseconds
Jul 15 09:28:28 volumio volumio[921]: info: sendMpdCommand status took 26 milliseconds
Jul 15 09:28:28 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:28 volumio volumio[921]: info: Command Router : Notfying DB Updatefalse
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent
Jul 15 09:28:28 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:28 volumio volumio[921]: verbose: ControllerMpd::parseState
Jul 15 09:28:28 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:28:28 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:28 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:28 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:28 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 15 09:28:28 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:28:28 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:28:28 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:28:28 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:28 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:28 volumio volumio[921]: info: No code
Jul 15 09:28:28 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:28 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:28 volumio volumio[921]: info: ControllerMpd::pushState
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::servicePushState
Jul 15 09:28:28 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:28 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:28 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:28 volumio volumio[921]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 15 09:28:28 volumio volumio[921]: verbose: CURRENT POSITION 0
Jul 15 09:28:28 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop
Jul 15 09:28:28 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop
Jul 15 09:28:28 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:28 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:28 volumio volumio[921]: info: No code
Jul 15 09:28:28 volumio volumio[921]: info: CoreStateMachine::pushState
Jul 15 09:28:28 volumio volumio[921]: info: CorePlayQueue::getTrack 0
Jul 15 09:28:28 volumio volumio[921]: info: CoreCommandRouter::volumioPushState
Jul 15 09:28:28 volumio volumio[921]: info: ------------------------------ 110ms
Jul 15 09:28:28 volumio volumio[921]: info: ------------------------------ 110ms
Jul 15 09:28:28 volumio kernel: usb 1-1.2: new high-speed USB device number 27 using dwc_otg
Jul 15 09:28:28 volumio kernel: usb 1-1.2: New USB device found, idVendor=14cd, idProduct=1212, bcdDevice= 1.00
Jul 15 09:28:28 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Jul 15 09:28:28 volumio kernel: usb 1-1.2: Product: Mass Storage Device
Jul 15 09:28:28 volumio kernel: usb 1-1.2: Manufacturer: Generic
Jul 15 09:28:28 volumio kernel: usb 1-1.2: SerialNumber: 121220130416
Jul 15 09:28:28 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected
Jul 15 09:28:28 volumio kernel: scsi host1: usb-storage 1-1.2:1.0
Jul 15 09:28:30 volumio kernel: usb 1-1.2: reset high-speed USB device number 27 using dwc_otg
Jul 15 09:28:31 volumio kernel: usb 1-1.2: reset high-speed USB device number 27 using dwc_otg
Jul 15 09:28:31 volumio kernel: usb 1-1.2: reset high-speed USB device number 27 using dwc_otg
Jul 15 09:28:32 volumio volumio[921]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/080B-0044
Jul 15 09:28:32 volumio kernel: usb 1-1.2: reset high-speed USB device number 27 using dwc_otg
Jul 15 09:28:34 volumio kernel: usb 1-1.2: USB disconnect, device number 27
Jul 15 09:28:41 volumio volumio[921]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 15 09:28:41 volumio volumio[921]: Error: connect ETIMEDOUT 157.240.13.8:443
Jul 15 09:28:41 volumio volumio[921]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) {
Jul 15 09:28:41 volumio volumio[921]: errno: -110,
Jul 15 09:28:41 volumio volumio[921]: code: 'ETIMEDOUT',
Jul 15 09:28:41 volumio volumio[921]: syscall: 'connect',
Jul 15 09:28:41 volumio volumio[921]: address: '157.240.13.8',
Jul 15 09:28:41 volumio volumio[921]: port: 443
Jul 15 09:28:41 volumio volumio[921]: }
Jul 15 09:28:41 volumio volumio[921]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 15 09:28:42 volumio sudo[2026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-15 09:27
Jul 15 09:28:42 volumio sudo[2026]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"