-- Logs begin at Mon 2024-10-07 20:42:04 CDT, end at Tue 2024-10-08 00:40:14 CDT. -- Oct 07 23:39:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:39:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:39:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:39:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:39:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 22 Oct 07 23:39:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:39:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:39:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:39:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:39:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:39:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 22 Oct 07 23:39:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:40:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:40:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:40:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:40:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:40:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 22 Oct 07 23:40:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:40:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:40:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:40:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:40:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:40:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 22 Oct 07 23:40:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:41:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:41:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:41:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:41:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:41:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 22 Oct 07 23:41:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:41:28 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 22 Oct 07 23:41:28 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:41:28 musicadeldiablo volumio[1149]: info: Prefetching next song Oct 07 23:41:28 musicadeldiablo volumio[1149]: info: DOING PREFETCH IN MPD Oct 07 23:41:28 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/05 Re-Connect.flac" Oct 07 23:41:28 musicadeldiablo volumio[1149]: info: Oct 07 23:41:28 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:41:28 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:41:28 musicadeldiablo volumio[1149]: info: sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/05 Re-Connect.flac" took 2 milliseconds Oct 07 23:41:28 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 07 23:41:28 musicadeldiablo volumio[1149]: info: Oct 07 23:41:28 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:41:28 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:41:28 musicadeldiablo volumio[1149]: info: Oct 07 23:41:28 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:41:28 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:41:28 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 07 23:41:28 musicadeldiablo volumio[1149]: info: sendMpdCommand consume 1 took 3 milliseconds Oct 07 23:41:28 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 07 23:41:28 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 07 23:41:32 musicadeldiablo volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 07 23:41:32 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: Oct 07 23:41:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: Oct 07 23:41:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: Oct 07 23:41:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: Oct 07 23:41:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: Oct 07 23:41:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: Oct 07 23:41:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: ------------------------------ 4ms Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 3 milliseconds Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 2 milliseconds Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 3 milliseconds Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1087 Kbps","isStreaming":false,"title":"Re-Connect","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/05 Re-Connect.flac","trackType":"flac"} Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 23 Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1087 Kbps","isStreaming":false,"title":"Re-Connect","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/05 Re-Connect.flac","trackType":"flac"} Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 23 Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: ------------------------------ 28ms Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: ------------------------------ 27ms Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 23 milliseconds Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1087 Kbps","isStreaming":false,"title":"Re-Connect","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/05 Re-Connect.flac","trackType":"flac"} Oct 07 23:41:33 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 23 Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: ------------------------------ 40ms Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:41:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:41:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:41:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:41:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:41:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:41:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:41:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:42:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:42:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:42:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:42:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:42:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:42:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:42:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:42:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:42:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:42:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:42:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:42:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:43:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:43:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:43:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:43:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:43:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:43:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:43:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:43:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:43:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:43:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:43:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:43:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:44:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:44:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:44:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:44:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:44:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:44:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:44:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:44:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:44:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:44:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:44:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:44:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:45:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:45:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:45:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:45:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:45:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:45:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:45:20 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 23 Oct 07 23:45:20 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:45:20 musicadeldiablo volumio[1149]: info: Prefetching next song Oct 07 23:45:20 musicadeldiablo volumio[1149]: info: DOING PREFETCH IN MPD Oct 07 23:45:20 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/06 Inner Silence.flac" Oct 07 23:45:20 musicadeldiablo volumio[1149]: info: sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/06 Inner Silence.flac" took 1 milliseconds Oct 07 23:45:20 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 07 23:45:20 musicadeldiablo volumio[1149]: info: Oct 07 23:45:20 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:45:20 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:45:20 musicadeldiablo volumio[1149]: info: sendMpdCommand consume 1 took 1 milliseconds Oct 07 23:45:20 musicadeldiablo volumio[1149]: info: Oct 07 23:45:20 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:45:20 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:45:20 musicadeldiablo volumio[1149]: info: Oct 07 23:45:20 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:45:20 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:45:20 musicadeldiablo volumio[1149]: info: ------------------------------ 4ms Oct 07 23:45:24 musicadeldiablo volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 07 23:45:24 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: Oct 07 23:45:25 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: Oct 07 23:45:25 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: Oct 07 23:45:25 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: Oct 07 23:45:25 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: Oct 07 23:45:25 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: Oct 07 23:45:25 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: ------------------------------ 5ms Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 4 milliseconds Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 4 milliseconds Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 3 milliseconds Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"585 Kbps","isStreaming":false,"title":"Inner Silence","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/06 Inner Silence.flac","trackType":"flac"} Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 24 Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"585 Kbps","isStreaming":false,"title":"Inner Silence","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/06 Inner Silence.flac","trackType":"flac"} Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 24 Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"585 Kbps","isStreaming":false,"title":"Inner Silence","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/06 Inner Silence.flac","trackType":"flac"} Oct 07 23:45:25 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 24 Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: ------------------------------ 36ms Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: ------------------------------ 35ms Oct 07 23:45:25 musicadeldiablo volumio[1149]: info: ------------------------------ 35ms Oct 07 23:45:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:45:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:45:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:45:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:45:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:45:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:46:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:46:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:46:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:46:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:46:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:46:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:46:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:46:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:46:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:46:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:46:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:46:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:47:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:47:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:47:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:47:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:47:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:47:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:47:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:47:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:47:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:47:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:47:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:47:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:48:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:48:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:48:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:48:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:48:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:48:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:48:28 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 24 Oct 07 23:48:28 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:48:28 musicadeldiablo volumio[1149]: info: Prefetching next song Oct 07 23:48:28 musicadeldiablo volumio[1149]: info: DOING PREFETCH IN MPD Oct 07 23:48:28 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/07 Alternative 4.flac" Oct 07 23:48:28 musicadeldiablo volumio[1149]: info: Oct 07 23:48:28 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:48:28 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:48:28 musicadeldiablo volumio[1149]: info: sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/07 Alternative 4.flac" took 1 milliseconds Oct 07 23:48:28 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 07 23:48:28 musicadeldiablo volumio[1149]: info: Oct 07 23:48:28 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:48:28 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:48:28 musicadeldiablo volumio[1149]: info: Oct 07 23:48:28 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:48:28 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:48:28 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 07 23:48:28 musicadeldiablo volumio[1149]: info: sendMpdCommand consume 1 took 3 milliseconds Oct 07 23:48:28 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 07 23:48:28 musicadeldiablo volumio[1149]: info: ------------------------------ 1ms Oct 07 23:48:32 musicadeldiablo volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 07 23:48:32 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: Oct 07 23:48:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: Oct 07 23:48:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: Oct 07 23:48:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: Oct 07 23:48:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: Oct 07 23:48:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: Oct 07 23:48:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: ------------------------------ 4ms Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 3 milliseconds Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 3 milliseconds Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 2 milliseconds Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":378,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"576 Kbps","isStreaming":false,"title":"Alternative 4","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/07 Alternative 4.flac","trackType":"flac"} Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 25 Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":378,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"576 Kbps","isStreaming":false,"title":"Alternative 4","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/07 Alternative 4.flac","trackType":"flac"} Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 25 Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":378,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"576 Kbps","isStreaming":false,"title":"Alternative 4","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/07 Alternative 4.flac","trackType":"flac"} Oct 07 23:48:33 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 25 Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: ------------------------------ 34ms Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: ------------------------------ 34ms Oct 07 23:48:33 musicadeldiablo volumio[1149]: info: ------------------------------ 33ms Oct 07 23:48:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:48:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:48:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:48:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:48:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:48:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:49:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:49:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:49:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:49:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:49:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:49:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:49:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:49:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:49:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:49:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:49:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:49:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:50:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:50:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:50:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:50:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:50:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:50:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:50:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:50:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:50:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:50:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:50:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:50:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:51:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:51:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:51:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:51:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:51:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:51:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:51:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:51:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:51:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:51:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:51:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:51:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:52:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:52:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:52:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:52:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:52:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:52:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:52:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:52:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:52:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:52:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:52:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:52:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:53:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:53:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:53:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:53:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:53:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:53:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:53:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:53:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:53:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:53:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:53:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:53:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:54:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:54:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:54:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:54:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:54:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:54:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:54:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:54:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:54:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:54:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:54:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:54:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:54:46 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 25 Oct 07 23:54:46 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:54:46 musicadeldiablo volumio[1149]: info: Prefetching next song Oct 07 23:54:46 musicadeldiablo volumio[1149]: info: DOING PREFETCH IN MPD Oct 07 23:54:46 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/08 Regret.flac" Oct 07 23:54:46 musicadeldiablo volumio[1149]: info: Oct 07 23:54:46 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:54:46 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:54:46 musicadeldiablo volumio[1149]: info: sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/08 Regret.flac" took 1 milliseconds Oct 07 23:54:46 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 07 23:54:46 musicadeldiablo volumio[1149]: info: Oct 07 23:54:46 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:54:46 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:54:46 musicadeldiablo volumio[1149]: info: Oct 07 23:54:46 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:54:46 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:54:46 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 07 23:54:46 musicadeldiablo volumio[1149]: info: sendMpdCommand consume 1 took 3 milliseconds Oct 07 23:54:46 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 07 23:54:46 musicadeldiablo volumio[1149]: info: ------------------------------ 1ms Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: Oct 07 23:54:51 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: Oct 07 23:54:51 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: Oct 07 23:54:51 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: Oct 07 23:54:51 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: Oct 07 23:54:51 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: Oct 07 23:54:51 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: ------------------------------ 4ms Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 4 milliseconds Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: ------------------------------ 4ms Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 3 milliseconds Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 2 milliseconds Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":478,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"682 Kbps","isStreaming":false,"title":"Regret","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/08 Regret.flac","trackType":"flac"} Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 26 Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":478,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"682 Kbps","isStreaming":false,"title":"Regret","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/08 Regret.flac","trackType":"flac"} Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 26 Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":478,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"682 Kbps","isStreaming":false,"title":"Regret","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/08 Regret.flac","trackType":"flac"} Oct 07 23:54:51 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 26 Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: ------------------------------ 37ms Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: ------------------------------ 36ms Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: ------------------------------ 35ms Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:54:51 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 07 23:55:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:55:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:55:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:55:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:55:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:55:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:55:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:55:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:55:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:55:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:55:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:55:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:56:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:56:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:56:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:56:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:56:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:56:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:56:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:56:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:56:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:56:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:56:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:56:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:57:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:57:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:57:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:57:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:57:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:57:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:57:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:57:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:57:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:57:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:57:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:57:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:58:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:58:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:58:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:58:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:58:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:58:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:58:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:58:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:58:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:58:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:58:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:58:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:59:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:59:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:59:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:59:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:59:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:59:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 23:59:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 23:59:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 23:59:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 07 23:59:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 07 23:59:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 07 23:59:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:00:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:00:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:00:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:00:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:00:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 08 00:00:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:00:13 musicadeldiablo systemd[1]: Starting Daily man-db regeneration... Oct 08 00:00:14 musicadeldiablo systemd[1]: man-db.service: Succeeded. Oct 08 00:00:14 musicadeldiablo systemd[1]: Started Daily man-db regeneration. Oct 08 00:00:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:00:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:00:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:00:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:00:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 08 00:00:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:01:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:01:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:01:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:01:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:01:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 08 00:01:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:01:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:01:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:01:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:01:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:01:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 08 00:01:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:02:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:02:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:02:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:02:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:02:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 08 00:02:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:02:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:02:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:02:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:02:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:02:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 08 00:02:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:02:44 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 26 Oct 08 00:02:44 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:02:44 musicadeldiablo volumio[1149]: info: Prefetching next song Oct 08 00:02:44 musicadeldiablo volumio[1149]: info: DOING PREFETCH IN MPD Oct 08 00:02:44 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/09 Feel.flac" Oct 08 00:02:44 musicadeldiablo volumio[1149]: info: Oct 08 00:02:44 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:02:44 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:02:44 musicadeldiablo volumio[1149]: info: sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/09 Feel.flac" took 2 milliseconds Oct 08 00:02:44 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 08 00:02:44 musicadeldiablo volumio[1149]: info: Oct 08 00:02:44 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:02:44 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:02:44 musicadeldiablo volumio[1149]: info: Oct 08 00:02:44 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:02:44 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:02:44 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 08 00:02:44 musicadeldiablo volumio[1149]: info: sendMpdCommand consume 1 took 2 milliseconds Oct 08 00:02:44 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 08 00:02:44 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: Oct 08 00:02:49 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: Oct 08 00:02:49 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: Oct 08 00:02:49 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: Oct 08 00:02:49 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: Oct 08 00:02:49 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: Oct 08 00:02:49 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: ------------------------------ 4ms Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 3 milliseconds Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: ------------------------------ 4ms Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 3 milliseconds Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 2 milliseconds Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1048 Kbps","isStreaming":false,"title":"Feel","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/09 Feel.flac","trackType":"flac"} Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 27 Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1048 Kbps","isStreaming":false,"title":"Feel","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/09 Feel.flac","trackType":"flac"} Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 27 Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1048 Kbps","isStreaming":false,"title":"Feel","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/09 Feel.flac","trackType":"flac"} Oct 08 00:02:49 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 27 Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: ------------------------------ 23ms Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: ------------------------------ 22ms Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: ------------------------------ 22ms Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:02:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:03:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:03:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:03:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:03:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:03:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:03:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:03:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:03:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:03:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:03:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:03:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:03:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:04:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:04:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:04:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:04:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:04:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:04:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:04:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:04:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:04:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:04:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:04:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:04:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:05:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:05:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:05:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:05:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:05:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:05:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:05:14 musicadeldiablo volumio[1149]: verbose: New Socket.io Connection to 192.168.1.74 from 192.168.1.65 UA: Mozilla/5.0 (Linux; Android 14; CPH2363 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetVisibleSources Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: Received Get System Info Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: Listing playlists Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetQueue Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CoreStateMachine::getQueue Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CorePlayQueue::getQueue Oct 08 00:05:14 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 08 00:05:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:05:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:05:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:05:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:05:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:05:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:06:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:06:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:06:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:06:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:06:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:06:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:06:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:06:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:06:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:06:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:06:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:06:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:07:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:07:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:07:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:07:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:07:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:07:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:07:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:07:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:07:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:07:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:07:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:07:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:08:12 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:08:12 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:08:12 musicadeldiablo volumio[1149]: info: Prefetching next song Oct 08 00:08:12 musicadeldiablo volumio[1149]: info: DOING PREFETCH IN MPD Oct 08 00:08:12 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/10 Destiny.flac" Oct 08 00:08:12 musicadeldiablo volumio[1149]: info: Oct 08 00:08:12 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:08:12 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:08:12 musicadeldiablo volumio[1149]: info: sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/10 Destiny.flac" took 1 milliseconds Oct 08 00:08:12 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 08 00:08:12 musicadeldiablo volumio[1149]: info: Oct 08 00:08:12 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:08:12 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:08:12 musicadeldiablo volumio[1149]: info: Oct 08 00:08:12 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:08:12 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:08:12 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 08 00:08:12 musicadeldiablo volumio[1149]: info: sendMpdCommand consume 1 took 2 milliseconds Oct 08 00:08:12 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 08 00:08:12 musicadeldiablo volumio[1149]: info: ------------------------------ 1ms Oct 08 00:08:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:08:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:08:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:08:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:08:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 27 Oct 08 00:08:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: Oct 08 00:08:17 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: Oct 08 00:08:17 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: Oct 08 00:08:17 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: Oct 08 00:08:17 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: Oct 08 00:08:17 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: Oct 08 00:08:17 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: ------------------------------ 4ms Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 3 milliseconds Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 3 milliseconds Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 2 milliseconds Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":135,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"687 Kbps","isStreaming":false,"title":"Destiny","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/10 Destiny.flac","trackType":"flac"} Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 28 Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":135,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"687 Kbps","isStreaming":false,"title":"Destiny","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/10 Destiny.flac","trackType":"flac"} Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 28 Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":135,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"687 Kbps","isStreaming":false,"title":"Destiny","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/10 Destiny.flac","trackType":"flac"} Oct 08 00:08:17 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 28 Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:08:17 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:08:18 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:08:18 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:08:18 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:08:18 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:08:18 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:08:18 musicadeldiablo volumio[1149]: info: ------------------------------ 23ms Oct 08 00:08:18 musicadeldiablo volumio[1149]: info: ------------------------------ 22ms Oct 08 00:08:18 musicadeldiablo volumio[1149]: info: ------------------------------ 22ms Oct 08 00:08:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:08:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:08:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:08:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:08:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:08:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:09:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:09:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:09:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:09:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:09:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:09:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:09:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:09:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:09:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:09:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:09:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:09:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:10:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:10:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:10:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:10:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:10:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:10:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:10:28 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 28 Oct 08 00:10:28 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:10:28 musicadeldiablo volumio[1149]: info: Prefetching next song Oct 08 00:10:28 musicadeldiablo volumio[1149]: info: DOING PREFETCH IN MPD Oct 08 00:10:28 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/11 Your Possible Pasts.flac" Oct 08 00:10:28 musicadeldiablo volumio[1149]: info: Oct 08 00:10:28 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:10:28 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:10:28 musicadeldiablo volumio[1149]: info: sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/11 Your Possible Pasts.flac" took 2 milliseconds Oct 08 00:10:28 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 08 00:10:28 musicadeldiablo volumio[1149]: info: Oct 08 00:10:28 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:10:28 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:10:28 musicadeldiablo volumio[1149]: info: Oct 08 00:10:28 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:10:28 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:10:28 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 08 00:10:28 musicadeldiablo volumio[1149]: info: sendMpdCommand consume 1 took 2 milliseconds Oct 08 00:10:28 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 08 00:10:28 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 08 00:10:32 musicadeldiablo volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 08 00:10:32 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:10:32 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:10:32 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:10:32 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:10:32 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: Oct 08 00:10:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: Oct 08 00:10:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: Oct 08 00:10:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: Oct 08 00:10:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: Oct 08 00:10:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: Oct 08 00:10:33 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: ------------------------------ 5ms Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 7 milliseconds Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: ------------------------------ 7ms Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 5 milliseconds Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: ------------------------------ 5ms Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 4 milliseconds Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"463 Kbps","isStreaming":false,"title":"Your Possible Pasts","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/11 Your Possible Pasts.flac","trackType":"flac"} Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 29 Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"463 Kbps","isStreaming":false,"title":"Your Possible Pasts","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/11 Your Possible Pasts.flac","trackType":"flac"} Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 29 Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"463 Kbps","isStreaming":false,"title":"Your Possible Pasts","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/11 Your Possible Pasts.flac","trackType":"flac"} Oct 08 00:10:33 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 29 Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: ------------------------------ 24ms Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: ------------------------------ 23ms Oct 08 00:10:33 musicadeldiablo volumio[1149]: info: ------------------------------ 21ms Oct 08 00:10:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:10:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:10:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:10:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:10:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:10:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:11:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:11:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:11:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:11:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:11:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:11:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:11:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:11:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:11:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:11:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:11:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:11:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:12:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:12:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:12:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:12:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:12:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:12:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:12:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:12:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:12:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:12:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:12:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:12:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:12:49 musicadeldiablo volumio[1149]: verbose: New Socket.io Connection to 192.168.1.74 from 192.168.1.65 UA: Mozilla/5.0 (Linux; Android 14; CPH2363 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetVisibleSources Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: Received Get System Info Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:12:49 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:12:50 musicadeldiablo volumio[1149]: info: Listing playlists Oct 08 00:12:50 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetQueue Oct 08 00:12:50 musicadeldiablo volumio[1149]: info: CoreStateMachine::getQueue Oct 08 00:12:50 musicadeldiablo volumio[1149]: info: CorePlayQueue::getQueue Oct 08 00:12:50 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 08 00:12:51 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume- Oct 08 00:12:51 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:12:51 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:12:51 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:12:51 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:12:51 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume- Oct 08 00:12:52 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:12:52 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:12:52 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:12:52 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:12:52 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume- Oct 08 00:12:52 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:12:52 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:12:52 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:12:52 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:12:52 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume- Oct 08 00:12:52 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:12:52 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:12:52 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:12:52 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:12:59 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume- Oct 08 00:12:59 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:12:59 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:12:59 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:12:59 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:13:00 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume- Oct 08 00:13:00 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:13:00 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:13:00 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:13:00 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:13:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:13:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:13:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:13:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:13:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:13:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:13:25 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume25 Oct 08 00:13:25 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:13:25 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:13:25 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:13:25 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:13:26 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume31 Oct 08 00:13:26 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:13:26 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:13:26 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:13:26 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:13:26 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume45 Oct 08 00:13:26 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:13:26 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:13:26 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:13:26 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:13:27 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume48 Oct 08 00:13:27 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:13:27 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:13:27 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:13:27 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:13:29 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume29 Oct 08 00:13:29 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:13:29 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:13:29 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:13:29 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:13:29 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume34 Oct 08 00:13:29 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:13:29 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:13:29 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:13:29 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:13:31 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume38 Oct 08 00:13:31 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:13:31 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:13:31 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:13:31 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:13:33 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume51 Oct 08 00:13:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:13:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:13:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:13:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:13:33 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume50 Oct 08 00:13:33 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:13:33 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:13:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:13:33 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:13:33 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume46 Oct 08 00:13:34 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:13:34 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:13:34 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:13:34 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:13:34 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume47 Oct 08 00:13:34 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:13:34 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:13:34 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:13:34 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:13:34 musicadeldiablo volumio[1149]: info: VolumeController::SetAlsaVolume38 Oct 08 00:13:34 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:13:34 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:13:34 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:13:34 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:13:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:13:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:13:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:13:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:13:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:13:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:14:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:14:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:14:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:14:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:14:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:14:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:14:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:14:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:14:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:14:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:14:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:14:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:14:57 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 29 Oct 08 00:14:57 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:14:57 musicadeldiablo volumio[1149]: info: Prefetching next song Oct 08 00:14:57 musicadeldiablo volumio[1149]: info: DOING PREFETCH IN MPD Oct 08 00:14:57 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/12 One of the Few.flac" Oct 08 00:14:57 musicadeldiablo volumio[1149]: info: Oct 08 00:14:57 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:14:57 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:14:57 musicadeldiablo volumio[1149]: info: sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/12 One of the Few.flac" took 1 milliseconds Oct 08 00:14:57 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 08 00:14:57 musicadeldiablo volumio[1149]: info: Oct 08 00:14:57 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:14:57 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:14:57 musicadeldiablo volumio[1149]: info: Oct 08 00:14:57 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:14:57 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:14:57 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 08 00:14:57 musicadeldiablo volumio[1149]: info: sendMpdCommand consume 1 took 2 milliseconds Oct 08 00:14:57 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 08 00:14:57 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 08 00:15:01 musicadeldiablo volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 08 00:15:01 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: Oct 08 00:15:02 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: Oct 08 00:15:02 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: Oct 08 00:15:02 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: Oct 08 00:15:02 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: Oct 08 00:15:02 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: Oct 08 00:15:02 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: ------------------------------ 5ms Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 4 milliseconds Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 3 milliseconds Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 3 milliseconds Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":111,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"451 Kbps","isStreaming":false,"title":"One of the Few","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/12 One of the Few.flac","trackType":"flac"} Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 30 Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":111,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"451 Kbps","isStreaming":false,"title":"One of the Few","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/12 One of the Few.flac","trackType":"flac"} Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 30 Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: ------------------------------ 20ms Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: ------------------------------ 19ms Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":111,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"451 Kbps","isStreaming":false,"title":"One of the Few","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/12 One of the Few.flac","trackType":"flac"} Oct 08 00:15:02 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 30 Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: ------------------------------ 24ms Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:15:02 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:15:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:15:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:15:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:15:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:15:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:15:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:15:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:15:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:15:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:15:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:15:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:15:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:16:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:16:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:16:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:16:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:16:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:16:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:16:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:16:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:16:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:16:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:16:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:16:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:16:48 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 30 Oct 08 00:16:48 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:16:48 musicadeldiablo volumio[1149]: info: Prefetching next song Oct 08 00:16:48 musicadeldiablo volumio[1149]: info: DOING PREFETCH IN MPD Oct 08 00:16:48 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/13 Better off Dead.flac" Oct 08 00:16:48 musicadeldiablo volumio[1149]: info: Oct 08 00:16:48 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:16:48 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:16:48 musicadeldiablo volumio[1149]: info: sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/13 Better off Dead.flac" took 1 milliseconds Oct 08 00:16:48 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 08 00:16:48 musicadeldiablo volumio[1149]: info: Oct 08 00:16:48 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:16:48 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:16:48 musicadeldiablo volumio[1149]: info: Oct 08 00:16:48 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:16:48 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:16:48 musicadeldiablo volumio[1149]: info: ------------------------------ 8ms Oct 08 00:16:48 musicadeldiablo volumio[1149]: info: sendMpdCommand consume 1 took 7 milliseconds Oct 08 00:16:48 musicadeldiablo volumio[1149]: info: ------------------------------ 7ms Oct 08 00:16:48 musicadeldiablo volumio[1149]: info: ------------------------------ 6ms Oct 08 00:16:52 musicadeldiablo volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 08 00:16:52 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: Oct 08 00:16:53 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: Oct 08 00:16:53 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: Oct 08 00:16:53 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: Oct 08 00:16:53 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: Oct 08 00:16:53 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: Oct 08 00:16:53 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: ------------------------------ 5ms Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 4 milliseconds Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: ------------------------------ 4ms Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 3 milliseconds Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 2 milliseconds Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":263,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"705 Kbps","isStreaming":false,"title":"Better off Dead","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/13 Better off Dead.flac","trackType":"flac"} Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 31 Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":263,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"705 Kbps","isStreaming":false,"title":"Better off Dead","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/13 Better off Dead.flac","trackType":"flac"} Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 31 Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":263,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"705 Kbps","isStreaming":false,"title":"Better off Dead","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/13 Better off Dead.flac","trackType":"flac"} Oct 08 00:16:53 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 31 Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: ------------------------------ 27ms Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: ------------------------------ 26ms Oct 08 00:16:53 musicadeldiablo volumio[1149]: info: ------------------------------ 26ms Oct 08 00:17:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:17:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:17:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:17:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:17:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:17:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:17:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:17:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:17:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:17:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:17:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:17:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:18:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:18:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:18:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:18:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:18:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:18:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:18:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:18:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:18:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:18:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:18:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:18:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:19:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:19:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:19:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:19:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:19:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:19:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:19:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:19:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:19:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:19:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:19:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:19:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:20:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:20:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:20:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:20:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:20:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:20:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:20:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:20:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:20:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:20:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:20:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:20:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:21:11 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:21:11 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:21:11 musicadeldiablo volumio[1149]: info: Prefetching next song Oct 08 00:21:11 musicadeldiablo volumio[1149]: info: DOING PREFETCH IN MPD Oct 08 00:21:11 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/14 Goodbye, Cruel World.flac" Oct 08 00:21:11 musicadeldiablo volumio[1149]: info: Oct 08 00:21:11 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:21:11 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:21:11 musicadeldiablo volumio[1149]: info: sendMpdCommand add "USB/414C-A61F/Musica/(1998) Alternative 4/14 Goodbye, Cruel World.flac" took 1 milliseconds Oct 08 00:21:11 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 08 00:21:11 musicadeldiablo volumio[1149]: info: Oct 08 00:21:11 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:21:11 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:21:11 musicadeldiablo volumio[1149]: info: Oct 08 00:21:11 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:21:11 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:21:11 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 08 00:21:11 musicadeldiablo volumio[1149]: info: sendMpdCommand consume 1 took 2 milliseconds Oct 08 00:21:11 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 08 00:21:11 musicadeldiablo volumio[1149]: info: ------------------------------ 1ms Oct 08 00:21:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:21:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:21:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:21:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:21:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 31 Oct 08 00:21:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: Oct 08 00:21:16 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: Oct 08 00:21:16 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: Oct 08 00:21:16 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: Oct 08 00:21:16 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: Oct 08 00:21:16 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: Oct 08 00:21:16 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: ------------------------------ 7ms Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 7 milliseconds Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: ------------------------------ 7ms Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 6 milliseconds Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: ------------------------------ 4ms Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 4 milliseconds Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":101,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"484 Kbps","isStreaming":false,"title":"Goodbye, Cruel World","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/14 Goodbye, Cruel World.flac","trackType":"flac"} Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 32 Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":101,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"484 Kbps","isStreaming":false,"title":"Goodbye, Cruel World","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/14 Goodbye, Cruel World.flac","trackType":"flac"} Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 32 Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: ------------------------------ 19ms Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: ------------------------------ 18ms Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":101,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"484 Kbps","isStreaming":false,"title":"Goodbye, Cruel World","artist":"Anathema","album":"Alternative 4","uri":"USB/414C-A61F/Musica/(1998) Alternative 4/14 Goodbye, Cruel World.flac","trackType":"flac"} Oct 08 00:21:16 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 32 Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: ------------------------------ 19ms Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:21:16 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:21:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:21:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:21:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:21:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:21:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:21:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:22:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:22:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:22:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:22:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:22:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:22:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:22:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:22:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:22:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:22:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:22:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:22:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:22:52 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:22:52 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: Oct 08 00:22:58 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: Oct 08 00:22:58 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:22:58 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: Oct 08 00:22:58 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: Oct 08 00:22:58 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:22:58 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: Oct 08 00:22:58 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: Oct 08 00:22:58 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:22:58 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:22:58 musicadeldiablo volumio[1149]: error: updateQueue error: null Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: ------------------------------ 8ms Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 7 milliseconds Oct 08 00:22:58 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 32 Oct 08 00:22:58 musicadeldiablo volumio[1149]: 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} Oct 08 00:22:58 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 32 Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService stop Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreStateMachine::stPlaybackTimer Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: ------------------------------ 14ms Oct 08 00:22:58 musicadeldiablo volumio[1149]: error: updateQueue error: null Oct 08 00:22:58 musicadeldiablo volumio[1149]: error: updateQueue error: null Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: ------------------------------ 13ms Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 12 milliseconds Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: ------------------------------ 12ms Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 12 milliseconds Oct 08 00:22:58 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:22:58 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:22:58 musicadeldiablo volumio[1149]: 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} Oct 08 00:22:58 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 0 Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService stop Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus stop Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: No code Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:22:58 musicadeldiablo volumio[1149]: 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} Oct 08 00:22:58 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 0 Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService stop Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus stop Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: No code Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: ------------------------------ 24ms Oct 08 00:22:58 musicadeldiablo volumio[1149]: info: ------------------------------ 23ms Oct 08 00:23:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:23:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:23:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:23:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:23:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:23:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:23:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:23:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:23:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:23:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:23:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:23:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:24:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:24:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:24:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:24:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:24:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:24:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:24:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:24:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:24:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:24:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:24:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:24:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:25:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:25:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:25:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:25:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:25:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:25:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:25:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:25:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:25:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:25:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:25:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:25:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:26:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:26:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:26:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:26:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:26:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:26:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:26:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:26:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:26:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:26:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:26:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:26:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:27:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:27:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:27:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:27:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:27:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:27:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:27:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:27:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:27:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:27:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:27:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:27:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:28:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:28:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:28:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:28:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:28:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:28:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:28:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:28:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:28:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:28:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:28:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:28:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:29:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:29:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:29:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:29:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:29:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:29:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:29:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:29:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:29:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:29:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:29:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:29:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:30:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:30:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:30:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:30:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:30:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:30:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:30:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:30:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:30:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:30:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:30:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:30:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:31:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:31:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:31:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:31:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:31:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:31:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:31:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:31:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:31:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:31:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:31:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:31:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:32:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:32:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:32:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:32:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:32:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:32:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:32:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:32:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:32:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:32:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:32:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:32:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:33:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:33:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:33:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:33:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:33:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:33:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:33:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:33:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:33:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:33:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:33:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:33:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:34:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:34:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:34:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:34:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:34:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:34:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:34:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:34:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:34:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:34:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:34:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:34:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:35:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:35:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:35:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:35:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:35:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:35:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:35:15 musicadeldiablo volumio[1149]: verbose: New Socket.io Connection to 192.168.1.74 from 192.168.1.65 UA: Mozilla/5.0 (Linux; Android 14; CPH2363 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetVisibleSources Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: Received Get System Info Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: Listing playlists Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetQueue Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CoreStateMachine::getQueue Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CorePlayQueue::getQueue Oct 08 00:35:15 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 08 00:35:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 08 00:35:17 musicadeldiablo volumio[1149]: info: Received Get System Info Oct 08 00:35:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:35:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:35:17 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:35:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:35:17 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:35:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:35:20 musicadeldiablo sudo[30202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 08 00:35:20 musicadeldiablo sudo[30202]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 00:35:20 musicadeldiablo sudo[30202]: pam_unix(sudo:session): session closed for user root Oct 08 00:35:20 musicadeldiablo sudo[30205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 08 00:35:20 musicadeldiablo sudo[30205]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 00:35:20 musicadeldiablo sudo[30205]: pam_unix(sudo:session): session closed for user root Oct 08 00:35:20 musicadeldiablo volumio[1149]: verbose: New Socket.io Connection to 192.168.1.74 from 192.168.1.65 UA: Mozilla/5.0 (Linux; Android 14; CPH2363 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 08 00:35:21 musicadeldiablo sudo[30209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 08 00:35:21 musicadeldiablo sudo[30209]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 00:35:21 musicadeldiablo sudo[30209]: pam_unix(sudo:session): session closed for user root Oct 08 00:35:21 musicadeldiablo sudo[30212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 08 00:35:21 musicadeldiablo sudo[30212]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 00:35:21 musicadeldiablo sudo[30212]: pam_unix(sudo:session): session closed for user root Oct 08 00:35:21 musicadeldiablo volumio[1149]: verbose: New Socket.io Connection to 192.168.1.74 from 192.168.1.65 UA: Mozilla/5.0 (Linux; Android 14; CPH2363 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetVisibleSources Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: Received Get System Info Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: Listing playlists Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 08 00:35:21 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 08 00:35:22 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetQueue Oct 08 00:35:22 musicadeldiablo volumio[1149]: info: CoreStateMachine::getQueue Oct 08 00:35:22 musicadeldiablo volumio[1149]: info: CorePlayQueue::getQueue Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: Received Get System Info Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: Received Get System Info Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:35:23 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:35:34 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 08 00:35:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:35:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:35:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:35:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:35:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:35:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:35:44 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 08 00:35:44 musicadeldiablo volumio[1149]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 08 00:35:44 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 08 00:35:44 musicadeldiablo volumio[1149]: info: Received Get System Version Oct 08 00:35:44 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 08 00:35:44 musicadeldiablo volumio[1149]: info: Received Get System Info Oct 08 00:35:44 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:35:44 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:35:44 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:35:44 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:35:44 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:35:44 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:36:06 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 08 00:36:06 musicadeldiablo volumio[1149]: info: CURURI: albums://Architectural/Architectural%20-%20Peacetime.%20SEMANTICA%2040 Oct 08 00:36:06 musicadeldiablo volumio[1149]: info: Preload queue cleared Oct 08 00:36:06 musicadeldiablo volumio[1149]: info: Preloading song: music-library/USB/414C-A61F/Musica/[semantica 40] architectural - peacetime 2012 flac/architectural - a.architectural - looking ahead.semantica40.flac Oct 08 00:36:06 musicadeldiablo volumio[1149]: info: Preloading song: music-library/USB/414C-A61F/Musica/[semantica 40] architectural - peacetime 2012 flac/architectural - b.architectural - peacetime.semantica40.flac Oct 08 00:36:06 musicadeldiablo volumio[1149]: info: Exploding uri music-library/USB/414C-A61F/Musica/[semantica 40] architectural - peacetime 2012 flac/architectural - a.architectural - looking ahead.semantica40.flac in service mpd Oct 08 00:36:06 musicadeldiablo volumio[1149]: info: ALBUMART /albumart?cacheid=117&web=Architectural/Architectural%20-%20Peacetime.%20SEMANTICA%2040/extralarge&path=%2Fmnt%2FUSB%2F414C-A61F%2FMusica%2F%5Bsemantica%2040%5D%20architectural%20-%20peacetime%202012%20flac%2Farchitectural%20-%20a.architectural%20-%20looking%20ahead.semantica40.flac&metadata=false Oct 08 00:36:06 musicadeldiablo volumio[1149]: info: URI /mnt/USB/414C-A61F/Musica/[semantica 40] architectural - peacetime 2012 flac/architectural - a.architectural - looking ahead.semantica40.flac Oct 08 00:36:06 musicadeldiablo volumio[1149]: info: Exploding uri music-library/USB/414C-A61F/Musica/[semantica 40] architectural - peacetime 2012 flac/architectural - b.architectural - peacetime.semantica40.flac in service mpd Oct 08 00:36:06 musicadeldiablo volumio[1149]: info: ALBUMART /albumart?cacheid=117&web=Architectural/Architectural%20-%20Peacetime.%20SEMANTICA%2040/extralarge&path=%2Fmnt%2FUSB%2F414C-A61F%2FMusica%2F%5Bsemantica%2040%5D%20architectural%20-%20peacetime%202012%20flac%2Farchitectural%20-%20b.architectural%20-%20peacetime.semantica40.flac&metadata=false Oct 08 00:36:06 musicadeldiablo volumio[1149]: info: URI /mnt/USB/414C-A61F/Musica/[semantica 40] architectural - peacetime 2012 flac/architectural - b.architectural - peacetime.semantica40.flac Oct 08 00:36:07 musicadeldiablo volumio[1149]: info: No valid Plugin REST Endpoint Oct 08 00:36:13 musicadeldiablo sudo[30255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 08 00:36:13 musicadeldiablo sudo[30255]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 00:36:13 musicadeldiablo sudo[30255]: pam_unix(sudo:session): session closed for user root Oct 08 00:36:13 musicadeldiablo sudo[30258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 08 00:36:13 musicadeldiablo sudo[30258]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 00:36:13 musicadeldiablo sudo[30258]: pam_unix(sudo:session): session closed for user root Oct 08 00:36:13 musicadeldiablo volumio[1149]: verbose: New Socket.io Connection to 192.168.1.74 from 192.168.1.65 UA: Mozilla/5.0 (Linux; Android 14; CPH2363 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:36:13 musicadeldiablo sudo[30261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 08 00:36:13 musicadeldiablo sudo[30261]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 00:36:13 musicadeldiablo sudo[30261]: pam_unix(sudo:session): session closed for user root Oct 08 00:36:13 musicadeldiablo sudo[30264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 08 00:36:13 musicadeldiablo sudo[30264]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 00:36:13 musicadeldiablo sudo[30264]: pam_unix(sudo:session): session closed for user root Oct 08 00:36:13 musicadeldiablo volumio[1149]: verbose: New Socket.io Connection to 192.168.1.74 from 192.168.1.65 UA: Mozilla/5.0 (Linux; Android 14; CPH2363 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetVisibleSources Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetQueue Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreStateMachine::getQueue Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getQueue Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: Listing playlists Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: Received Get System Info Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 08 00:36:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 08 00:36:17 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: Received Get System Info Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: Received Get System Info Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:36:20 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:36:36 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 08 00:36:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:36:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:36:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:36:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:36:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:36:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:36:45 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 08 00:36:45 musicadeldiablo volumio[1149]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 08 00:36:45 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 08 00:36:45 musicadeldiablo volumio[1149]: info: Received Get System Version Oct 08 00:36:45 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 08 00:36:45 musicadeldiablo volumio[1149]: info: Received Get System Info Oct 08 00:36:45 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:36:45 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:36:45 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:36:45 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:36:45 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:36:45 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:37:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:37:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:37:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:37:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:37:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:37:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:37:36 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 08 00:37:36 musicadeldiablo volumio[1149]: info: CURURI: albums:// Oct 08 00:37:36 musicadeldiablo volumio[1149]: info: listAlbums - loading Albums from cache Oct 08 00:37:36 musicadeldiablo volumio[1149]: info: Preload queue cleared Oct 08 00:37:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:37:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:37:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:37:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:37:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 08 00:37:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:37:56 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 08 00:37:56 musicadeldiablo volumio[1149]: info: CURURI: albums://Funeral%20Mist/Salvation Oct 08 00:37:56 musicadeldiablo volumio[1149]: info: Preload queue cleared Oct 08 00:37:56 musicadeldiablo volumio[1149]: info: Preloading song: music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/01 Agnus Dei.flac Oct 08 00:37:56 musicadeldiablo volumio[1149]: info: Preloading song: music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/02 Breathing Wounds.flac Oct 08 00:37:56 musicadeldiablo volumio[1149]: info: Preloading song: music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/03 Holy Poison.flac Oct 08 00:37:56 musicadeldiablo volumio[1149]: info: Preloading song: music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/04 Sun Of Hope.flac Oct 08 00:37:56 musicadeldiablo volumio[1149]: info: Preloading song: music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/05 Perdition's Light.flac Oct 08 00:37:56 musicadeldiablo volumio[1149]: info: Preloading song: music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/06 Across The Qliphoth.flac Oct 08 00:37:56 musicadeldiablo volumio[1149]: info: Preloading song: music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/07 Realm Of Plagues.flac Oct 08 00:37:56 musicadeldiablo volumio[1149]: info: Preloading song: music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/08 Circle Of Eyes.flac Oct 08 00:37:56 musicadeldiablo volumio[1149]: info: Preloading song: music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/09 Bread To Stone.flac Oct 08 00:37:56 musicadeldiablo volumio[1149]: info: Preloading song: music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/10 In Manus Tuas.flac Oct 08 00:37:56 musicadeldiablo volumio[1149]: info: Preloading song: music-library/USB/414C-A61F/Musica/bialettisempre/2003 - Salvation/06. Across The Qlipoth.mp3 Oct 08 00:37:56 musicadeldiablo volumio[1149]: info: Exploding uri music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/01 Agnus Dei.flac in service mpd Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: ALBUMART /albumart?cacheid=117&web=Funeral%20Mist/Salvation/extralarge&path=%2Fmnt%2FUSB%2F414C-A61F%2FMusica%2F(2003)%20Salvation%20%5BFLAC%5D%2F01%20Agnus%20Dei.flac&metadata=false Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: URI /mnt/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/01 Agnus Dei.flac Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: Exploding uri music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/02 Breathing Wounds.flac in service mpd Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: ALBUMART /albumart?cacheid=117&web=Funeral%20Mist/Salvation/extralarge&path=%2Fmnt%2FUSB%2F414C-A61F%2FMusica%2F(2003)%20Salvation%20%5BFLAC%5D%2F02%20Breathing%20Wounds.flac&metadata=false Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: URI /mnt/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/02 Breathing Wounds.flac Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: Exploding uri music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/03 Holy Poison.flac in service mpd Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: ALBUMART /albumart?cacheid=117&web=Funeral%20Mist/Salvation/extralarge&path=%2Fmnt%2FUSB%2F414C-A61F%2FMusica%2F(2003)%20Salvation%20%5BFLAC%5D%2F03%20Holy%20Poison.flac&metadata=false Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: URI /mnt/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/03 Holy Poison.flac Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: Exploding uri music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/04 Sun Of Hope.flac in service mpd Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: ALBUMART /albumart?cacheid=117&web=Funeral%20Mist/Salvation/extralarge&path=%2Fmnt%2FUSB%2F414C-A61F%2FMusica%2F(2003)%20Salvation%20%5BFLAC%5D%2F04%20Sun%20Of%20Hope.flac&metadata=false Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: URI /mnt/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/04 Sun Of Hope.flac Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: Exploding uri music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/05 Perdition's Light.flac in service mpd Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: ALBUMART /albumart?cacheid=117&web=Funeral%20Mist/Salvation/extralarge&path=%2Fmnt%2FUSB%2F414C-A61F%2FMusica%2F(2003)%20Salvation%20%5BFLAC%5D%2F05%20Perdition's%20Light.flac&metadata=false Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: URI /mnt/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/05 Perdition's Light.flac Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: Exploding uri music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/06 Across The Qliphoth.flac in service mpd Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: ALBUMART /albumart?cacheid=117&web=Funeral%20Mist/Salvation/extralarge&path=%2Fmnt%2FUSB%2F414C-A61F%2FMusica%2F(2003)%20Salvation%20%5BFLAC%5D%2F06%20Across%20The%20Qliphoth.flac&metadata=false Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: URI /mnt/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/06 Across The Qliphoth.flac Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: Exploding uri music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/07 Realm Of Plagues.flac in service mpd Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: ALBUMART /albumart?cacheid=117&web=Funeral%20Mist/Salvation/extralarge&path=%2Fmnt%2FUSB%2F414C-A61F%2FMusica%2F(2003)%20Salvation%20%5BFLAC%5D%2F07%20Realm%20Of%20Plagues.flac&metadata=false Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: URI /mnt/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/07 Realm Of Plagues.flac Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: Exploding uri music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/08 Circle Of Eyes.flac in service mpd Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: ALBUMART /albumart?cacheid=117&web=Funeral%20Mist/Salvation/extralarge&path=%2Fmnt%2FUSB%2F414C-A61F%2FMusica%2F(2003)%20Salvation%20%5BFLAC%5D%2F08%20Circle%20Of%20Eyes.flac&metadata=false Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: URI /mnt/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/08 Circle Of Eyes.flac Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: Exploding uri music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/09 Bread To Stone.flac in service mpd Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: ALBUMART /albumart?cacheid=117&web=Funeral%20Mist/Salvation/extralarge&path=%2Fmnt%2FUSB%2F414C-A61F%2FMusica%2F(2003)%20Salvation%20%5BFLAC%5D%2F09%20Bread%20To%20Stone.flac&metadata=false Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: URI /mnt/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/09 Bread To Stone.flac Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: Exploding uri music-library/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/10 In Manus Tuas.flac in service mpd Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: ALBUMART /albumart?cacheid=117&web=Funeral%20Mist/Salvation/extralarge&path=%2Fmnt%2FUSB%2F414C-A61F%2FMusica%2F(2003)%20Salvation%20%5BFLAC%5D%2F10%20In%20Manus%20Tuas.flac&metadata=false Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: URI /mnt/USB/414C-A61F/Musica/(2003) Salvation [FLAC]/10 In Manus Tuas.flac Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: Exploding uri music-library/USB/414C-A61F/Musica/bialettisempre/2003 - Salvation/06. Across The Qlipoth.mp3 in service mpd Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: ALBUMART /albumart?cacheid=117&web=Funeral%20Mist/Salvation/extralarge&path=%2Fmnt%2FUSB%2F414C-A61F%2FMusica%2Fbialettisempre%2F2003%20-%20Salvation%2F06.%20Across%20The%20Qlipoth.mp3&metadata=false Oct 08 00:37:57 musicadeldiablo volumio[1149]: info: URI /mnt/USB/414C-A61F/Musica/bialettisempre/2003 - Salvation/06. Across The Qlipoth.mp3 Oct 08 00:37:58 musicadeldiablo volumio[1149]: info: No valid Plugin REST Endpoint Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Preload queue cleared Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioAddQueueItems Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::addQueueItems Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::addQueueItems Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Preload queue cleared Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Adding Item to queue: albums://Funeral%20Mist/Salvation Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Exploding uri albums://Funeral%20Mist/Salvation in service mpd Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::saveQueue Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::updateTrackBlock Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrackBlock Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPlay Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::play index 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::stop Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::play index undefined Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::clearAddPlayTracks USB/414C-A61F/Musica/(2003) Salvation [FLAC]/01 Agnus Dei.flac Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand stop Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand stop took 2 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand clear Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Oct 08 00:38:07 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand clear took 6 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand add "USB/414C-A61F/Musica/(2003) Salvation [FLAC]/01 Agnus Dei.flac" Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Oct 08 00:38:07 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Oct 08 00:38:07 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:38:07 musicadeldiablo volumio[1149]: error: updateQueue error: null Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Oct 08 00:38:07 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ------------------------------ 6ms Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand add "USB/414C-A61F/Musica/(2003) Salvation [FLAC]/01 Agnus Dei.flac" took 4 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ------------------------------ 2ms Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand play Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Oct 08 00:38:07 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:38:07 musicadeldiablo volumio[1149]: error: Upnp client error: Error: This socket has been ended by the other party Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ------------------------------ 4ms Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand play took 2 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ------------------------------ 3ms Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Oct 08 00:38:07 musicadeldiablo volumio[1149]: ---------------------------- MPD announces system playlist update Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Ignoring MPD Status Update Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ------------------------------ 1ms Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Oct 08 00:38:07 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Oct 08 00:38:07 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Oct 08 00:38:07 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Oct 08 00:38:07 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Oct 08 00:38:07 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Oct 08 00:38:07 musicadeldiablo volumio[1149]: ---------------------------- MPD announces state update: player Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 5 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ControllerMpd::getState Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 4 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 4 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 2 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 5 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand status took 4 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseState Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":273,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Agnus Dei","artist":"Funeral Mist","album":"Salvation","uri":"USB/414C-A61F/Musica/(2003) Salvation [FLAC]/01 Agnus Dei.flac","trackType":"flac"} Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus stop Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":273,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Agnus Dei","artist":"Funeral Mist","album":"Salvation","uri":"USB/414C-A61F/Musica/(2003) Salvation [FLAC]/01 Agnus Dei.flac","trackType":"flac"} Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":273,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Agnus Dei","artist":"Funeral Mist","album":"Salvation","uri":"USB/414C-A61F/Musica/(2003) Salvation [FLAC]/01 Agnus Dei.flac","trackType":"flac"} Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":273,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Agnus Dei","artist":"Funeral Mist","album":"Salvation","uri":"USB/414C-A61F/Musica/(2003) Salvation [FLAC]/01 Agnus Dei.flac","trackType":"flac"} Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ------------------------------ 31ms Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ------------------------------ 36ms Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ------------------------------ 35ms Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ------------------------------ 35ms Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 27 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: sendMpdCommand playlistinfo took 27 milliseconds Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: ControllerMpd::parseTrackInfo Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":273,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Agnus Dei","artist":"Funeral Mist","album":"Salvation","uri":"USB/414C-A61F/Musica/(2003) Salvation [FLAC]/01 Agnus Dei.flac","trackType":"flac"} Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ControllerMpd::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::servicePushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":273,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Agnus Dei","artist":"Funeral Mist","album":"Salvation","uri":"USB/414C-A61F/Musica/(2003) Salvation [FLAC]/01 Agnus Dei.flac","trackType":"flac"} Oct 08 00:38:07 musicadeldiablo volumio[1149]: verbose: CURRENT POSITION 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState stateService play Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::syncState currentStatus play Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: Received an update from plugin. extracting info from payload Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreStateMachine::pushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioPushState Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ------------------------------ 50ms Oct 08 00:38:07 musicadeldiablo volumio[1149]: info: ------------------------------ 49ms Oct 08 00:38:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:38:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:38:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:38:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:38:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:38:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:38:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:38:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:38:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:38:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:38:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:39:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:39:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:39:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:39:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:39:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:39:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:39:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:39:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:39:43 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:39:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:39:43 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:39:43 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:40:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 08 00:40:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 08 00:40:13 musicadeldiablo volumio[1149]: info: Discovery: Getting this device information Oct 08 00:40:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 08 00:40:13 musicadeldiablo volumio[1149]: info: CorePlayQueue::getTrack 33 Oct 08 00:40:13 musicadeldiablo volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 08 00:40:13 musicadeldiablo volumio[1149]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 08 00:40:13 musicadeldiablo volumio[1149]: Error: connect ETIMEDOUT 146.75.106.79:443 Oct 08 00:40:13 musicadeldiablo volumio[1149]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 08 00:40:13 musicadeldiablo volumio[1149]: errno: -110, Oct 08 00:40:13 musicadeldiablo volumio[1149]: code: 'ETIMEDOUT', Oct 08 00:40:13 musicadeldiablo volumio[1149]: syscall: 'connect', Oct 08 00:40:13 musicadeldiablo volumio[1149]: address: '146.75.106.79', Oct 08 00:40:13 musicadeldiablo volumio[1149]: port: 443 Oct 08 00:40:13 musicadeldiablo volumio[1149]: } Oct 08 00:40:13 musicadeldiablo volumio[1149]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 08 00:40:14 musicadeldiablo sudo[30699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-07 23:39 Oct 08 00:40:14 musicadeldiablo sudo[30699]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"