-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sun 2025-05-25 19:45:25 CST. -- May 25 19:44:01 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:01 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:01 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:02 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:02 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:03 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:03 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:03 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:05 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:06 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:07 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:07 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:07 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:09 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:09 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:10 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:11 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:13 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:13 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:14 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:15 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:15 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:15 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:16 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:16 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:16 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:17 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:17 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:17 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:18 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:18 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:18 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:19 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:19 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:19 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:19 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 25 19:44:19 smsl-n100 volumio[1949]: info: CURURI: music-library/USB May 25 19:44:19 smsl-n100 volumio[1949]: info: Preload queue cleared May 25 19:44:20 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:20 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:20 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:20 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:20 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:20 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:21 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:22 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:22 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:22 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:22 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:22 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:23 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:23 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:23 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:24 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:24 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:24 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:25 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:26 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:26 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:27 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:27 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:27 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:27 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:27 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:27 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:28 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:28 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:28 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:29 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 25 19:44:29 smsl-n100 volumio[1949]: info: CURURI: music-library/USB May 25 19:44:29 smsl-n100 volumio[1949]: info: Preload queue cleared May 25 19:44:29 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:29 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:29 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:31 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:31 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:31 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:32 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:32 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:32 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:32 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 25 19:44:32 smsl-n100 volumio[1949]: info: CURURI: music-library May 25 19:44:32 smsl-n100 volumio[1949]: info: Preload queue cleared May 25 19:44:33 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:33 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:33 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:34 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 25 19:44:34 smsl-n100 volumio[1949]: info: CURURI: music-library/USB May 25 19:44:34 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:34 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:34 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:34 smsl-n100 volumio[1949]: info: Preload queue cleared May 25 19:44:35 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:35 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:35 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:35 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:35 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:35 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:36 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:37 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:37 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:38 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:38 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:38 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:39 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:39 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:39 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:40 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:40 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:40 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:40 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:40 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:40 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:41 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:41 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:41 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:42 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:42 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:42 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:44 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:44 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:44 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:45 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:45 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:45 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:46 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:46 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:46 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:47 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 25 19:44:47 smsl-n100 volumio[1949]: info: CURURI: music-library/USB May 25 19:44:47 smsl-n100 volumio[1949]: info: Preload queue cleared May 25 19:44:48 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:48 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 25 19:44:48 smsl-n100 volumio[1949]: info: CURURI: music-library/USB/____ May 25 19:44:48 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:48 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:48 smsl-n100 volumio[1949]: info: Preload queue cleared May 25 19:44:48 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:49 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:49 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:50 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:50 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:50 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:51 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:51 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:51 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:51 smsl-n100 volumio[1949]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 19:44:51 smsl-n100 volumio[1949]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 19:44:51 smsl-n100 volumio[1949]: info: Retrieving Cloud Streaming UI May 25 19:44:51 smsl-n100 volumio[1949]: info: Getting Tidal Cloud Configuration May 25 19:44:51 smsl-n100 volumio[1949]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 19:44:51 smsl-n100 volumio[1949]: info: Getting Qobuz Cloud Configuration May 25 19:44:51 smsl-n100 volumio[1949]: info: Asking plugin for UI Config May 25 19:44:51 smsl-n100 volumio[1949]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 19:44:51 smsl-n100 volumio[1949]: info: Getting Spotify Cloud Configuration May 25 19:44:51 smsl-n100 volumio[1949]: info: Asking plugin for UI Config May 25 19:44:51 smsl-n100 volumio[1949]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 19:44:51 smsl-n100 volumio[1949]: info: Saving Spotify Acccount May 25 19:44:51 smsl-n100 volumio[1949]: info: Got it May 25 19:44:51 smsl-n100 volumio[1949]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 25 19:44:51 smsl-n100 volumio[1949]: info: Got Tidal Cloud Configuration May 25 19:44:51 smsl-n100 volumio[1949]: info: Got it May 25 19:44:51 smsl-n100 volumio[1949]: info: CoreCommandRouter::getUIConfigOnPlugin May 25 19:44:52 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 25 19:44:52 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 25 19:44:52 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 25 19:44:52 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 25 19:44:52 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 19:44:52 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 19:44:52 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 19:44:52 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 19:44:52 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetBrowseSources May 25 19:44:52 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetBrowseSources May 25 19:44:52 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetBrowseSources May 25 19:44:52 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 19:44:52 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 25 19:44:53 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:53 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:53 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:54 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:54 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:54 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:54 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 25 19:44:54 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand rescan May 25 19:44:54 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:44:54 smsl-n100 volumio[1949]: info: May 25 19:44:54 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:44:54 smsl-n100 volumio[1949]: info: sendMpdCommand rescan took 11 milliseconds May 25 19:44:54 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:44:54 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:44:54 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:44:54 smsl-n100 volumio[1949]: info: May 25 19:44:54 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:44:54 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:44:54 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:44:54 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:44:54 smsl-n100 volumio[1949]: info: May 25 19:44:54 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:44:54 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:44:54 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:44:54 smsl-n100 volumio[1949]: info: sendMpdCommand status took 25 milliseconds May 25 19:44:54 smsl-n100 volumio[1949]: info: sendMpdCommand status took 20 milliseconds May 25 19:44:54 smsl-n100 volumio[1949]: info: sendMpdCommand status took 19 milliseconds May 25 19:44:54 smsl-n100 volumio[1949]: info: sendMpdCommand status took 15 milliseconds May 25 19:44:54 smsl-n100 volumio[1949]: info: sendMpdCommand status took 14 milliseconds May 25 19:44:54 smsl-n100 volumio[1949]: info: sendMpdCommand status took 11 milliseconds May 25 19:44:54 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:44:54 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:44:54 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:44:54 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:44:55 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:44:55 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:44:55 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:44:55 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:44:55 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:44:55 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:44:55 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:55 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:55 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:55 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:44:55 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:55 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:55 smsl-n100 volumio[1949]: info: No code May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:55 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:55 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:55 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:55 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:55 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:44:55 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:55 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:55 smsl-n100 volumio[1949]: info: No code May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:55 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:55 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:55 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:55 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:55 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:44:55 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:55 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:55 smsl-n100 volumio[1949]: info: No code May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:55 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:55 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:55 smsl-n100 volumio[1949]: info: ------------------------------ 559ms May 25 19:44:55 smsl-n100 volumio[1949]: info: ------------------------------ 555ms May 25 19:44:55 smsl-n100 volumio[1949]: info: ------------------------------ 550ms May 25 19:44:55 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:55 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:55 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:55 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:55 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:55 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:55 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:55 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:55 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:55 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:55 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:55 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 19:44:56 smsl-n100 volumio[1949]: info: MPD Database updated - AlbumList cache refreshed May 25 19:44:56 smsl-n100 volumio[1949]: info: May 25 19:44:56 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: database May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:44:56 smsl-n100 volumio[1949]: info: May 25 19:44:56 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:44:56 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:44:56 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:44:56 smsl-n100 volumio[1949]: info: MPD Database updated - AlbumList cache refreshed May 25 19:44:56 smsl-n100 volumio[1949]: info: May 25 19:44:56 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: database May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:44:56 smsl-n100 volumio[1949]: info: May 25 19:44:56 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:44:56 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:44:56 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:44:56 smsl-n100 volumio[1949]: info: MPD Database updated - AlbumList cache refreshed May 25 19:44:56 smsl-n100 volumio[1949]: info: May 25 19:44:56 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: database May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:44:56 smsl-n100 volumio[1949]: info: May 25 19:44:56 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:44:56 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:44:56 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:44:56 smsl-n100 volumio[1949]: info: sendMpdCommand status took 60 milliseconds May 25 19:44:56 smsl-n100 volumio[1949]: info: sendMpdCommand status took 58 milliseconds May 25 19:44:56 smsl-n100 volumio[1949]: info: sendMpdCommand status took 56 milliseconds May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:44:56 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatefalse May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:44:56 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:44:56 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: No code May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:44:56 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: No code May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: ------------------------------ 277ms May 25 19:44:56 smsl-n100 volumio[1949]: info: ------------------------------ 278ms May 25 19:44:56 smsl-n100 volumio[1949]: info: sendMpdCommand status took 296 milliseconds May 25 19:44:56 smsl-n100 volumio[1949]: info: sendMpdCommand status took 293 milliseconds May 25 19:44:56 smsl-n100 volumio[1949]: info: sendMpdCommand status took 292 milliseconds May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:44:56 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatefalse May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:44:56 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:44:56 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: No code May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:44:56 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: No code May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: ------------------------------ 512ms May 25 19:44:56 smsl-n100 volumio[1949]: info: ------------------------------ 513ms May 25 19:44:56 smsl-n100 volumio[1949]: info: sendMpdCommand status took 536 milliseconds May 25 19:44:56 smsl-n100 volumio[1949]: info: sendMpdCommand status took 533 milliseconds May 25 19:44:56 smsl-n100 volumio[1949]: info: sendMpdCommand status took 531 milliseconds May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:44:56 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatefalse May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:44:56 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:44:56 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:44:56 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: No code May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:56 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:56 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:56 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:57 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:44:57 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:44:57 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:44:57 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:44:57 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:57 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:57 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:57 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:57 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:57 smsl-n100 volumio[1949]: info: No code May 25 19:44:57 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:44:57 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:57 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:44:57 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:44:57 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:44:57 smsl-n100 volumio[1949]: info: ------------------------------ 729ms May 25 19:44:57 smsl-n100 volumio[1949]: info: ------------------------------ 730ms May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:44:57 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:57 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:57 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:57 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:57 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:57 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:58 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:58 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:58 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:44:59 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:44:59 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:44:59 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:00 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 19:45:00 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:00 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:00 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:01 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:01 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:01 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand update May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:02 smsl-n100 volumio[1949]: info: May 25 19:45:02 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:02 smsl-n100 volumio[1949]: info: sendMpdCommand update took 9 milliseconds May 25 19:45:02 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:02 smsl-n100 volumio[1949]: info: May 25 19:45:02 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:02 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:02 smsl-n100 volumio[1949]: info: May 25 19:45:02 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:02 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:02 smsl-n100 volumio[1949]: info: sendMpdCommand status took 23 milliseconds May 25 19:45:02 smsl-n100 volumio[1949]: info: sendMpdCommand status took 18 milliseconds May 25 19:45:02 smsl-n100 volumio[1949]: info: sendMpdCommand status took 16 milliseconds May 25 19:45:02 smsl-n100 volumio[1949]: info: sendMpdCommand status took 13 milliseconds May 25 19:45:02 smsl-n100 volumio[1949]: info: sendMpdCommand status took 11 milliseconds May 25 19:45:02 smsl-n100 volumio[1949]: info: sendMpdCommand status took 9 milliseconds May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:02 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:02 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:02 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:02 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:02 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:02 smsl-n100 volumio[1949]: info: No code May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:02 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:02 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:02 smsl-n100 volumio[1949]: info: No code May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:02 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:02 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:02 smsl-n100 volumio[1949]: info: No code May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:02 smsl-n100 volumio[1949]: info: ------------------------------ 419ms May 25 19:45:02 smsl-n100 volumio[1949]: info: ------------------------------ 413ms May 25 19:45:02 smsl-n100 volumio[1949]: info: ------------------------------ 409ms May 25 19:45:02 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:02 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:02 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:02 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:02 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:02 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:02 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:02 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:02 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:02 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:02 smsl-n100 volumio[1949]: info: May 25 19:45:02 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:02 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:02 smsl-n100 volumio[1949]: info: sendMpdCommand status took 6 milliseconds May 25 19:45:02 smsl-n100 volumio[1949]: info: sendMpdCommand status took 3 milliseconds May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:02 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatefalse May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:02 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:02 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:02 smsl-n100 volumio[1949]: info: No code May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:02 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:02 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:02 smsl-n100 volumio[1949]: info: ------------------------------ 165ms May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:02 smsl-n100 volumio[1949]: info: May 25 19:45:02 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:02 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:02 smsl-n100 volumio[1949]: info: May 25 19:45:02 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:02 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:02 smsl-n100 volumio[1949]: info: sendMpdCommand status took 12 milliseconds May 25 19:45:02 smsl-n100 volumio[1949]: info: sendMpdCommand status took 9 milliseconds May 25 19:45:02 smsl-n100 volumio[1949]: info: sendMpdCommand status took 9 milliseconds May 25 19:45:02 smsl-n100 volumio[1949]: info: sendMpdCommand status took 5 milliseconds May 25 19:45:02 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:02 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatefalse May 25 19:45:02 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:03 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:03 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:03 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatefalse May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:03 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:03 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:03 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:03 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:03 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:03 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:03 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:03 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:03 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:03 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:03 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:03 smsl-n100 volumio[1949]: info: No code May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:03 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:03 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:03 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:03 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:03 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:03 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:03 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:03 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:03 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:03 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:03 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:03 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:03 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:03 smsl-n100 volumio[1949]: info: No code May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:03 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:03 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:03 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:03 smsl-n100 volumio[1949]: info: ------------------------------ 276ms May 25 19:45:03 smsl-n100 volumio[1949]: info: ------------------------------ 273ms May 25 19:45:03 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:03 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:03 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:03 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:03 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:03 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:03 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:03 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:03 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:03 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:03 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:03 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:04 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 19:45:04 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:04 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:04 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:04 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 25 19:45:04 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand update May 25 19:45:04 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:04 smsl-n100 volumio[1949]: info: May 25 19:45:04 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:04 smsl-n100 volumio[1949]: info: sendMpdCommand update took 10 milliseconds May 25 19:45:04 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:04 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:04 smsl-n100 volumio[1949]: info: sendMpdCommand status took 9 milliseconds May 25 19:45:04 smsl-n100 volumio[1949]: info: sendMpdCommand status took 4 milliseconds May 25 19:45:04 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:04 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:04 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:04 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:04 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:04 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:04 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:04 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:04 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:04 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:04 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:04 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:04 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:04 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:04 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:04 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:04 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:04 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:04 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 19:45:04 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:04 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:04 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:04 smsl-n100 volumio[1949]: info: No code May 25 19:45:04 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:04 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:04 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:04 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:04 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:04 smsl-n100 volumio[1949]: info: ------------------------------ 166ms May 25 19:45:04 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:04 smsl-n100 volumio[1949]: info: May 25 19:45:04 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:04 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:04 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:04 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:04 smsl-n100 volumio[1949]: info: May 25 19:45:04 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:04 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:04 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:04 smsl-n100 volumio[1949]: info: sendMpdCommand status took 14 milliseconds May 25 19:45:04 smsl-n100 volumio[1949]: info: sendMpdCommand status took 11 milliseconds May 25 19:45:04 smsl-n100 volumio[1949]: info: sendMpdCommand status took 9 milliseconds May 25 19:45:04 smsl-n100 volumio[1949]: info: sendMpdCommand status took 6 milliseconds May 25 19:45:04 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:05 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:05 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:05 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:05 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:05 smsl-n100 volumio[1949]: info: No code May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:05 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:05 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:05 smsl-n100 volumio[1949]: info: No code May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:05 smsl-n100 volumio[1949]: info: ------------------------------ 273ms May 25 19:45:05 smsl-n100 volumio[1949]: info: ------------------------------ 268ms May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:05 smsl-n100 volumio[1949]: info: May 25 19:45:05 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:05 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:05 smsl-n100 volumio[1949]: info: May 25 19:45:05 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:05 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:05 smsl-n100 volumio[1949]: info: sendMpdCommand status took 12 milliseconds May 25 19:45:05 smsl-n100 volumio[1949]: info: sendMpdCommand status took 9 milliseconds May 25 19:45:05 smsl-n100 volumio[1949]: info: sendMpdCommand status took 8 milliseconds May 25 19:45:05 smsl-n100 volumio[1949]: info: sendMpdCommand status took 6 milliseconds May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:05 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatefalse May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:05 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatefalse May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:05 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:05 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:05 smsl-n100 volumio[1949]: info: No code May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:05 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:05 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:05 smsl-n100 volumio[1949]: info: No code May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:05 smsl-n100 volumio[1949]: info: ------------------------------ 250ms May 25 19:45:05 smsl-n100 volumio[1949]: info: ------------------------------ 247ms May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:05 smsl-n100 volumio[1949]: info: May 25 19:45:05 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:05 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:05 smsl-n100 volumio[1949]: info: sendMpdCommand status took 11 milliseconds May 25 19:45:05 smsl-n100 volumio[1949]: info: sendMpdCommand status took 8 milliseconds May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:05 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatefalse May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:05 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:05 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:05 smsl-n100 volumio[1949]: info: No code May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:05 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:05 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:05 smsl-n100 volumio[1949]: info: ------------------------------ 135ms May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand update May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:05 smsl-n100 volumio[1949]: info: May 25 19:45:05 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:05 smsl-n100 volumio[1949]: info: sendMpdCommand update took 13 milliseconds May 25 19:45:05 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:05 smsl-n100 volumio[1949]: info: May 25 19:45:05 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:05 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:05 smsl-n100 volumio[1949]: info: May 25 19:45:05 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:05 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:05 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:05 smsl-n100 volumio[1949]: info: sendMpdCommand status took 31 milliseconds May 25 19:45:05 smsl-n100 volumio[1949]: info: sendMpdCommand status took 27 milliseconds May 25 19:45:05 smsl-n100 volumio[1949]: info: sendMpdCommand status took 25 milliseconds May 25 19:45:05 smsl-n100 volumio[1949]: info: sendMpdCommand status took 22 milliseconds May 25 19:45:05 smsl-n100 volumio[1949]: info: sendMpdCommand status took 21 milliseconds May 25 19:45:05 smsl-n100 volumio[1949]: info: sendMpdCommand status took 18 milliseconds May 25 19:45:05 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:05 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:05 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:06 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:06 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:06 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:06 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:06 smsl-n100 volumio[1949]: info: No code May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:06 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:06 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:06 smsl-n100 volumio[1949]: info: No code May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:06 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:06 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:06 smsl-n100 volumio[1949]: info: No code May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:06 smsl-n100 volumio[1949]: info: ------------------------------ 435ms May 25 19:45:06 smsl-n100 volumio[1949]: info: ------------------------------ 431ms May 25 19:45:06 smsl-n100 volumio[1949]: info: ------------------------------ 427ms May 25 19:45:06 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:06 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:06 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:06 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:06 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:06 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:06 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:06 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:06 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand rescan May 25 19:45:06 smsl-n100 volumio[1949]: info: sendMpdCommand rescan took 12 milliseconds May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:06 smsl-n100 volumio[1949]: info: May 25 19:45:06 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:06 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:06 smsl-n100 volumio[1949]: info: May 25 19:45:06 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:06 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:06 smsl-n100 volumio[1949]: info: sendMpdCommand status took 15 milliseconds May 25 19:45:06 smsl-n100 volumio[1949]: info: sendMpdCommand status took 11 milliseconds May 25 19:45:06 smsl-n100 volumio[1949]: info: sendMpdCommand status took 9 milliseconds May 25 19:45:06 smsl-n100 volumio[1949]: info: sendMpdCommand status took 7 milliseconds May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:06 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:06 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:06 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:06 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:06 smsl-n100 volumio[1949]: info: No code May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:06 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:06 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:06 smsl-n100 volumio[1949]: info: No code May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:06 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:06 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:06 smsl-n100 volumio[1949]: info: ------------------------------ 339ms May 25 19:45:06 smsl-n100 volumio[1949]: info: ------------------------------ 334ms May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:06 smsl-n100 volumio[1949]: info: May 25 19:45:06 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:06 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:06 smsl-n100 volumio[1949]: info: sendMpdCommand status took 8 milliseconds May 25 19:45:06 smsl-n100 volumio[1949]: info: sendMpdCommand status took 5 milliseconds May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:06 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:06 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:06 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:07 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:07 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:07 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:07 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:07 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:07 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:07 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:07 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:07 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:07 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:07 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:07 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:07 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:07 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:07 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:07 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:07 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:07 smsl-n100 volumio[1949]: info: No code May 25 19:45:07 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:07 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:07 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:07 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:07 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:07 smsl-n100 volumio[1949]: info: ------------------------------ 193ms May 25 19:45:07 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:07 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:07 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:07 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:07 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:07 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:07 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:07 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:07 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:07 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:07 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:07 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:07 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 25 19:45:07 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand rescan May 25 19:45:07 smsl-n100 volumio[1949]: info: sendMpdCommand rescan took 6 milliseconds May 25 19:45:07 smsl-n100 volumio[1949]: info: MPD Database updated - AlbumList cache refreshed May 25 19:45:07 smsl-n100 volumio[1949]: info: May 25 19:45:07 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: database May 25 19:45:07 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:07 smsl-n100 volumio[1949]: info: May 25 19:45:07 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:07 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:07 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:07 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:07 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:07 smsl-n100 volumio[1949]: info: MPD Database updated - AlbumList cache refreshed May 25 19:45:08 smsl-n100 volumio[1949]: info: May 25 19:45:08 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: database May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:08 smsl-n100 volumio[1949]: info: May 25 19:45:08 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:08 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:08 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:08 smsl-n100 volumio[1949]: info: sendMpdCommand status took 51 milliseconds May 25 19:45:08 smsl-n100 volumio[1949]: info: sendMpdCommand status took 48 milliseconds May 25 19:45:08 smsl-n100 volumio[1949]: info: sendMpdCommand status took 47 milliseconds May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:08 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:08 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:08 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:08 smsl-n100 volumio[1949]: info: No code May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:08 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:08 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:08 smsl-n100 volumio[1949]: info: No code May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:08 smsl-n100 volumio[1949]: info: ------------------------------ 291ms May 25 19:45:08 smsl-n100 volumio[1949]: info: ------------------------------ 294ms May 25 19:45:08 smsl-n100 volumio[1949]: info: MPD Database updated - AlbumList cache refreshed May 25 19:45:08 smsl-n100 volumio[1949]: info: May 25 19:45:08 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: database May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:08 smsl-n100 volumio[1949]: info: May 25 19:45:08 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:08 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:08 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:08 smsl-n100 volumio[1949]: info: sendMpdCommand status took 331 milliseconds May 25 19:45:08 smsl-n100 volumio[1949]: info: sendMpdCommand status took 327 milliseconds May 25 19:45:08 smsl-n100 volumio[1949]: info: sendMpdCommand status took 327 milliseconds May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:08 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:08 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:08 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:08 smsl-n100 volumio[1949]: info: No code May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:08 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:08 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:08 smsl-n100 volumio[1949]: info: No code May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:08 smsl-n100 volumio[1949]: info: ------------------------------ 567ms May 25 19:45:08 smsl-n100 volumio[1949]: info: ------------------------------ 570ms May 25 19:45:08 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:08 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:08 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:08 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:08 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:08 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:08 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:08 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:08 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:08 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:08 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:08 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand rescan May 25 19:45:08 smsl-n100 volumio[1949]: info: sendMpdCommand status took 513 milliseconds May 25 19:45:08 smsl-n100 volumio[1949]: info: sendMpdCommand status took 510 milliseconds May 25 19:45:08 smsl-n100 volumio[1949]: info: sendMpdCommand status took 510 milliseconds May 25 19:45:08 smsl-n100 volumio[1949]: info: sendMpdCommand rescan took 68 milliseconds May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:08 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:08 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:08 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:08 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:08 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:08 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:08 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:09 smsl-n100 volumio[1949]: info: No code May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:09 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:09 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:09 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:09 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:09 smsl-n100 volumio[1949]: info: No code May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:09 smsl-n100 volumio[1949]: info: ------------------------------ 846ms May 25 19:45:09 smsl-n100 volumio[1949]: info: ------------------------------ 847ms May 25 19:45:09 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:09 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:09 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:09 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:09 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:09 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 25 19:45:09 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand update May 25 19:45:09 smsl-n100 volumio[1949]: info: sendMpdCommand update took 6 milliseconds May 25 19:45:09 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:09 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:09 smsl-n100 volumio[1949]: info: MPD Database updated - AlbumList cache refreshed May 25 19:45:09 smsl-n100 volumio[1949]: info: May 25 19:45:09 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: database May 25 19:45:09 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:09 smsl-n100 volumio[1949]: info: May 25 19:45:09 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:09 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:09 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:09 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:09 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:09 smsl-n100 volumio[1949]: info: MPD Database updated - AlbumList cache refreshed May 25 19:45:09 smsl-n100 volumio[1949]: info: May 25 19:45:09 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: database May 25 19:45:09 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:09 smsl-n100 volumio[1949]: info: May 25 19:45:09 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:09 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:09 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:09 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:09 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:09 smsl-n100 volumio[1949]: info: sendMpdCommand status took 39 milliseconds May 25 19:45:09 smsl-n100 volumio[1949]: info: sendMpdCommand status took 36 milliseconds May 25 19:45:09 smsl-n100 volumio[1949]: info: sendMpdCommand status took 35 milliseconds May 25 19:45:09 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:09 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:09 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:09 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:09 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:09 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:09 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:09 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:09 smsl-n100 volumio[1949]: info: No code May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:09 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:09 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:09 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:09 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:09 smsl-n100 volumio[1949]: info: No code May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:09 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:09 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:09 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:10 smsl-n100 volumio[1949]: info: ------------------------------ 303ms May 25 19:45:10 smsl-n100 volumio[1949]: info: ------------------------------ 304ms May 25 19:45:10 smsl-n100 volumio[1949]: info: MPD Database updated - AlbumList cache refreshed May 25 19:45:10 smsl-n100 volumio[1949]: info: May 25 19:45:10 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: database May 25 19:45:10 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:10 smsl-n100 volumio[1949]: info: May 25 19:45:10 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:10 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:10 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:10 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:10 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:10 smsl-n100 volumio[1949]: info: sendMpdCommand status took 330 milliseconds May 25 19:45:10 smsl-n100 volumio[1949]: info: sendMpdCommand status took 327 milliseconds May 25 19:45:10 smsl-n100 volumio[1949]: info: sendMpdCommand status took 327 milliseconds May 25 19:45:10 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:10 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:10 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:10 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:10 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:10 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:10 smsl-n100 volumio[1949]: info: No code May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:10 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:10 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:10 smsl-n100 volumio[1949]: info: No code May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:10 smsl-n100 volumio[1949]: info: ------------------------------ 609ms May 25 19:45:10 smsl-n100 volumio[1949]: info: ------------------------------ 610ms May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: sendMpdCommand status took 481 milliseconds May 25 19:45:10 smsl-n100 volumio[1949]: info: sendMpdCommand status took 478 milliseconds May 25 19:45:10 smsl-n100 volumio[1949]: info: sendMpdCommand status took 477 milliseconds May 25 19:45:10 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:10 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:10 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:10 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:10 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:10 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:10 smsl-n100 volumio[1949]: info: No code May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:10 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:10 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:10 smsl-n100 volumio[1949]: info: No code May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:10 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:10 smsl-n100 volumio[1949]: info: ------------------------------ 668ms May 25 19:45:10 smsl-n100 volumio[1949]: info: ------------------------------ 669ms May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:10 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:10 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:10 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: MPD Database updated - AlbumList cache refreshed May 25 19:45:11 smsl-n100 volumio[1949]: info: May 25 19:45:11 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: database May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:11 smsl-n100 volumio[1949]: info: May 25 19:45:11 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:11 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:11 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:11 smsl-n100 volumio[1949]: info: MPD Database updated - AlbumList cache refreshed May 25 19:45:11 smsl-n100 volumio[1949]: info: May 25 19:45:11 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: database May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:11 smsl-n100 volumio[1949]: info: May 25 19:45:11 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:11 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:11 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:11 smsl-n100 volumio[1949]: info: sendMpdCommand status took 39 milliseconds May 25 19:45:11 smsl-n100 volumio[1949]: info: sendMpdCommand status took 37 milliseconds May 25 19:45:11 smsl-n100 volumio[1949]: info: sendMpdCommand status took 36 milliseconds May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:11 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:11 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:11 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: No code May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:11 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: No code May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: ------------------------------ 244ms May 25 19:45:11 smsl-n100 volumio[1949]: info: ------------------------------ 245ms May 25 19:45:11 smsl-n100 volumio[1949]: info: MPD Database updated - AlbumList cache refreshed May 25 19:45:11 smsl-n100 volumio[1949]: info: May 25 19:45:11 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: database May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:11 smsl-n100 volumio[1949]: info: May 25 19:45:11 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:11 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:11 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:11 smsl-n100 volumio[1949]: info: sendMpdCommand status took 282 milliseconds May 25 19:45:11 smsl-n100 volumio[1949]: info: sendMpdCommand status took 279 milliseconds May 25 19:45:11 smsl-n100 volumio[1949]: info: sendMpdCommand status took 277 milliseconds May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:11 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:11 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:11 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: No code May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:11 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: No code May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: ------------------------------ 472ms May 25 19:45:11 smsl-n100 volumio[1949]: info: ------------------------------ 472ms May 25 19:45:11 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:11 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:11 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:11 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:11 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:11 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:11 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:11 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:11 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:11 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:11 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:11 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:11 smsl-n100 volumio[1949]: info: sendMpdCommand status took 356 milliseconds May 25 19:45:11 smsl-n100 volumio[1949]: info: sendMpdCommand status took 353 milliseconds May 25 19:45:11 smsl-n100 volumio[1949]: info: sendMpdCommand status took 353 milliseconds May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:11 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:11 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:11 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:11 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: No code May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:11 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:11 smsl-n100 volumio[1949]: info: No code May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:11 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:11 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:11 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:12 smsl-n100 volumio[1949]: info: ------------------------------ 542ms May 25 19:45:12 smsl-n100 volumio[1949]: info: ------------------------------ 543ms May 25 19:45:12 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:12 smsl-n100 volumio[1949]: info: May 25 19:45:12 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:12 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:12 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:12 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:12 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:12 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:12 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:12 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:12 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:12 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:12 smsl-n100 volumio[1949]: info: May 25 19:45:12 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:12 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:12 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:12 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:12 smsl-n100 volumio[1949]: info: May 25 19:45:12 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:12 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:12 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:12 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:12 smsl-n100 volumio[1949]: info: sendMpdCommand status took 78 milliseconds May 25 19:45:12 smsl-n100 volumio[1949]: info: sendMpdCommand status took 77 milliseconds May 25 19:45:12 smsl-n100 volumio[1949]: info: sendMpdCommand status took 22 milliseconds May 25 19:45:12 smsl-n100 volumio[1949]: info: sendMpdCommand status took 19 milliseconds May 25 19:45:12 smsl-n100 volumio[1949]: info: sendMpdCommand status took 18 milliseconds May 25 19:45:12 smsl-n100 volumio[1949]: info: sendMpdCommand status took 15 milliseconds May 25 19:45:12 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:12 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatefalse May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:12 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:12 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:12 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatefalse May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:12 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:12 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:12 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatefalse May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:12 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:12 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:12 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:12 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:12 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:12 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:12 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:12 smsl-n100 volumio[1949]: info: No code May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:12 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:12 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:12 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:12 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:12 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:12 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:12 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:12 smsl-n100 volumio[1949]: info: No code May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:12 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:12 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:12 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:12 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:12 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:12 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:12 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:12 smsl-n100 volumio[1949]: info: No code May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:12 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:12 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:12 smsl-n100 volumio[1949]: info: ------------------------------ 419ms May 25 19:45:12 smsl-n100 volumio[1949]: info: ------------------------------ 362ms May 25 19:45:12 smsl-n100 volumio[1949]: info: ------------------------------ 359ms May 25 19:45:12 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:12 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:12 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:12 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:12 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:12 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:12 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:12 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:12 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 19:45:12 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:12 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 25 19:45:13 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand rescan May 25 19:45:13 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:13 smsl-n100 volumio[1949]: info: May 25 19:45:13 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:13 smsl-n100 volumio[1949]: info: sendMpdCommand rescan took 9 milliseconds May 25 19:45:13 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:13 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:13 smsl-n100 volumio[1949]: info: sendMpdCommand status took 8 milliseconds May 25 19:45:13 smsl-n100 volumio[1949]: info: sendMpdCommand status took 4 milliseconds May 25 19:45:13 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:13 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:13 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:13 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:13 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:13 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:13 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:13 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:13 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:13 smsl-n100 volumio[1949]: info: No code May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:13 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:13 smsl-n100 volumio[1949]: info: ------------------------------ 176ms May 25 19:45:13 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:13 smsl-n100 volumio[1949]: info: May 25 19:45:13 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:13 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:13 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:13 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:13 smsl-n100 volumio[1949]: info: May 25 19:45:13 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:13 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:13 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:13 smsl-n100 volumio[1949]: info: sendMpdCommand status took 22 milliseconds May 25 19:45:13 smsl-n100 volumio[1949]: info: sendMpdCommand status took 19 milliseconds May 25 19:45:13 smsl-n100 volumio[1949]: info: sendMpdCommand status took 18 milliseconds May 25 19:45:13 smsl-n100 volumio[1949]: info: sendMpdCommand status took 14 milliseconds May 25 19:45:13 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:13 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:13 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:13 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:13 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatetrue May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:13 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:13 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:13 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:13 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:13 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:13 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:13 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:13 smsl-n100 volumio[1949]: info: No code May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:13 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:13 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:13 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:13 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:13 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:13 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:13 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:13 smsl-n100 volumio[1949]: info: No code May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:13 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:13 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:13 smsl-n100 volumio[1949]: info: ------------------------------ 334ms May 25 19:45:13 smsl-n100 volumio[1949]: info: ------------------------------ 329ms May 25 19:45:13 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:13 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:13 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:13 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:13 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:13 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:13 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:13 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:13 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:13 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:13 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:13 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: MPD Database updated - AlbumList cache refreshed May 25 19:45:14 smsl-n100 volumio[1949]: info: May 25 19:45:14 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: database May 25 19:45:14 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:14 smsl-n100 volumio[1949]: info: May 25 19:45:14 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:14 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:14 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:14 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:14 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:14 smsl-n100 volumio[1949]: info: MPD Database updated - AlbumList cache refreshed May 25 19:45:14 smsl-n100 volumio[1949]: info: May 25 19:45:14 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: database May 25 19:45:14 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:14 smsl-n100 volumio[1949]: info: May 25 19:45:14 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:14 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:14 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:14 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:14 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:14 smsl-n100 volumio[1949]: info: sendMpdCommand status took 36 milliseconds May 25 19:45:14 smsl-n100 volumio[1949]: info: sendMpdCommand status took 34 milliseconds May 25 19:45:14 smsl-n100 volumio[1949]: info: sendMpdCommand status took 33 milliseconds May 25 19:45:14 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:14 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatefalse May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:14 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:14 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:14 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:14 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:14 smsl-n100 volumio[1949]: info: No code May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:14 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:14 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:14 smsl-n100 volumio[1949]: info: No code May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:14 smsl-n100 volumio[1949]: info: ------------------------------ 211ms May 25 19:45:14 smsl-n100 volumio[1949]: info: ------------------------------ 212ms May 25 19:45:14 smsl-n100 volumio[1949]: info: MPD Database updated - AlbumList cache refreshed May 25 19:45:14 smsl-n100 volumio[1949]: info: May 25 19:45:14 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: database May 25 19:45:14 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:14 smsl-n100 volumio[1949]: info: May 25 19:45:14 smsl-n100 volumio[1949]: ---------------------------- MPD announces state update: update May 25 19:45:14 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:14 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:14 smsl-n100 volumio[1949]: info: ControllerMpd::getState May 25 19:45:14 smsl-n100 volumio[1949]: verbose: ControllerMpd::sendMpdCommand status May 25 19:45:14 smsl-n100 volumio[1949]: info: sendMpdCommand status took 232 milliseconds May 25 19:45:14 smsl-n100 volumio[1949]: info: sendMpdCommand status took 230 milliseconds May 25 19:45:14 smsl-n100 volumio[1949]: info: sendMpdCommand status took 229 milliseconds May 25 19:45:14 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:14 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatefalse May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:14 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:14 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:14 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:14 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:14 smsl-n100 volumio[1949]: info: No code May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:14 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:14 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:14 smsl-n100 volumio[1949]: info: No code May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:14 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:14 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:14 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:14 smsl-n100 volumio[1949]: info: ------------------------------ 404ms May 25 19:45:14 smsl-n100 volumio[1949]: info: ------------------------------ 405ms May 25 19:45:14 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:14 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:14 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:14 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:14 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:14 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:14 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:14 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:14 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:14 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:14 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:14 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:15 smsl-n100 volumio[1949]: info: sendMpdCommand status took 293 milliseconds May 25 19:45:15 smsl-n100 volumio[1949]: info: sendMpdCommand status took 290 milliseconds May 25 19:45:15 smsl-n100 volumio[1949]: info: sendMpdCommand status took 289 milliseconds May 25 19:45:15 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:15 smsl-n100 volumio[1949]: info: Command Router : Notfying DB Updatefalse May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreCommandRouter::Close All Modals sent May 25 19:45:15 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:15 smsl-n100 volumio[1949]: verbose: ControllerMpd::parseState May 25 19:45:15 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:15 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:15 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:15 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:15 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:15 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:15 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:15 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:15 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:15 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:15 smsl-n100 volumio[1949]: info: No code May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:15 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:15 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:15 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:15 smsl-n100 volumio[1949]: info: ControllerMpd::pushState May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreCommandRouter::servicePushState May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:15 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:15 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:15 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:15 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:15 smsl-n100 volumio[1949]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 25 19:45:15 smsl-n100 volumio[1949]: verbose: CURRENT POSITION 0 May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState stateService stop May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreStateMachine::syncState currentStatus stop May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:15 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:15 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:15 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:15 smsl-n100 volumio[1949]: info: No code May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreStateMachine::pushState May 25 19:45:15 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioPushState May 25 19:45:15 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output update for this device May 25 19:45:15 smsl-n100 volumio[1949]: info: MRS: Pushing multiroomSync output May 25 19:45:15 smsl-n100 volumio[1949]: info: ------------------------------ 455ms May 25 19:45:15 smsl-n100 volumio[1949]: info: ------------------------------ 456ms May 25 19:45:15 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:15 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:15 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:15 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:15 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:15 smsl-n100 volumio[1949]: info: Updating RAAT Signal Path May 25 19:45:15 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:15 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:15 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:16 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:16 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:16 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:16 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 19:45:16 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:16 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:16 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:17 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:17 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:17 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:18 smsl-n100 volumio[1949]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 25 19:45:18 smsl-n100 volumio[1949]: info: CoreCommandRouter::volumioGetState May 25 19:45:18 smsl-n100 volumio[1949]: info: CorePlayQueue::getTrack 0 May 25 19:45:19 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 25 19:45:19 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 25 19:45:20 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 19:45:24 smsl-n100 volumio[1949]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 19:45:24 smsl-n100 volumio[1949]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 19:45:24 smsl-n100 volumio[1949]: Error: dns service error: unknown May 25 19:45:24 smsl-n100 volumio[1949]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) May 25 19:45:24 smsl-n100 volumio[1949]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 25 19:45:24 smsl-n100 volumio[1949]: errorCode: -65537 May 25 19:45:24 smsl-n100 volumio[1949]: } May 25 19:45:24 smsl-n100 volumio[1949]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 19:45:25 smsl-n100 sudo[3678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-25 19:44 May 25 19:45:25 smsl-n100 sudo[3678]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="723ba1d50268911818ebdca474fb7656df6050cb" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 14 Feb 2025 02:46:15 PM CET" VOLUMIO_VERSION="3.789" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="215d731aee688e00fb3cc923952be9a7"