-- Logs begin at Thu 2019-02-14 10:12:00 UTC, end at Fri 2025-12-19 09:30:26 UTC. -- Dec 19 09:29:48 volumio volumio[606]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 19 09:29:48 volumio volumio[606]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory Dec 19 09:29:48 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 19 09:29:49 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 19 09:29:49 volumio sudo[8470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 19 09:29:49 volumio sudo[8470]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 09:29:49 volumio sudo[8470]: pam_unix(sudo:session): session closed for user root Dec 19 09:29:49 volumio sudo[8475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 19 09:29:49 volumio sudo[8475]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 09:29:49 volumio sudo[8483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 19 09:29:49 volumio sudo[8483]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 09:29:49 volumio sudo[8475]: pam_unix(sudo:session): session closed for user root Dec 19 09:29:49 volumio sudo[8491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 19 09:29:49 volumio sudo[8491]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 09:29:49 volumio sudo[8483]: pam_unix(sudo:session): session closed for user root Dec 19 09:29:49 volumio sudo[8503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 09:29:49 volumio sudo[8503]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 09:29:49 volumio sudo[8503]: pam_unix(sudo:session): session closed for user root Dec 19 09:29:49 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 09:29:49 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 09:29:49 volumio sudo[8491]: pam_unix(sudo:session): session closed for user root Dec 19 09:29:49 volumio sudo[8511]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 09:29:49 volumio sudo[8511]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 09:29:49 volumio sudo[8511]: pam_unix(sudo:session): session closed for user root Dec 19 09:29:49 volumio sudo[8517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 09:29:49 volumio sudo[8517]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 09:29:49 volumio sudo[8517]: pam_unix(sudo:session): session closed for user root Dec 19 09:29:49 volumio volumio[606]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Dec 19 09:29:49 volumio volumio[606]: wlan0 Interface doesn't support scanning. Dec 19 09:29:49 volumio volumio[606]: info: Cannot use regular scanning, forcing with ap-force Dec 19 09:29:49 volumio sudo[8522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Dec 19 09:29:49 volumio sudo[8522]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 09:29:49 volumio sudo[8522]: pam_unix(sudo:session): session closed for user root Dec 19 09:29:49 volumio volumio[606]: command failed: No such device (-19) Dec 19 09:29:49 volumio volumio[606]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Dec 19 09:29:49 volumio volumio[606]: command failed: No such device (-19) Dec 19 09:30:00 volumio volumio[606]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 19 09:30:00 volumio volumio[606]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 19 09:30:00 volumio volumio[606]: info: Retrieving Cloud Streaming UI Dec 19 09:30:00 volumio volumio[606]: info: Getting Tidal Cloud Configuration Dec 19 09:30:00 volumio volumio[606]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 19 09:30:00 volumio volumio[606]: info: Getting Qobuz Cloud Configuration Dec 19 09:30:00 volumio volumio[606]: info: Asking plugin for UI Config Dec 19 09:30:00 volumio volumio[606]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 19 09:30:00 volumio volumio[606]: info: Getting Spotify Cloud Configuration Dec 19 09:30:00 volumio volumio[606]: info: Asking plugin for UI Config Dec 19 09:30:00 volumio volumio[606]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 19 09:30:00 volumio volumio[606]: info: Saving Spotify Acccount Dec 19 09:30:00 volumio volumio[606]: info: Got Tidal Cloud Configuration Dec 19 09:30:00 volumio volumio[606]: info: Got it Dec 19 09:30:00 volumio volumio[606]: info: Got it Dec 19 09:30:00 volumio volumio[606]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 19 09:30:00 volumio volumio[606]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 19 09:30:00 volumio volumio[606]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Dec 19 09:30:00 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 19 09:30:00 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 19 09:30:00 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 19 09:30:00 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 19 09:30:00 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 09:30:00 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 09:30:00 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 09:30:00 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 09:30:00 volumio volumio[606]: info: CoreCommandRouter::volumioGetBrowseSources Dec 19 09:30:01 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 19 09:30:01 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 19 09:30:05 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 19 09:30:07 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand rescan Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:07 volumio volumio[606]: info: Dec 19 09:30:07 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:07 volumio volumio[606]: info: sendMpdCommand rescan took 14 milliseconds Dec 19 09:30:07 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:07 volumio volumio[606]: info: Dec 19 09:30:07 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:07 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:07 volumio volumio[606]: info: Dec 19 09:30:07 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:07 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:07 volumio volumio[606]: info: Dec 19 09:30:07 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:07 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:07 volumio volumio[606]: info: Dec 19 09:30:07 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:07 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:07 volumio volumio[606]: info: Dec 19 09:30:07 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:07 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:07 volumio volumio[606]: info: sendMpdCommand status took 43 milliseconds Dec 19 09:30:07 volumio volumio[606]: info: sendMpdCommand status took 34 milliseconds Dec 19 09:30:07 volumio volumio[606]: info: sendMpdCommand status took 32 milliseconds Dec 19 09:30:07 volumio volumio[606]: info: sendMpdCommand status took 29 milliseconds Dec 19 09:30:07 volumio volumio[606]: info: sendMpdCommand status took 28 milliseconds Dec 19 09:30:07 volumio volumio[606]: info: sendMpdCommand status took 26 milliseconds Dec 19 09:30:07 volumio volumio[606]: info: sendMpdCommand status took 24 milliseconds Dec 19 09:30:07 volumio volumio[606]: info: sendMpdCommand status took 22 milliseconds Dec 19 09:30:07 volumio volumio[606]: info: sendMpdCommand status took 21 milliseconds Dec 19 09:30:07 volumio volumio[606]: info: sendMpdCommand status took 19 milliseconds Dec 19 09:30:07 volumio volumio[606]: info: sendMpdCommand status took 17 milliseconds Dec 19 09:30:07 volumio volumio[606]: info: sendMpdCommand status took 14 milliseconds Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:07 volumio volumio[606]: info: Command Router : Notfying DB Updatetrue Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:07 volumio volumio[606]: info: Command Router : Notfying DB Updatetrue Dec 19 09:30:07 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:07 volumio volumio[606]: info: Command Router : Notfying DB Updatetrue Dec 19 09:30:07 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:07 volumio volumio[606]: info: Command Router : Notfying DB Updatetrue Dec 19 09:30:07 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:07 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: info: Command Router : Notfying DB Updatetrue Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: info: Command Router : Notfying DB Updatetrue Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: MPD Database updated - AlbumList cache refreshed Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: database Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: MPD Database updated - AlbumList cache refreshed Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: database Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand playlistinfo took 305 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand playlistinfo took 246 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand playlistinfo took 202 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand playlistinfo took 151 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand playlistinfo took 108 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand playlistinfo took 64 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 38 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 37 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 35 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 33 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 33 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 30 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 24 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 23 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 21 milliseconds Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: info: Command Router : Notfying DB Updatefalse Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: info: Command Router : Notfying DB Updatefalse Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: info: Command Router : Notfying DB Updatefalse Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: info: Command Router : Notfying DB Updatefalse Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:08 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: No code Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:08 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: No code Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:08 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: No code Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:08 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: No code Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:08 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: No code Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:08 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: No code Dec 19 09:30:08 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:08 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:08 volumio volumio[606]: info: ------------------------------ 850ms Dec 19 09:30:08 volumio volumio[606]: info: ------------------------------ 841ms Dec 19 09:30:08 volumio volumio[606]: info: ------------------------------ 838ms Dec 19 09:30:08 volumio volumio[606]: info: ------------------------------ 835ms Dec 19 09:30:08 volumio volumio[606]: info: ------------------------------ 832ms Dec 19 09:30:08 volumio volumio[606]: info: ------------------------------ 829ms Dec 19 09:30:08 volumio volumio[606]: info: MPD Database updated - AlbumList cache refreshed Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: database Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: MPD Database updated - AlbumList cache refreshed Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: database Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: MPD Database updated - AlbumList cache refreshed Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: database Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: MPD Database updated - AlbumList cache refreshed Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: database Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: MPD Database updated - AlbumList cache refreshed Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: database Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: MPD Database updated - AlbumList cache refreshed Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: database Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: MPD Database updated - AlbumList cache refreshed Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: database Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: Dec 19 09:30:08 volumio volumio[606]: ---------------------------- MPD announces state update: update Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: info: ControllerMpd::getState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand status Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:08 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 596 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 592 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 591 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand playlistinfo took 524 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand playlistinfo took 481 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand playlistinfo took 438 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand playlistinfo took 394 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand playlistinfo took 394 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 166 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 163 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 162 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 158 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 156 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 155 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 150 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 149 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 147 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 143 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 141 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 140 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 136 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 135 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 133 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 130 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 128 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 132 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 128 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 126 milliseconds Dec 19 09:30:08 volumio volumio[606]: info: sendMpdCommand status took 125 milliseconds Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: info: Command Router : Notfying DB Updatefalse Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: info: Command Router : Notfying DB Updatefalse Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: info: Command Router : Notfying DB Updatefalse Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: info: Command Router : Notfying DB Updatefalse Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: info: Command Router : Notfying DB Updatefalse Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:08 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:08 volumio volumio[606]: info: Command Router : Notfying DB Updatefalse Dec 19 09:30:08 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:09 volumio volumio[606]: info: Command Router : Notfying DB Updatefalse Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:09 volumio volumio[606]: info: Command Router : Notfying DB Updatefalse Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::Close All Modals sent Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseState Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1168ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1166ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1164ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1157ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1158ms Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 490 milliseconds Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 490 milliseconds Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 443 milliseconds Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 442 milliseconds Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 399 milliseconds Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 399 milliseconds Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 355 milliseconds Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 355 milliseconds Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 311 milliseconds Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 311 milliseconds Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 269 milliseconds Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 268 milliseconds Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 224 milliseconds Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 224 milliseconds Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 180 milliseconds Dec 19 09:30:09 volumio volumio[606]: info: sendMpdCommand playlistinfo took 180 milliseconds Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: verbose: ControllerMpd::parseTrackInfo Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ControllerMpd::pushState Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::servicePushState Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: 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":"Anne Murray","artist":"Anne Murray","album":"Christmas","uri":"http://192.168.178.33:50002/m/MP3/15644.mp3","trackType":"mp3"} Dec 19 09:30:09 volumio volumio[606]: verbose: CURRENT POSITION 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState stateService stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::syncState currentStatus stop Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: No code Dec 19 09:30:09 volumio volumio[606]: info: CoreStateMachine::pushState Dec 19 09:30:09 volumio volumio[606]: info: CorePlayQueue::getTrack 0 Dec 19 09:30:09 volumio volumio[606]: info: CoreCommandRouter::volumioPushState Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1580ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1587ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1156ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1157ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1152ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1153ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1147ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1148ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1142ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1143ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1139ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1139ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1135ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1136ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1132ms Dec 19 09:30:09 volumio volumio[606]: info: ------------------------------ 1132ms Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:09 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: SPOTIFY VOLUME 18 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: VOLUMIO VOLUME 17 Dec 19 09:30:10 volumio volumio[606]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 19 09:30:10 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 19 09:30:13 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 19 09:30:17 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 19 09:30:19 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Dec 19 09:30:19 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Dec 19 09:30:21 volumio volumio[606]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 19 09:30:24 volumio volumio[606]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 09:30:24 volumio volumio[606]: Error: dns service error: unknown Dec 19 09:30:24 volumio volumio[606]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Dec 19 09:30:24 volumio volumio[606]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 19 09:30:24 volumio volumio[606]: errorCode: -65537 Dec 19 09:30:24 volumio volumio[606]: } Dec 19 09:30:24 volumio volumio[606]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 09:30:26 volumio sudo[8582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-19 09:29 Dec 19 09:30:26 volumio sudo[8582]: 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="1f061e035f7cb2799b32d3520aa8e55cd07df6f9" VOLUMIO_FE_VERSION="9971a09df9c3edfdedf2ecf438999be8aba9db68" VOLUMIO_FE3_VERSION="3974def988c7b2392ddc85f9b8cb4692d5e8fda9" VOLUMIO_BE_VERSION="b3c53a818b9b3d0e5c13c9d346c4d613c4ca426f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 11 Jul 2022 04:03:33 PM CEST" VOLUMIO_VERSION="3.324" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5b2f59e6e90e57f326ca25c7ca839d52"