-- Logs begin at Thu 2019-02-14 12:12:00 IST, end at Fri 2024-07-12 14:51:43 IDT. --
Jul 12 14:50:01 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 12 14:50:01 volumio-bjgi volumio[964]: info: Received Get System Info
Jul 12 14:50:01 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 12 14:50:01 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 12 14:50:01 volumio-bjgi volumio[964]: info: Discovery: Getting this device information
Jul 12 14:50:01 volumio-bjgi volumio[964]: info: CoreCommandRouter::volumioGetState
Jul 12 14:50:01 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 12 14:50:01 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jul 12 14:50:02 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 12 14:50:02 volumio-bjgi volumio[964]: info: Received Get System Info
Jul 12 14:50:02 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 12 14:50:02 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 12 14:50:02 volumio-bjgi volumio[964]: info: Discovery: Getting this device information
Jul 12 14:50:02 volumio-bjgi volumio[964]: info: CoreCommandRouter::volumioGetState
Jul 12 14:50:02 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 12 14:50:09 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 12 14:50:18 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 12 14:50:18 volumio-bjgi volumio[964]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jul 12 14:50:18 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jul 12 14:50:18 volumio-bjgi volumio[964]: info: Received Get System Version
Jul 12 14:50:18 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 12 14:50:18 volumio-bjgi volumio[964]: info: Received Get System Info
Jul 12 14:50:18 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 12 14:50:18 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 12 14:50:18 volumio-bjgi volumio[964]: info: Discovery: Getting this device information
Jul 12 14:50:18 volumio-bjgi volumio[964]: info: CoreCommandRouter::volumioGetState
Jul 12 14:50:18 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 12 14:50:23 volumio-bjgi kernel: hwmon hwmon1: Voltage normalised
Jul 12 14:50:25 volumio-bjgi kernel: hwmon hwmon1: Undervoltage detected!
Jul 12 14:50:33 volumio-bjgi kernel: hwmon hwmon1: Voltage normalised
Jul 12 14:50:35 volumio-bjgi volumiologrotate[527]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory
Jul 12 14:50:35 volumio-bjgi volumiologrotate[527]: ls: cannot access 'BJGI': No such file or directory
Jul 12 14:50:36 volumio-bjgi kernel: hwmon hwmon1: Undervoltage detected!
Jul 12 14:50:49 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 12 14:50:49 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 12 14:50:49 volumio-bjgi volumio[964]: info: Discovery: Getting this device information
Jul 12 14:50:49 volumio-bjgi volumio[964]: info: CoreCommandRouter::volumioGetState
Jul 12 14:50:49 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 12 14:50:51 volumio-bjgi volumio[964]: info: CoreCommandRouter::volumioGetQueue
Jul 12 14:50:51 volumio-bjgi volumio[964]: info: CoreStateMachine::getQueue
Jul 12 14:50:51 volumio-bjgi volumio[964]: info: CorePlayQueue::getQueue
Jul 12 14:50:52 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 12 14:50:52 volumio-bjgi volumio[964]: info: CURURI: music-library/USB
Jul 12 14:50:57 volumio-bjgi volumio[964]: info: Preload queue cleared
Jul 12 14:50:57 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 12 14:50:57 volumio-bjgi volumio[964]: info: CURURI: music-library/USB/Новый_том
Jul 12 14:50:57 volumio-bjgi volumio[964]: info: Preload queue cleared
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreStateMachine::ClearQueue
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreStateMachine::stop
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreStateMachine::serviceStop
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreCommandRouter::serviceStop
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CorePlayQueue::clearPlayQueue
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CorePlayQueue::saveQueue
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreCommandRouter::volumioPushQueue
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreStateMachine::addQueueItems
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CorePlayQueue::addQueueItems
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: Preload queue cleared
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: Adding Item to queue: music-library/USB/Новый_том/a-ha - Hunting High & Low [24-192]
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: Exploding uri music-library/USB/Новый_том/a-ha - Hunting High & Low [24-192] in service mpd
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: PlaybackInactive
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: Device Session is_active: true
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: DeviceInactive
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: Relinquishing Volumio State
Jul 12 14:51:06 volumio-bjgi volumio[964]: verbose: UNSET VOLATILE: Service: tidalconnect
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: unSetVolatile called
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: Relinquishing Volumio State to another service
Jul 12 14:51:06 volumio-bjgi vtcs[1521]: [2024-07-12 14:51:06.874] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE
Jul 12 14:51:06 volumio-bjgi vtcs[1521]: [2024-07-12 14:51:06] [info] asio async_shutdown error: asio.misc:2 (End of file)
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: ALBUMART /albumart?cacheid=909&web=a-ha/Hunting%20High%20%26%20Low/extralarge&path=%2Fmnt%2FUSB%2F%D0%9D%D0%BE%D0%B2%D1%8B%D0%B9_%D1%82%D0%BE%D0%BC%2Fa-ha%20-%20Hunting%20High%20%26%20Low%20%5B24-192%5D%2F01-Take%20On%20Me%20(2015%20Remastered%20Version).flac&metadata=false
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: URI /mnt/USB/Новый_том/a-ha - Hunting High & Low [24-192]/01-Take On Me (2015 Remastered Version).flac
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: ALBUMART /albumart?cacheid=909&web=a-ha/Hunting%20High%20%26%20Low/extralarge&path=%2Fmnt%2FUSB%2F%D0%9D%D0%BE%D0%B2%D1%8B%D0%B9_%D1%82%D0%BE%D0%BC%2Fa-ha%20-%20Hunting%20High%20%26%20Low%20%5B24-192%5D%2F02-Train%20Of%20Thought%20(2015%20Remastered%20Version).flac&metadata=false
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: URI /mnt/USB/Новый_том/a-ha - Hunting High & Low [24-192]/02-Train Of Thought (2015 Remastered Version).flac
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: ALBUMART /albumart?cacheid=909&web=a-ha/Hunting%20High%20%26%20Low/extralarge&path=%2Fmnt%2FUSB%2F%D0%9D%D0%BE%D0%B2%D1%8B%D0%B9_%D1%82%D0%BE%D0%BC%2Fa-ha%20-%20Hunting%20High%20%26%20Low%20%5B24-192%5D%2F03-Hunting%20High%20And%20Low%20(2015%20Remastered%20Version).flac&metadata=false
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: URI /mnt/USB/Новый_том/a-ha - Hunting High & Low [24-192]/03-Hunting High And Low (2015 Remastered Version).flac
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: ALBUMART /albumart?cacheid=909&web=a-ha/Hunting%20High%20%26%20Low/extralarge&path=%2Fmnt%2FUSB%2F%D0%9D%D0%BE%D0%B2%D1%8B%D0%B9_%D1%82%D0%BE%D0%BC%2Fa-ha%20-%20Hunting%20High%20%26%20Low%20%5B24-192%5D%2F04-The%20Blue%20Sky%20(2015%20Remastered%20Version).flac&metadata=false
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: URI /mnt/USB/Новый_том/a-ha - Hunting High & Low [24-192]/04-The Blue Sky (2015 Remastered Version).flac
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: ALBUMART /albumart?cacheid=909&web=a-ha/Hunting%20High%20%26%20Low/extralarge&path=%2Fmnt%2FUSB%2F%D0%9D%D0%BE%D0%B2%D1%8B%D0%B9_%D1%82%D0%BE%D0%BC%2Fa-ha%20-%20Hunting%20High%20%26%20Low%20%5B24-192%5D%2F05-Living%20A%20Boy's%20Adventure%20Tale%20(2015%20Remastered%20Version).flac&metadata=false
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: URI /mnt/USB/Новый_том/a-ha - Hunting High & Low [24-192]/05-Living A Boy's Adventure Tale (2015 Remastered Version).flac
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: ALBUMART /albumart?cacheid=909&web=a-ha/Hunting%20High%20%26%20Low/extralarge&path=%2Fmnt%2FUSB%2F%D0%9D%D0%BE%D0%B2%D1%8B%D0%B9_%D1%82%D0%BE%D0%BC%2Fa-ha%20-%20Hunting%20High%20%26%20Low%20%5B24-192%5D%2F06-The%20Sun%20Always%20Shines%20On%20T.V.%20(2015%20Remastered%20Version).flac&metadata=false
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: URI /mnt/USB/Новый_том/a-ha - Hunting High & Low [24-192]/06-The Sun Always Shines On T.V. (2015 Remastered Version).flac
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: ALBUMART /albumart?cacheid=909&web=a-ha/Hunting%20High%20%26%20Low/extralarge&path=%2Fmnt%2FUSB%2F%D0%9D%D0%BE%D0%B2%D1%8B%D0%B9_%D1%82%D0%BE%D0%BC%2Fa-ha%20-%20Hunting%20High%20%26%20Low%20%5B24-192%5D%2F07-And%20You%20Tell%20Me%20(2015%20Remastered%20Version).flac&metadata=false
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: URI /mnt/USB/Новый_том/a-ha - Hunting High & Low [24-192]/07-And You Tell Me (2015 Remastered Version).flac
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: ALBUMART /albumart?cacheid=909&web=a-ha/Hunting%20High%20%26%20Low/extralarge&path=%2Fmnt%2FUSB%2F%D0%9D%D0%BE%D0%B2%D1%8B%D0%B9_%D1%82%D0%BE%D0%BC%2Fa-ha%20-%20Hunting%20High%20%26%20Low%20%5B24-192%5D%2F08-Love%20Is%20Reason%20(2015%20Remastered%20Version).flac&metadata=false
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: URI /mnt/USB/Новый_том/a-ha - Hunting High & Low [24-192]/08-Love Is Reason (2015 Remastered Version).flac
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: ALBUMART /albumart?cacheid=909&web=a-ha/Hunting%20High%20%26%20Low/extralarge&path=%2Fmnt%2FUSB%2F%D0%9D%D0%BE%D0%B2%D1%8B%D0%B9_%D1%82%D0%BE%D0%BC%2Fa-ha%20-%20Hunting%20High%20%26%20Low%20%5B24-192%5D%2F09-I%20Dream%20Myself%20Alive%20(2015%20Remastered%20Version).flac&metadata=false
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: URI /mnt/USB/Новый_том/a-ha - Hunting High & Low [24-192]/09-I Dream Myself Alive (2015 Remastered Version).flac
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: ALBUMART /albumart?cacheid=909&web=a-ha/Hunting%20High%20%26%20Low/extralarge&path=%2Fmnt%2FUSB%2F%D0%9D%D0%BE%D0%B2%D1%8B%D0%B9_%D1%82%D0%BE%D0%BC%2Fa-ha%20-%20Hunting%20High%20%26%20Low%20%5B24-192%5D%2F10-Here%20I%20Stand%20And%20Face%20The%20Rain%20(2015%20Remastered%20Version).flac&metadata=false
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: URI /mnt/USB/Новый_том/a-ha - Hunting High & Low [24-192]/10-Here I Stand And Face The Rain (2015 Remastered Version).flac
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreCommandRouter::volumioPushQueue
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CorePlayQueue::saveQueue
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreStateMachine::updateTrackBlock
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CorePlayQueue::getTrackBlock
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreCommandRouter::volumioPlay
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreStateMachine::play index 0
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreStateMachine::stop
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreStateMachine::updateTrackBlock
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CorePlayQueue::getTrackBlock
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreStateMachine::stPlaybackTimer
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreStateMachine::pushState
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CorePlayQueue::getTrack 0
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreCommandRouter::volumioPushState
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: MRS: Pushing multiroomSync output update for this device
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: MRS: Pushing multiroomSync output
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreStateMachine::serviceStop
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CorePlayQueue::getTrack 0
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: CoreCommandRouter::serviceStop
Jul 12 14:51:06 volumio-bjgi volumio[964]: info: ControllerMpd::stop
Jul 12 14:51:06 volumio-bjgi volumio[964]: verbose: ControllerMpd::sendMpdCommand stop
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: sendMpdCommand stop took 14 milliseconds
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CoreStateMachine::play index undefined
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CorePlayQueue::getTrack 0
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CoreStateMachine::startPlaybackTimer
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CorePlayQueue::getTrack 0
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: ControllerMpd::clearAddPlayTracks USB/Новый_том/a-ha - Hunting High & Low [24-192]/01-Take On Me (2015 Remastered Version).flac
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: ControllerMpd::sendMpdCommand stop
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: sendMpdCommand stop took 5 milliseconds
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: ControllerMpd::sendMpdCommand clear
Jul 12 14:51:07 volumio-bjgi volumio[964]: info:
Jul 12 14:51:07 volumio-bjgi volumio[964]: ---------------------------- MPD announces system playlist update
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: Ignoring MPD Status Update
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: sendMpdCommand clear took 19 milliseconds
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: ControllerMpd::sendMpdCommand add "USB/Новый_том/a-ha - Hunting High & Low [24-192]/01-Take On Me (2015 Remastered Version).flac"
Jul 12 14:51:07 volumio-bjgi volumio[964]: error: updateQueue error: null
Jul 12 14:51:07 volumio-bjgi volumio[964]: info:
Jul 12 14:51:07 volumio-bjgi volumio[964]: ---------------------------- MPD announces system playlist update
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: Ignoring MPD Status Update
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: ------------------------------ 30ms
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: sendMpdCommand add "USB/Новый_том/a-ha - Hunting High & Low [24-192]/01-Take On Me (2015 Remastered Version).flac" took 24 milliseconds
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: ControllerMpd::sendMpdCommand play
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: ------------------------------ 20ms
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: sendMpdCommand play took 15 milliseconds
Jul 12 14:51:07 volumio-bjgi volumio[964]: info:
Jul 12 14:51:07 volumio-bjgi volumio[964]: ---------------------------- MPD announces state update: player
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: ControllerMpd::getState
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: ControllerMpd::sendMpdCommand status
Jul 12 14:51:07 volumio-bjgi volumio[964]: info:
Jul 12 14:51:07 volumio-bjgi volumio[964]: ---------------------------- MPD announces state update: player
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: sendMpdCommand status took 120 milliseconds
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: ControllerMpd::getState
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: ControllerMpd::sendMpdCommand status
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: ControllerMpd::parseState
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: FusionDsp - ---- read samplerate from file: 44100
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: camilladsp stopping service pid 2940...
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: camilladsp service terminated, instance 1
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: FusionDsp - Effects disabled
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: camilladsp service started and running in background, instance 1
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: sendMpdCommand status took 203 milliseconds
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: sendMpdCommand playlistinfo took 197 milliseconds
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: ControllerMpd::parseState
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: ControllerMpd::parseTrackInfo
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: ControllerMpd::pushState
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CoreCommandRouter::servicePushState
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CorePlayQueue::getTrack 0
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Take On Me (2015 Remastered Version)","artist":"a-ha","album":"Hunting High & Low","uri":"USB/Новый_том/a-ha - Hunting High & Low [24-192]/01-Take On Me (2015 Remastered Version).flac","trackType":"flac"}
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: CURRENT POSITION 0
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CoreStateMachine::syncState stateService play
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CoreStateMachine::syncState currentStatus stop
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: ------------------------------ 341ms
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: sendMpdCommand playlistinfo took 88 milliseconds
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: ControllerMpd::parseTrackInfo
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: ControllerMpd::pushState
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CoreCommandRouter::servicePushState
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CorePlayQueue::getTrack 0
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: STATE SERVICE {"status":"play","position":0,"seek":39,"duration":228,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5341 Kbps","isStreaming":false,"title":"Take On Me (2015 Remastered Version)","artist":"a-ha","album":"Hunting High & Low","uri":"USB/Новый_том/a-ha - Hunting High & Low [24-192]/01-Take On Me (2015 Remastered Version).flac","trackType":"flac"}
Jul 12 14:51:07 volumio-bjgi volumio[964]: verbose: CURRENT POSITION 0
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CoreStateMachine::syncState stateService play
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CoreStateMachine::syncState currentStatus play
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: Received an update from plugin. extracting info from payload
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CoreStateMachine::pushState
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CorePlayQueue::getTrack 0
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CoreCommandRouter::volumioPushState
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: MRS: Pushing multiroomSync output update for this device
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: MRS: Pushing multiroomSync output
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CoreStateMachine::pushState
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CorePlayQueue::getTrack 0
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: CoreCommandRouter::volumioPushState
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: MRS: Pushing multiroomSync output update for this device
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: MRS: Pushing multiroomSync output
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: ------------------------------ 364ms
Jul 12 14:51:07 volumio-bjgi volumio[964]: info: camilladsp spawned new process with pid 3599, instance 1, run: true
Jul 12 14:51:07 volumio-bjgi kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
Jul 12 14:51:32 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 12 14:51:32 volumio-bjgi volumio[964]: info: CURURI: music-library/USB/Новый_том/Carpenters – 1983 – Voice of the Heart (A&M 38XB-4)
Jul 12 14:51:32 volumio-bjgi volumio[964]: info: Preload queue cleared
Jul 12 14:51:35 volumio-bjgi volumiologrotate[527]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory
Jul 12 14:51:35 volumio-bjgi volumiologrotate[527]: ls: cannot access 'BJGI': No such file or directory
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CoreStateMachine::ClearQueue
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CoreStateMachine::stop
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CoreStateMachine::stPlaybackTimer
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CoreStateMachine::updateTrackBlock
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CorePlayQueue::getTrackBlock
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CoreStateMachine::pushState
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CorePlayQueue::getTrack 0
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CoreCommandRouter::volumioPushState
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: MRS: Pushing multiroomSync output update for this device
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: MRS: Pushing multiroomSync output
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CoreStateMachine::serviceStop
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CorePlayQueue::getTrack 0
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CoreCommandRouter::serviceStop
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: ControllerMpd::stop
Jul 12 14:51:42 volumio-bjgi volumio[964]: verbose: ControllerMpd::sendMpdCommand stop
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CorePlayQueue::clearPlayQueue
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CorePlayQueue::saveQueue
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CoreCommandRouter::volumioPushQueue
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CoreStateMachine::addQueueItems
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: CorePlayQueue::addQueueItems
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: Preload queue cleared
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: Adding Item to queue: music-library/USB/Новый_том/Carpenters – 1983 – Voice of the Heart (A&M 38XB-4)
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: Exploding uri music-library/USB/Новый_том/Carpenters – 1983 – Voice of the Heart (A&M 38XB-4) in service mpd
Jul 12 14:51:42 volumio-bjgi volumio[964]: info:
Jul 12 14:51:42 volumio-bjgi volumio[964]: ---------------------------- MPD announces state update: player
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: ALBUMART /albumart?cacheid=909&web=Carpenters/Voice%20of%20the%20Heart/extralarge&path=%2Fmnt%2FUSB%2F%D0%9D%D0%BE%D0%B2%D1%8B%D0%B9_%D1%82%D0%BE%D0%BC%2FCarpenters%20%E2%80%93%201983%20%E2%80%93%20Voice%20of%20the%20Heart%20(A%26M%2038XB-4)%2FVoice%20of%20the%20Heart.cue&metadata=false
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: URI /mnt/USB/Новый_том/Carpenters – 1983 – Voice of the Heart (A&M 38XB-4)/Voice of the Heart.cue
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: ALBUMART /albumart?cacheid=909&web=Carpenters/Voice%20of%20the%20Heart/extralarge&path=%2Fmnt%2FUSB%2F%D0%9D%D0%BE%D0%B2%D1%8B%D0%B9_%D1%82%D0%BE%D0%BC%2FCarpenters%20%E2%80%93%201983%20%E2%80%93%20Voice%20of%20the%20Heart%20(A%26M%2038XB-4)%2FVoice%20of%20the%20Heart.cue&metadata=false
Jul 12 14:51:42 volumio-bjgi volumio[964]: info: URI /mnt/USB/Новый_том/Carpenters – 1983 – Voice of the Heart (A&M 38XB-4)/Voice of the Heart.cue
Jul 12 14:51:42 volumio-bjgi volumio[964]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 12 14:51:42 volumio-bjgi volumio[964]: Error: Unable to resolve or reject the same promise twice
Jul 12 14:51:42 volumio-bjgi volumio[964]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Jul 12 14:51:42 volumio-bjgi volumio[964]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21
Jul 12 14:51:42 volumio-bjgi volumio[964]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Jul 12 14:51:42 volumio-bjgi volumio[964]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Jul 12 14:51:42 volumio-bjgi volumio[964]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Jul 12 14:51:42 volumio-bjgi volumio[964]: at Socket.emit (events.js:315:20)
Jul 12 14:51:42 volumio-bjgi volumio[964]: at addChunk (internal/streams/readable.js:309:12)
Jul 12 14:51:42 volumio-bjgi volumio[964]: at readableAddChunk (internal/streams/readable.js:280:11)
Jul 12 14:51:42 volumio-bjgi volumio[964]: at Socket.Readable.push (internal/streams/readable.js:223:10)
Jul 12 14:51:42 volumio-bjgi volumio[964]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23)
Jul 12 14:51:42 volumio-bjgi volumio[964]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 12 14:51:43 volumio-bjgi sudo[3657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-12 14:50
Jul 12 14:51:43 volumio-bjgi sudo[3657]: 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"