-- Logs begin at Thu 2019-02-14 19:11:59 KST, end at Sat 2025-06-28 14:04:36 KST. -- Jun 28 14:03:01 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 28 14:03:01 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 28 14:03:01 volumio volumio[2102]: info: Discovery: Getting this device information Jun 28 14:03:01 volumio volumio[2102]: info: CoreCommandRouter::volumioGetState Jun 28 14:03:01 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:01 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 28 14:03:06 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 28 14:03:06 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 28 14:03:06 volumio volumio[2102]: info: Discovery: Getting this device information Jun 28 14:03:06 volumio volumio[2102]: info: CoreCommandRouter::volumioGetState Jun 28 14:03:06 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:06 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 28 14:03:06 volumio volumio[2102]: verbose: New Socket.io Connection to 192.168.0.10:3000 from 192.168.0.36 UA: Dart/3.5 (dart:io) Total Clients: 11 Jun 28 14:03:06 volumio volumio[2102]: info: CoreCommandRouter::volumioGetState Jun 28 14:03:06 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:06 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 28 14:03:06 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 28 14:03:06 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 28 14:03:06 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 28 14:03:06 volumio volumio[2102]: info: Discovery: Getting this device information Jun 28 14:03:06 volumio volumio[2102]: info: CoreCommandRouter::volumioGetState Jun 28 14:03:06 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:06 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 28 14:03:07 volumio volumio[2102]: info: CoreCommandRouter::volumioGetState Jun 28 14:03:07 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:08 volumio sudo[4623]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 28 14:03:08 volumio sudo[4621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 28 14:03:08 volumio sudo[4621]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 14:03:08 volumio sudo[4623]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 14:03:08 volumio sudo[4623]: pam_unix(sudo:session): session closed for user root Jun 28 14:03:08 volumio sudo[4621]: pam_unix(sudo:session): session closed for user root Jun 28 14:03:08 volumio volumio[2102]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.36 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 12 Jun 28 14:03:08 volumio sudo[4627]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 28 14:03:08 volumio sudo[4627]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 14:03:09 volumio sudo[4627]: pam_unix(sudo:session): session closed for user root Jun 28 14:03:09 volumio sudo[4630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 28 14:03:09 volumio sudo[4630]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 14:03:09 volumio sudo[4630]: pam_unix(sudo:session): session closed for user root Jun 28 14:03:09 volumio volumio[2102]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.36 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 13 Jun 28 14:03:09 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 28 14:03:09 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 28 14:03:09 volumio volumio[2102]: info: CoreCommandRouter::volumioGetVisibleSources Jun 28 14:03:09 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 28 14:03:09 volumio volumio[2102]: info: CoreCommandRouter::volumioGetState Jun 28 14:03:09 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:09 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 28 14:03:09 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 28 14:03:09 volumio volumio[2102]: info: Received Get System Info Jun 28 14:03:09 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 28 14:03:09 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 28 14:03:09 volumio volumio[2102]: info: Discovery: Getting this device information Jun 28 14:03:09 volumio volumio[2102]: info: CoreCommandRouter::volumioGetState Jun 28 14:03:09 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:09 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 28 14:03:09 volumio volumio[2102]: info: CoreCommandRouter::volumioGetState Jun 28 14:03:09 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:09 volumio volumio[2102]: info: Listing playlists Jun 28 14:03:09 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 28 14:03:09 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 28 14:03:10 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 28 14:03:10 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 28 14:03:10 volumio volumio[2102]: info: Received Get System Info Jun 28 14:03:10 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 28 14:03:10 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 28 14:03:10 volumio volumio[2102]: info: Discovery: Getting this device information Jun 28 14:03:10 volumio volumio[2102]: info: CoreCommandRouter::volumioGetState Jun 28 14:03:10 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:10 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 28 14:03:11 volumio volumio[2102]: info: CoreCommandRouter::volumioGetQueue Jun 28 14:03:11 volumio volumio[2102]: info: CoreStateMachine::getQueue Jun 28 14:03:11 volumio volumio[2102]: info: CorePlayQueue::getQueue Jun 28 14:03:12 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 28 14:03:12 volumio volumio[2102]: info: Received Get System Info Jun 28 14:03:12 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 28 14:03:12 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 28 14:03:12 volumio volumio[2102]: info: Discovery: Getting this device information Jun 28 14:03:12 volumio volumio[2102]: info: CoreCommandRouter::volumioGetState Jun 28 14:03:12 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:12 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 28 14:03:20 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand update Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:20 volumio volumio[2102]: info: Jun 28 14:03:20 volumio volumio[2102]: ---------------------------- MPD announces state update: update Jun 28 14:03:20 volumio volumio[2102]: info: sendMpdCommand update took 9 milliseconds Jun 28 14:03:20 volumio volumio[2102]: info: ControllerMpd::getState Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:20 volumio volumio[2102]: info: Jun 28 14:03:20 volumio volumio[2102]: ---------------------------- MPD announces state update: update Jun 28 14:03:20 volumio volumio[2102]: info: ControllerMpd::getState Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:20 volumio volumio[2102]: info: Jun 28 14:03:20 volumio volumio[2102]: ---------------------------- MPD announces state update: update Jun 28 14:03:20 volumio volumio[2102]: info: ControllerMpd::getState Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:20 volumio volumio[2102]: info: sendMpdCommand status took 12 milliseconds Jun 28 14:03:20 volumio volumio[2102]: info: sendMpdCommand status took 10 milliseconds Jun 28 14:03:20 volumio volumio[2102]: info: sendMpdCommand status took 9 milliseconds Jun 28 14:03:20 volumio volumio[2102]: info: sendMpdCommand status took 7 milliseconds Jun 28 14:03:20 volumio volumio[2102]: info: sendMpdCommand status took 7 milliseconds Jun 28 14:03:20 volumio volumio[2102]: info: sendMpdCommand status took 5 milliseconds Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:20 volumio volumio[2102]: info: Command Router : Notfying DB Updatetrue Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:20 volumio volumio[2102]: info: Command Router : Notfying DB Updatetrue Jun 28 14:03:20 volumio volumio[2102]: info: CoreCommandRouter::Close All Modals sent Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:20 volumio volumio[2102]: info: Command Router : Notfying DB Updatetrue Jun 28 14:03:20 volumio volumio[2102]: info: CoreCommandRouter::Close All Modals sent Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 14:03:20 volumio volumio[2102]: info: sendMpdCommand playlistinfo took 149 milliseconds Jun 28 14:03:20 volumio volumio[2102]: info: sendMpdCommand playlistinfo took 80 milliseconds Jun 28 14:03:20 volumio volumio[2102]: info: sendMpdCommand playlistinfo took 16 milliseconds Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::parseTrackInfo Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::parseTrackInfo Jun 28 14:03:20 volumio volumio[2102]: verbose: ControllerMpd::parseTrackInfo Jun 28 14:03:20 volumio volumio[2102]: info: ControllerMpd::pushState Jun 28 14:03:20 volumio volumio[2102]: info: CoreCommandRouter::servicePushState Jun 28 14:03:20 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:20 volumio volumio[2102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":79941,"duration":114,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track12","artist":null,"album":null,"uri":"NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 12. Moja pieszczotka (Mia diletta - 1837).ape","trackType":"ape"} Jun 28 14:03:20 volumio volumio[2102]: verbose: CURRENT POSITION 7 Jun 28 14:03:20 volumio volumio[2102]: info: CoreStateMachine::syncState stateService play Jun 28 14:03:20 volumio volumio[2102]: info: CoreStateMachine::syncState currentStatus play Jun 28 14:03:20 volumio volumio[2102]: info: Received an update from plugin. extracting info from payload Jun 28 14:03:20 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:20 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:20 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 14:03:20 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:20 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:20 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:20 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:20 volumio volumio[2102]: info: ControllerMpd::pushState Jun 28 14:03:20 volumio volumio[2102]: info: CoreCommandRouter::servicePushState Jun 28 14:03:20 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:20 volumio volumio[2102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":79941,"duration":114,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track12","artist":null,"album":null,"uri":"NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 12. Moja pieszczotka (Mia diletta - 1837).ape","trackType":"ape"} Jun 28 14:03:20 volumio volumio[2102]: verbose: CURRENT POSITION 7 Jun 28 14:03:20 volumio volumio[2102]: info: CoreStateMachine::syncState stateService play Jun 28 14:03:20 volumio volumio[2102]: info: CoreStateMachine::syncState currentStatus play Jun 28 14:03:20 volumio volumio[2102]: info: Received an update from plugin. extracting info from payload Jun 28 14:03:20 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:20 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:20 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:20 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:20 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:20 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:20 volumio volumio[2102]: info: ControllerMpd::pushState Jun 28 14:03:20 volumio volumio[2102]: info: CoreCommandRouter::servicePushState Jun 28 14:03:20 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:20 volumio volumio[2102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":79941,"duration":114,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track12","artist":null,"album":null,"uri":"NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 12. Moja pieszczotka (Mia diletta - 1837).ape","trackType":"ape"} Jun 28 14:03:20 volumio volumio[2102]: verbose: CURRENT POSITION 7 Jun 28 14:03:20 volumio volumio[2102]: info: CoreStateMachine::syncState stateService play Jun 28 14:03:20 volumio volumio[2102]: info: CoreStateMachine::syncState currentStatus play Jun 28 14:03:20 volumio volumio[2102]: info: Received an update from plugin. extracting info from payload Jun 28 14:03:20 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:20 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:20 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:20 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:20 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:20 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:20 volumio volumio[2102]: info: ------------------------------ 381ms Jun 28 14:03:20 volumio volumio[2102]: info: ------------------------------ 379ms Jun 28 14:03:20 volumio volumio[2102]: info: ------------------------------ 377ms Jun 28 14:03:24 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 28 14:03:24 volumio volumio[2102]: info: CURURI: music-library/NAS/Bitsori_Music/Classic Jun 28 14:03:24 volumio volumio[2102]: info: Preload queue cleared Jun 28 14:03:27 volumio volumio[2102]: info: MPD Database updated - AlbumList cache refreshed Jun 28 14:03:27 volumio volumio[2102]: info: Jun 28 14:03:27 volumio volumio[2102]: ---------------------------- MPD announces state update: database Jun 28 14:03:27 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:27 volumio volumio[2102]: info: Jun 28 14:03:27 volumio volumio[2102]: ---------------------------- MPD announces state update: update Jun 28 14:03:27 volumio volumio[2102]: info: ControllerMpd::getState Jun 28 14:03:27 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:27 volumio volumio[2102]: info: ControllerMpd::getState Jun 28 14:03:27 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:27 volumio volumio[2102]: info: MPD Database updated - AlbumList cache refreshed Jun 28 14:03:27 volumio volumio[2102]: info: Jun 28 14:03:27 volumio volumio[2102]: ---------------------------- MPD announces state update: database Jun 28 14:03:27 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:27 volumio volumio[2102]: info: Jun 28 14:03:27 volumio volumio[2102]: ---------------------------- MPD announces state update: update Jun 28 14:03:27 volumio volumio[2102]: info: ControllerMpd::getState Jun 28 14:03:27 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:27 volumio volumio[2102]: info: ControllerMpd::getState Jun 28 14:03:27 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:27 volumio volumio[2102]: info: MPD Database updated - AlbumList cache refreshed Jun 28 14:03:27 volumio volumio[2102]: info: Jun 28 14:03:27 volumio volumio[2102]: ---------------------------- MPD announces state update: database Jun 28 14:03:27 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:27 volumio volumio[2102]: info: Jun 28 14:03:27 volumio volumio[2102]: ---------------------------- MPD announces state update: update Jun 28 14:03:27 volumio volumio[2102]: info: ControllerMpd::getState Jun 28 14:03:27 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:27 volumio volumio[2102]: info: ControllerMpd::getState Jun 28 14:03:27 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:28 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 28 14:03:28 volumio volumio[2102]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 28 14:03:28 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 28 14:03:29 volumio volumio[2102]: info: sendMpdCommand status took 1810 milliseconds Jun 28 14:03:29 volumio volumio[2102]: info: sendMpdCommand status took 1808 milliseconds Jun 28 14:03:29 volumio volumio[2102]: info: sendMpdCommand status took 1807 milliseconds Jun 28 14:03:29 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:29 volumio volumio[2102]: info: Command Router : Notfying DB Updatefalse Jun 28 14:03:29 volumio volumio[2102]: info: CoreCommandRouter::Close All Modals sent Jun 28 14:03:29 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:29 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 14:03:29 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:29 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 14:03:29 volumio volumio[2102]: info: Received Get System Version Jun 28 14:03:29 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 28 14:03:30 volumio volumio[2102]: info: sendMpdCommand status took 2945 milliseconds Jun 28 14:03:30 volumio volumio[2102]: info: sendMpdCommand status took 2942 milliseconds Jun 28 14:03:30 volumio volumio[2102]: info: sendMpdCommand status took 2940 milliseconds Jun 28 14:03:30 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:30 volumio volumio[2102]: info: Command Router : Notfying DB Updatefalse Jun 28 14:03:30 volumio volumio[2102]: info: CoreCommandRouter::Close All Modals sent Jun 28 14:03:30 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:30 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 14:03:30 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:30 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 14:03:30 volumio volumio[2102]: info: Received Get System Info Jun 28 14:03:30 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 28 14:03:30 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 28 14:03:30 volumio volumio[2102]: info: Discovery: Getting this device information Jun 28 14:03:30 volumio volumio[2102]: info: CoreCommandRouter::volumioGetState Jun 28 14:03:30 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:30 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 28 14:03:31 volumio volumio[2102]: info: sendMpdCommand status took 3938 milliseconds Jun 28 14:03:31 volumio volumio[2102]: info: sendMpdCommand status took 3936 milliseconds Jun 28 14:03:31 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:31 volumio volumio[2102]: info: Command Router : Notfying DB Updatefalse Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::Close All Modals sent Jun 28 14:03:31 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:31 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 14:03:31 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:31 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 14:03:31 volumio volumio[2102]: info: sendMpdCommand playlistinfo took 2084 milliseconds Jun 28 14:03:31 volumio volumio[2102]: info: sendMpdCommand playlistinfo took 2083 milliseconds Jun 28 14:03:31 volumio volumio[2102]: info: sendMpdCommand playlistinfo took 1026 milliseconds Jun 28 14:03:31 volumio volumio[2102]: info: sendMpdCommand playlistinfo took 1027 milliseconds Jun 28 14:03:31 volumio volumio[2102]: verbose: ControllerMpd::parseTrackInfo Jun 28 14:03:31 volumio volumio[2102]: verbose: ControllerMpd::parseTrackInfo Jun 28 14:03:31 volumio volumio[2102]: verbose: ControllerMpd::parseTrackInfo Jun 28 14:03:31 volumio volumio[2102]: verbose: ControllerMpd::parseTrackInfo Jun 28 14:03:31 volumio volumio[2102]: info: ControllerMpd::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::servicePushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":87538,"duration":114,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track12","artist":null,"album":null,"uri":"NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 12. Moja pieszczotka (Mia diletta - 1837).ape","trackType":"ape"} Jun 28 14:03:31 volumio volumio[2102]: verbose: CURRENT POSITION 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::syncState stateService play Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::syncState currentStatus play Jun 28 14:03:31 volumio volumio[2102]: info: Received an update from plugin. extracting info from payload Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:31 volumio volumio[2102]: info: ControllerMpd::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::servicePushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":87538,"duration":114,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track12","artist":null,"album":null,"uri":"NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 12. Moja pieszczotka (Mia diletta - 1837).ape","trackType":"ape"} Jun 28 14:03:31 volumio volumio[2102]: verbose: CURRENT POSITION 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::syncState stateService play Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::syncState currentStatus play Jun 28 14:03:31 volumio volumio[2102]: info: Received an update from plugin. extracting info from payload Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:31 volumio volumio[2102]: info: ControllerMpd::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::servicePushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":87721,"duration":114,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track12","artist":null,"album":null,"uri":"NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 12. Moja pieszczotka (Mia diletta - 1837).ape","trackType":"ape"} Jun 28 14:03:31 volumio volumio[2102]: verbose: CURRENT POSITION 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::syncState stateService play Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::syncState currentStatus play Jun 28 14:03:31 volumio volumio[2102]: info: Received an update from plugin. extracting info from payload Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:31 volumio volumio[2102]: info: ControllerMpd::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::servicePushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":87721,"duration":114,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track12","artist":null,"album":null,"uri":"NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 12. Moja pieszczotka (Mia diletta - 1837).ape","trackType":"ape"} Jun 28 14:03:31 volumio volumio[2102]: verbose: CURRENT POSITION 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::syncState stateService play Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::syncState currentStatus play Jun 28 14:03:31 volumio volumio[2102]: info: Received an update from plugin. extracting info from payload Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:31 volumio volumio[2102]: info: ------------------------------ 4134ms Jun 28 14:03:31 volumio volumio[2102]: info: ------------------------------ 4133ms Jun 28 14:03:31 volumio volumio[2102]: info: ------------------------------ 4127ms Jun 28 14:03:31 volumio volumio[2102]: info: ------------------------------ 4127ms Jun 28 14:03:31 volumio volumio[2102]: info: sendMpdCommand playlistinfo took 117 milliseconds Jun 28 14:03:31 volumio volumio[2102]: info: sendMpdCommand playlistinfo took 117 milliseconds Jun 28 14:03:31 volumio volumio[2102]: verbose: ControllerMpd::parseTrackInfo Jun 28 14:03:31 volumio volumio[2102]: info: ControllerMpd::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::servicePushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":87927,"duration":114,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track12","artist":null,"album":null,"uri":"NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 12. Moja pieszczotka (Mia diletta - 1837).ape","trackType":"ape"} Jun 28 14:03:31 volumio volumio[2102]: verbose: CURRENT POSITION 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::syncState stateService play Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::syncState currentStatus play Jun 28 14:03:31 volumio volumio[2102]: info: Received an update from plugin. extracting info from payload Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:31 volumio volumio[2102]: info: ControllerMpd::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::servicePushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":87927,"duration":114,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track12","artist":null,"album":null,"uri":"NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 12. Moja pieszczotka (Mia diletta - 1837).ape","trackType":"ape"} Jun 28 14:03:31 volumio volumio[2102]: verbose: CURRENT POSITION 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::syncState stateService play Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::syncState currentStatus play Jun 28 14:03:31 volumio volumio[2102]: info: Received an update from plugin. extracting info from payload Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:31 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:31 volumio volumio[2102]: info: ------------------------------ 4173ms Jun 28 14:03:31 volumio volumio[2102]: info: ------------------------------ 4173ms Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 28 14:03:31 volumio volumio[2102]: info: Discovery: Getting this device information Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::volumioGetState Jun 28 14:03:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:31 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 28 14:03:51 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:51 volumio volumio[2102]: info: CorePlayQueue::getTrack 8 Jun 28 14:03:51 volumio volumio[2102]: info: Prefetching next song Jun 28 14:03:51 volumio volumio[2102]: info: DOING PREFETCH IN MPD Jun 28 14:03:51 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand add "NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 13. Nie ma czego trzeba (Ciò che manca - 1845).ape" Jun 28 14:03:51 volumio volumio[2102]: info: Jun 28 14:03:51 volumio volumio[2102]: ---------------------------- MPD announces system playlist update Jun 28 14:03:51 volumio volumio[2102]: info: Ignoring MPD Status Update Jun 28 14:03:51 volumio volumio[2102]: info: sendMpdCommand add "NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 13. Nie ma czego trzeba (Ciò che manca - 1845).ape" took 4 milliseconds Jun 28 14:03:51 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand consume 1 Jun 28 14:03:51 volumio volumio[2102]: info: Jun 28 14:03:51 volumio volumio[2102]: ---------------------------- MPD announces system playlist update Jun 28 14:03:51 volumio volumio[2102]: info: Ignoring MPD Status Update Jun 28 14:03:51 volumio volumio[2102]: info: Jun 28 14:03:51 volumio volumio[2102]: ---------------------------- MPD announces system playlist update Jun 28 14:03:51 volumio volumio[2102]: info: Ignoring MPD Status Update Jun 28 14:03:51 volumio volumio[2102]: info: ------------------------------ 11ms Jun 28 14:03:51 volumio volumio[2102]: info: sendMpdCommand consume 1 took 7 milliseconds Jun 28 14:03:51 volumio volumio[2102]: info: ------------------------------ 7ms Jun 28 14:03:51 volumio volumio[2102]: info: ------------------------------ 5ms Jun 28 14:03:54 volumio volumio[2102]: info: Jun 28 14:03:54 volumio volumio[2102]: ---------------------------- MPD announces system playlist update Jun 28 14:03:54 volumio volumio[2102]: info: Ignoring MPD Status Update Jun 28 14:03:54 volumio volumio[2102]: info: Jun 28 14:03:54 volumio volumio[2102]: ---------------------------- MPD announces state update: player Jun 28 14:03:54 volumio volumio[2102]: info: ControllerMpd::getState Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:54 volumio volumio[2102]: info: Jun 28 14:03:54 volumio volumio[2102]: ---------------------------- MPD announces system playlist update Jun 28 14:03:54 volumio volumio[2102]: info: Ignoring MPD Status Update Jun 28 14:03:54 volumio volumio[2102]: info: Jun 28 14:03:54 volumio volumio[2102]: ---------------------------- MPD announces state update: player Jun 28 14:03:54 volumio volumio[2102]: info: ControllerMpd::getState Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:54 volumio volumio[2102]: info: Jun 28 14:03:54 volumio volumio[2102]: ---------------------------- MPD announces system playlist update Jun 28 14:03:54 volumio volumio[2102]: info: Ignoring MPD Status Update Jun 28 14:03:54 volumio volumio[2102]: info: Jun 28 14:03:54 volumio volumio[2102]: ---------------------------- MPD announces state update: player Jun 28 14:03:54 volumio volumio[2102]: info: ControllerMpd::getState Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:54 volumio volumio[2102]: info: Jun 28 14:03:54 volumio volumio[2102]: ---------------------------- MPD announces state update: player Jun 28 14:03:54 volumio volumio[2102]: info: ControllerMpd::getState Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:54 volumio volumio[2102]: info: ------------------------------ 11ms Jun 28 14:03:54 volumio volumio[2102]: info: sendMpdCommand status took 9 milliseconds Jun 28 14:03:54 volumio volumio[2102]: info: ------------------------------ 9ms Jun 28 14:03:54 volumio volumio[2102]: info: sendMpdCommand status took 7 milliseconds Jun 28 14:03:54 volumio volumio[2102]: info: ------------------------------ 6ms Jun 28 14:03:54 volumio volumio[2102]: info: sendMpdCommand status took 5 milliseconds Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 14:03:54 volumio volumio[2102]: info: Jun 28 14:03:54 volumio volumio[2102]: ---------------------------- MPD announces state update: player Jun 28 14:03:54 volumio volumio[2102]: info: ControllerMpd::getState Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:54 volumio volumio[2102]: info: Jun 28 14:03:54 volumio volumio[2102]: ---------------------------- MPD announces state update: player Jun 28 14:03:54 volumio volumio[2102]: info: ControllerMpd::getState Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand status Jun 28 14:03:54 volumio volumio[2102]: info: sendMpdCommand status took 10 milliseconds Jun 28 14:03:54 volumio volumio[2102]: info: sendMpdCommand playlistinfo took 8 milliseconds Jun 28 14:03:54 volumio volumio[2102]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 28 14:03:54 volumio volumio[2102]: info: sendMpdCommand playlistinfo took 8 milliseconds Jun 28 14:03:54 volumio volumio[2102]: info: sendMpdCommand status took 6 milliseconds Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::parseTrackInfo Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::parseTrackInfo Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::parseTrackInfo Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 14:03:54 volumio volumio[2102]: info: ControllerMpd::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::servicePushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track13","artist":null,"album":null,"uri":"NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 13. Nie ma czego trzeba (Ciò che manca - 1845).ape","trackType":"ape"} Jun 28 14:03:54 volumio volumio[2102]: verbose: CURRENT POSITION 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::syncState stateService play Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::syncState currentStatus play Jun 28 14:03:54 volumio volumio[2102]: info: Received an update from plugin. extracting info from payload Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:54 volumio volumio[2102]: info: ControllerMpd::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::servicePushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track13","artist":null,"album":null,"uri":"NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 13. Nie ma czego trzeba (Ciò che manca - 1845).ape","trackType":"ape"} Jun 28 14:03:54 volumio volumio[2102]: verbose: CURRENT POSITION 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::syncState stateService play Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::syncState currentStatus play Jun 28 14:03:54 volumio volumio[2102]: info: Received an update from plugin. extracting info from payload Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:54 volumio volumio[2102]: info: ControllerMpd::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::servicePushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track13","artist":null,"album":null,"uri":"NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 13. Nie ma czego trzeba (Ciò che manca - 1845).ape","trackType":"ape"} Jun 28 14:03:54 volumio volumio[2102]: verbose: CURRENT POSITION 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::syncState stateService play Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::syncState currentStatus play Jun 28 14:03:54 volumio volumio[2102]: info: Received an update from plugin. extracting info from payload Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:54 volumio volumio[2102]: info: ------------------------------ 114ms Jun 28 14:03:54 volumio volumio[2102]: info: ------------------------------ 113ms Jun 28 14:03:54 volumio volumio[2102]: info: ------------------------------ 112ms Jun 28 14:03:54 volumio volumio[2102]: info: sendMpdCommand status took 104 milliseconds Jun 28 14:03:54 volumio volumio[2102]: info: sendMpdCommand playlistinfo took 101 milliseconds Jun 28 14:03:54 volumio volumio[2102]: info: sendMpdCommand playlistinfo took 100 milliseconds Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::parseState Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::parseTrackInfo Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::parseTrackInfo Jun 28 14:03:54 volumio volumio[2102]: info: ControllerMpd::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::servicePushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track13","artist":null,"album":null,"uri":"NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 13. Nie ma czego trzeba (Ciò che manca - 1845).ape","trackType":"ape"} Jun 28 14:03:54 volumio volumio[2102]: verbose: CURRENT POSITION 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::syncState stateService play Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::syncState currentStatus play Jun 28 14:03:54 volumio volumio[2102]: info: Received an update from plugin. extracting info from payload Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:54 volumio volumio[2102]: info: ControllerMpd::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::servicePushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track13","artist":null,"album":null,"uri":"NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 13. Nie ma czego trzeba (Ciò che manca - 1845).ape","trackType":"ape"} Jun 28 14:03:54 volumio volumio[2102]: verbose: CURRENT POSITION 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::syncState stateService play Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::syncState currentStatus play Jun 28 14:03:54 volumio volumio[2102]: info: Received an update from plugin. extracting info from payload Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:54 volumio volumio[2102]: info: ------------------------------ 187ms Jun 28 14:03:54 volumio volumio[2102]: info: ------------------------------ 181ms Jun 28 14:03:54 volumio volumio[2102]: info: sendMpdCommand playlistinfo took 105 milliseconds Jun 28 14:03:54 volumio volumio[2102]: verbose: ControllerMpd::parseTrackInfo Jun 28 14:03:54 volumio volumio[2102]: info: ControllerMpd::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::servicePushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track13","artist":null,"album":null,"uri":"NAS/Bitsori_Music/Musica_Classica/Chopin, Frédéric (1810-1849)/Canti/Op.74 - 17 Canti, Voce,Piano (Szmytka,Martineau)/Op.74 - 17 Canti, 13. Nie ma czego trzeba (Ciò che manca - 1845).ape","trackType":"ape"} Jun 28 14:03:54 volumio volumio[2102]: verbose: CURRENT POSITION 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::syncState stateService play Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::syncState currentStatus play Jun 28 14:03:54 volumio volumio[2102]: info: Received an update from plugin. extracting info from payload Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:54 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:54 volumio volumio[2102]: info: CorePlayQueue::getTrack 7 Jun 28 14:03:54 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:03:54 volumio volumio[2102]: info: ------------------------------ 244ms Jun 28 14:03:56 volumio volumio[2102]: info: CoreStateMachine::startPlaybackTimer Jun 28 14:03:56 volumio volumio[2102]: info: CorePlayQueue::getTrack 8 Jun 28 14:03:56 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:03:56 volumio volumio[2102]: info: CorePlayQueue::getTrack 8 Jun 28 14:03:56 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 14:03:56 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:04:01 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 28 14:04:01 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 28 14:04:01 volumio volumio[2102]: info: Discovery: Getting this device information Jun 28 14:04:01 volumio volumio[2102]: info: CoreCommandRouter::volumioGetState Jun 28 14:04:01 volumio volumio[2102]: info: CorePlayQueue::getTrack 8 Jun 28 14:04:01 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 28 14:04:25 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 28 14:04:25 volumio volumio[2102]: info: CURURI: music-library/NAS/Bitsori_Music/Classic Jun 28 14:04:26 volumio volumio[2102]: info: Preload queue cleared Jun 28 14:04:31 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 28 14:04:31 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 28 14:04:31 volumio volumio[2102]: info: Discovery: Getting this device information Jun 28 14:04:31 volumio volumio[2102]: info: CoreCommandRouter::volumioGetState Jun 28 14:04:31 volumio volumio[2102]: info: CorePlayQueue::getTrack 8 Jun 28 14:04:31 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 28 14:04:35 volumio volumio[2102]: info: Preload queue cleared Jun 28 14:04:35 volumio volumio[2102]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 28 14:04:35 volumio volumio[2102]: info: CoreStateMachine::ClearQueue Jun 28 14:04:35 volumio volumio[2102]: info: CoreStateMachine::stop Jun 28 14:04:36 volumio volumio[2102]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 14:04:36 volumio volumio[2102]: info: CoreStateMachine::stPlaybackTimer Jun 28 14:04:36 volumio volumio[2102]: info: CoreStateMachine::updateTrackBlock Jun 28 14:04:36 volumio volumio[2102]: info: CorePlayQueue::getTrackBlock Jun 28 14:04:36 volumio volumio[2102]: info: CoreStateMachine::pushState Jun 28 14:04:36 volumio volumio[2102]: info: CorePlayQueue::getTrack 8 Jun 28 14:04:36 volumio volumio[2102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 14:04:36 volumio volumio[2102]: info: CoreCommandRouter::volumioPushState Jun 28 14:04:36 volumio volumio[2102]: info: CoreStateMachine::serviceStop Jun 28 14:04:36 volumio volumio[2102]: info: CorePlayQueue::getTrack 8 Jun 28 14:04:36 volumio volumio[2102]: info: CoreCommandRouter::serviceStop Jun 28 14:04:36 volumio volumio[2102]: info: ControllerMpd::stop Jun 28 14:04:36 volumio volumio[2102]: verbose: ControllerMpd::sendMpdCommand stop Jun 28 14:04:36 volumio volumio[2102]: info: CorePlayQueue::clearPlayQueue Jun 28 14:04:36 volumio volumio[2102]: info: CorePlayQueue::saveQueue Jun 28 14:04:36 volumio volumio[2102]: info: CoreCommandRouter::volumioPushQueue Jun 28 14:04:36 volumio volumio[2102]: info: CoreStateMachine::addQueueItems Jun 28 14:04:36 volumio volumio[2102]: info: CorePlayQueue::addQueueItems Jun 28 14:04:36 volumio volumio[2102]: info: Preload queue cleared Jun 28 14:04:36 volumio volumio[2102]: info: Adding Item to queue: music-library/NAS/Bitsori_Music/Classic/Elgar - Violin Concerto Sanguine Fan Chanson de nuit Chanson de matin Jun 28 14:04:36 volumio volumio[2102]: info: Exploding uri music-library/NAS/Bitsori_Music/Classic/Elgar - Violin Concerto Sanguine Fan Chanson de nuit Chanson de matin in service mpd Jun 28 14:04:36 volumio volumio[2102]: info: Jun 28 14:04:36 volumio volumio[2102]: ---------------------------- MPD announces state update: player Jun 28 14:04:36 volumio volumio[2102]: info: ALBUMART /albumart?cacheid=884&web=Elgar-(Menuhin%20%3AViolin%20%2F%20London%20Philharmonic%20Orchestra-Adrian%20Boult)/Elgar%20-%20Violin%20Concerto%20and%20others/extralarge&path=%2Fmnt%2FNAS%2FBitsori_Music%2FClassic%2FElgar%20-%20Violin%20Concerto%20Sanguine%20Fan%20Chanson%20de%20nuit%20Chanson%20de%20matin%2FCDImage.cue&metadata=false Jun 28 14:04:36 volumio volumio[2102]: info: URI /mnt/NAS/Bitsori_Music/Classic/Elgar - Violin Concerto Sanguine Fan Chanson de nuit Chanson de matin/CDImage.cue Jun 28 14:04:36 volumio volumio[2102]: info: ALBUMART /albumart?cacheid=884&web=Elgar-(Menuhin%20%3AViolin%20%2F%20London%20Philharmonic%20Orchestra-Adrian%20Boult)/Elgar%20-%20Violin%20Concerto%20and%20others/extralarge&path=%2Fmnt%2FNAS%2FBitsori_Music%2FClassic%2FElgar%20-%20Violin%20Concerto%20Sanguine%20Fan%20Chanson%20de%20nuit%20Chanson%20de%20matin%2FCDImage.cue&metadata=false Jun 28 14:04:36 volumio volumio[2102]: info: URI /mnt/NAS/Bitsori_Music/Classic/Elgar - Violin Concerto Sanguine Fan Chanson de nuit Chanson de matin/CDImage.cue Jun 28 14:04:36 volumio volumio[2102]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 28 14:04:36 volumio volumio[2102]: Error: Unable to resolve or reject the same promise twice Jun 28 14:04:36 volumio volumio[2102]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jun 28 14:04:36 volumio volumio[2102]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Jun 28 14:04:36 volumio volumio[2102]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jun 28 14:04:36 volumio volumio[2102]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jun 28 14:04:36 volumio volumio[2102]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jun 28 14:04:36 volumio volumio[2102]: at Socket.emit (events.js:315:20) Jun 28 14:04:36 volumio volumio[2102]: at addChunk (internal/streams/readable.js:309:12) Jun 28 14:04:36 volumio volumio[2102]: at readableAddChunk (internal/streams/readable.js:280:11) Jun 28 14:04:36 volumio volumio[2102]: at Socket.Readable.push (internal/streams/readable.js:223:10) Jun 28 14:04:36 volumio volumio[2102]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Jun 28 14:04:36 volumio volumio[2102]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 28 14:04:36 volumio sudo[4791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-28 14:03 Jun 28 14:04:36 volumio sudo[4791]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"