Dec 23 21:50:00 volumio volumio[1352]: verbose: New Socket.io Connection to 10.0.0.12:3000 from 10.0.0.157 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 23 21:50:00 volumio volumio[1352]: info: Discovery: Getting this device information Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState Dec 23 21:50:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 0 Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 23 21:50:00 volumio volumio[1352]: info: Discovery: Getting this device information Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState Dec 23 21:50:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 0 Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 23 21:50:00 volumio sudo[2469]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 23 21:50:00 volumio sudo[2469]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 21:50:00 volumio sudo[2474]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 23 21:50:00 volumio sudo[2474]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 21:50:00 volumio sudo[2474]: pam_unix(sudo:session): session closed for user root Dec 23 21:50:00 volumio sudo[2469]: pam_unix(sudo:session): session closed for user root Dec 23 21:50:00 volumio sudo[2481]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 23 21:50:00 volumio sudo[2481]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 21:50:00 volumio sudo[2481]: pam_unix(sudo:session): session closed for user root Dec 23 21:50:00 volumio sudo[2486]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 23 21:50:00 volumio sudo[2486]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 21:50:00 volumio sudo[2486]: pam_unix(sudo:session): session closed for user root Dec 23 21:50:00 volumio sudo[2493]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 23 21:50:00 volumio sudo[2493]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 21:50:00 volumio sudo[2493]: pam_unix(sudo:session): session closed for user root Dec 23 21:50:00 volumio sudo[2497]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 23 21:50:00 volumio sudo[2497]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 21:50:00 volumio sudo[2497]: pam_unix(sudo:session): session closed for user root Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 23 21:50:00 volumio volumio[1352]: info: Discovery: Getting this device information Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState Dec 23 21:50:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 0 Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 23 21:50:00 volumio volumio[1352]: info: Discovery: Getting this device information Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState Dec 23 21:50:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 0 Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState Dec 23 21:50:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 0 Dec 23 21:50:00 volumio volumio[1352]: verbose: New Socket.io Connection to 10.0.0.12:3000 from 10.0.0.157 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 23 21:50:00 volumio volumio[1352]: info: Discovery: Getting this device information Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState Dec 23 21:50:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 0 Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 23 21:50:00 volumio volumio[1352]: verbose: New Socket.io Connection to 10.0.0.12:3000 from 10.0.0.157 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 23 21:50:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 23 21:50:03 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 23 21:50:03 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 23 21:50:04 volumio sudo[2509]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 23 21:50:04 volumio sudo[2509]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 21:50:04 volumio sudo[2509]: pam_unix(sudo:session): session closed for user root Dec 23 21:50:04 volumio sudo[2511]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 23 21:50:04 volumio sudo[2511]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 21:50:04 volumio sudo[2511]: pam_unix(sudo:session): session closed for user root Dec 23 21:50:04 volumio volumio[1352]: verbose: New Socket.io Connection to 10.0.0.12 from 10.0.0.157 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Dec 23 21:50:04 volumio sudo[2515]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 23 21:50:04 volumio sudo[2515]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 21:50:04 volumio sudo[2515]: pam_unix(sudo:session): session closed for user root Dec 23 21:50:04 volumio sudo[2517]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 23 21:50:04 volumio sudo[2517]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 21:50:04 volumio sudo[2517]: pam_unix(sudo:session): session closed for user root Dec 23 21:50:04 volumio volumio[1352]: verbose: New Socket.io Connection to 10.0.0.12 from 10.0.0.157 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Dec 23 21:50:04 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState Dec 23 21:50:04 volumio volumio[1352]: info: CorePlayQueue::getTrack 0 Dec 23 21:50:04 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 23 21:50:04 volumio volumio[1352]: info: Listing playlists Dec 23 21:50:04 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 23 21:50:04 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 23 21:50:04 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 23 21:50:04 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 23 21:50:06 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 23 21:50:06 volumio volumio[1352]: info: Received Get System Info Dec 23 21:50:06 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 23 21:50:06 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 23 21:50:06 volumio volumio[1352]: info: Discovery: Getting this device information Dec 23 21:50:06 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState Dec 23 21:50:06 volumio volumio[1352]: info: CorePlayQueue::getTrack 0 Dec 23 21:50:06 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioNext Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::next Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::stop Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::stPlaybackTimer Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::updateTrackBlock Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrackBlock Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 0 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::serviceStop Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 0 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::serviceStop Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::stop Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 21:50:15 volumio volumio[1352]: info: Dec 23 21:50:15 volumio volumio[1352]: ---------------------------- MPD announces state update: player Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand stop took 7 milliseconds Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::play index undefined Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::startPlaybackTimer Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::clearAddPlayTracks NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::updateTrackBlock Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrackBlock Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand status took 5 milliseconds Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand stop took 1 milliseconds Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand clear Dec 23 21:50:15 volumio volumio[1352]: info: Dec 23 21:50:15 volumio volumio[1352]: ---------------------------- MPD announces state update: player Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:15 volumio volumio[1352]: info: Dec 23 21:50:15 volumio volumio[1352]: ---------------------------- MPD announces state update: player Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:15 volumio volumio[1352]: info: Dec 23 21:50:15 volumio volumio[1352]: ---------------------------- MPD announces system playlist update Dec 23 21:50:15 volumio volumio[1352]: info: Ignoring MPD Status Update Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand clear took 3 milliseconds Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand status took 2 milliseconds Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand status took 2 milliseconds Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand add "NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a" Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"圣诞结","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - 圣诞结.m4a","trackType":"m4a"} Dec 23 21:50:15 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState stateService stop Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus stop Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: No code Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: 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} Dec 23 21:50:15 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState stateService stop Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus stop Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: No code Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: 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} Dec 23 21:50:15 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState stateService stop Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus stop Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: No code Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: ------------------------------ 61ms Dec 23 21:50:15 volumio volumio[1352]: info: ------------------------------ 56ms Dec 23 21:50:15 volumio volumio[1352]: info: ------------------------------ 55ms Dec 23 21:50:15 volumio volumio[1352]: info: Dec 23 21:50:15 volumio volumio[1352]: ---------------------------- MPD announces system playlist update Dec 23 21:50:15 volumio volumio[1352]: info: Ignoring MPD Status Update Dec 23 21:50:15 volumio volumio[1352]: info: Dec 23 21:50:15 volumio volumio[1352]: ---------------------------- MPD announces system playlist update Dec 23 21:50:15 volumio volumio[1352]: info: Ignoring MPD Status Update Dec 23 21:50:15 volumio volumio[1352]: error: updateQueue error: null Dec 23 21:50:15 volumio volumio[1352]: info: Dec 23 21:50:15 volumio volumio[1352]: ---------------------------- MPD announces system playlist update Dec 23 21:50:15 volumio volumio[1352]: info: Ignoring MPD Status Update Dec 23 21:50:15 volumio volumio[1352]: info: ------------------------------ 57ms Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand add "NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a" took 54 milliseconds Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand play Dec 23 21:50:15 volumio volumio[1352]: info: ------------------------------ 31ms Dec 23 21:50:15 volumio volumio[1352]: info: ------------------------------ 30ms Dec 23 21:50:15 volumio volumio[1352]: info: ------------------------------ 29ms Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand play took 28 milliseconds Dec 23 21:50:15 volumio volumio[1352]: info: Dec 23 21:50:15 volumio volumio[1352]: ---------------------------- MPD announces system playlist update Dec 23 21:50:15 volumio volumio[1352]: info: Ignoring MPD Status Update Dec 23 21:50:15 volumio volumio[1352]: info: Dec 23 21:50:15 volumio volumio[1352]: ---------------------------- MPD announces system playlist update Dec 23 21:50:15 volumio volumio[1352]: info: Ignoring MPD Status Update Dec 23 21:50:15 volumio volumio[1352]: info: ------------------------------ 3ms Dec 23 21:50:15 volumio volumio[1352]: info: ------------------------------ 3ms Dec 23 21:50:15 volumio volumio[1352]: info: Dec 23 21:50:15 volumio volumio[1352]: ---------------------------- MPD announces state update: player Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:15 volumio volumio[1352]: info: Dec 23 21:50:15 volumio volumio[1352]: ---------------------------- MPD announces state update: player Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:15 volumio volumio[1352]: info: Dec 23 21:50:15 volumio volumio[1352]: ---------------------------- MPD announces state update: player Dec 23 21:50:15 volumio volumio[1352]: info: Dec 23 21:50:15 volumio volumio[1352]: ---------------------------- MPD announces state update: player Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand status took 2 milliseconds Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand status took 1 milliseconds Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:15 volumio volumio[1352]: info: Dec 23 21:50:15 volumio volumio[1352]: ---------------------------- MPD announces state update: player Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:15 volumio volumio[1352]: info: Dec 23 21:50:15 volumio volumio[1352]: ---------------------------- MPD announces state update: player Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand status took 4 milliseconds Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand status took 4 milliseconds Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand status took 3 milliseconds Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand status took 2 milliseconds Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:15 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus stop Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:15 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:15 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: ------------------------------ 19ms Dec 23 21:50:15 volumio volumio[1352]: info: ------------------------------ 27ms Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 23 21:50:15 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:15 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:15 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:15 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:15 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:15 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:15 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:15 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:15 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:15 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:15 volumio volumio[1352]: info: ------------------------------ 81ms Dec 23 21:50:15 volumio volumio[1352]: info: ------------------------------ 81ms Dec 23 21:50:15 volumio volumio[1352]: info: ------------------------------ 79ms Dec 23 21:50:15 volumio volumio[1352]: info: ------------------------------ 78ms Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 23 21:50:15 volumio volumio[1352]: info: Discovery: Getting this device information Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::volumioGetState Dec 23 21:50:15 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 23 21:50:15 volumio volumio[1352]: verbose: New Socket.io Connection to 10.0.0.12:3000 from 10.0.0.157 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 23 21:50:15 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 23 21:50:26 volumio volumio[1352]: info: VolumeController::SetAlsaVolume91 Dec 23 21:50:26 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:26 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:26 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:26 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:26 volumio volumio[1352]: info: Dec 23 21:50:26 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:50:26 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:26 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:26 volumio volumio[1352]: info: Dec 23 21:50:26 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:50:26 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:26 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:26 volumio volumio[1352]: info: Dec 23 21:50:26 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:50:26 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:26 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:26 volumio volumio[1352]: info: sendMpdCommand status took 2 milliseconds Dec 23 21:50:26 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:26 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:26 volumio volumio[1352]: info: sendMpdCommand status took 4 milliseconds Dec 23 21:50:26 volumio volumio[1352]: info: sendMpdCommand status took 3 milliseconds Dec 23 21:50:26 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 23 21:50:26 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:26 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:26 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:26 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:26 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:26 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:26 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:26 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:26 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12355,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:26 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:26 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:26 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:26 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:26 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:26 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:26 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:26 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:26 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:26 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:26 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:26 volumio volumio[1352]: info: ------------------------------ 20ms Dec 23 21:50:26 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 17 milliseconds Dec 23 21:50:26 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 16 milliseconds Dec 23 21:50:26 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:26 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:26 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:26 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:26 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:26 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12355,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:26 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:26 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:26 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:26 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:26 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:26 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:26 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:26 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:26 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:26 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:26 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:26 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:26 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:26 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12355,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:26 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:26 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:26 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:26 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:26 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:26 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:26 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:26 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:26 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:26 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:26 volumio volumio[1352]: info: ------------------------------ 53ms Dec 23 21:50:26 volumio volumio[1352]: info: ------------------------------ 54ms Dec 23 21:50:27 volumio volumio[1352]: info: VolumeController::SetAlsaVolume101 Dec 23 21:50:27 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:27 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:27 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:27 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:27 volumio volumio[1352]: info: Dec 23 21:50:27 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:50:27 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:27 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:27 volumio volumio[1352]: info: Dec 23 21:50:27 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:50:27 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:27 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:27 volumio volumio[1352]: info: Dec 23 21:50:27 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:50:27 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:27 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:27 volumio volumio[1352]: info: sendMpdCommand status took 2 milliseconds Dec 23 21:50:27 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:27 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:27 volumio volumio[1352]: info: sendMpdCommand status took 2 milliseconds Dec 23 21:50:27 volumio volumio[1352]: info: sendMpdCommand status took 3 milliseconds Dec 23 21:50:27 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 23 21:50:27 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:27 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:27 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:27 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:27 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:27 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:27 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:27 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:27 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12733,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:27 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:27 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:27 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:27 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:27 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:27 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:27 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:27 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:27 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:27 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:27 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:27 volumio volumio[1352]: info: ------------------------------ 22ms Dec 23 21:50:27 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 17 milliseconds Dec 23 21:50:27 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 18 milliseconds Dec 23 21:50:27 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:27 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:27 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:27 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:27 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:27 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12733,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:27 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:27 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:27 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:27 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:27 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:27 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:27 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:27 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:27 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:27 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:27 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:27 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:27 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:27 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12733,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:27 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:27 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:27 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:27 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:27 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:27 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:27 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:27 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:27 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:27 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:27 volumio volumio[1352]: info: ------------------------------ 51ms Dec 23 21:50:27 volumio volumio[1352]: info: ------------------------------ 51ms Dec 23 21:50:28 volumio volumio[1352]: info: VolumeController::SetAlsaVolume104 Dec 23 21:50:28 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:28 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:28 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:28 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:29 volumio volumio[1352]: info: VolumeController::SetAlsaVolume105 Dec 23 21:50:29 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:29 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:29 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:29 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:33 volumio volumio[1352]: info: VolumeController::SetAlsaVolume105 Dec 23 21:50:33 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:33 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:33 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:33 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:35 volumio volumio[1352]: info: VolumeController::SetAlsaVolume110 Dec 23 21:50:35 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:35 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:35 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:35 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:36 volumio volumio[1352]: info: VolumeController::SetAlsaVolume104 Dec 23 21:50:36 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:36 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:36 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:36 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:36 volumio volumio[1352]: info: VolumeController::SetAlsaVolume105 Dec 23 21:50:36 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:36 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:36 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:36 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:38 volumio volumio[1352]: info: VolumeController::SetAlsaVolume95 Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:38 volumio volumio[1352]: info: Dec 23 21:50:38 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:50:38 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:38 volumio volumio[1352]: info: Dec 23 21:50:38 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:50:38 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:38 volumio volumio[1352]: info: Dec 23 21:50:38 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:50:38 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:38 volumio volumio[1352]: info: sendMpdCommand status took 2 milliseconds Dec 23 21:50:38 volumio volumio[1352]: info: sendMpdCommand status took 2 milliseconds Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:38 volumio volumio[1352]: info: sendMpdCommand status took 4 milliseconds Dec 23 21:50:38 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 23 21:50:38 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:38 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23726,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:38 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:38 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:38 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23726,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:38 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:38 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:38 volumio volumio[1352]: info: ------------------------------ 35ms Dec 23 21:50:38 volumio volumio[1352]: info: ------------------------------ 35ms Dec 23 21:50:38 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 31 milliseconds Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:38 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23726,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:38 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:38 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:38 volumio volumio[1352]: info: ------------------------------ 51ms Dec 23 21:50:38 volumio volumio[1352]: info: VolumeController::SetAlsaVolume91 Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:38 volumio volumio[1352]: info: Dec 23 21:50:38 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:50:38 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:38 volumio volumio[1352]: info: Dec 23 21:50:38 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:50:38 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:38 volumio volumio[1352]: info: Dec 23 21:50:38 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:50:38 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:50:38 volumio volumio[1352]: info: sendMpdCommand status took 2 milliseconds Dec 23 21:50:38 volumio volumio[1352]: info: sendMpdCommand status took 2 milliseconds Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:38 volumio volumio[1352]: info: sendMpdCommand status took 3 milliseconds Dec 23 21:50:38 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 23 21:50:38 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:38 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":24104,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:38 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:38 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:38 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":24104,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:38 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:38 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:38 volumio volumio[1352]: info: ------------------------------ 36ms Dec 23 21:50:38 volumio volumio[1352]: info: ------------------------------ 36ms Dec 23 21:50:38 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 32 milliseconds Dec 23 21:50:38 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:50:38 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":24104,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:50:38 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:50:38 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:38 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:50:38 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:50:38 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:50:38 volumio volumio[1352]: info: ------------------------------ 49ms Dec 23 21:50:46 volumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 21:50:49 volumio volumio[1352]: info: CALLMETHOD: miscellanea appearance setLanguage [object Object] Dec 23 21:50:49 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Dec 23 21:50:49 volumio volumio[1352]: info: Loading i18n strings for locale zh Dec 23 21:50:49 volumio volumio[1352]: Updating browse sources language Dec 23 21:50:49 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 23 21:50:50 volumio volumio[1352]: info: Fetching Streaming Services browse cache Dec 23 21:50:55 volumio volumio[1352]: info: CoreCommandRouter::volumioGetQueue Dec 23 21:50:55 volumio volumio[1352]: info: CoreStateMachine::getQueue Dec 23 21:50:55 volumio volumio[1352]: info: CorePlayQueue::getQueue Dec 23 21:51:00 volumio volumio[1352]: info: VolumeController::SetAlsaVolume81 Dec 23 21:51:00 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:51:00 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:00 volumio volumio[1352]: info: Dec 23 21:51:00 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:51:00 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:51:00 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:51:00 volumio volumio[1352]: info: Dec 23 21:51:00 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:51:00 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:51:00 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:51:00 volumio volumio[1352]: info: Dec 23 21:51:00 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:51:00 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:51:00 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:51:00 volumio volumio[1352]: info: sendMpdCommand status took 2 milliseconds Dec 23 21:51:00 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:51:00 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:51:00 volumio volumio[1352]: info: sendMpdCommand status took 3 milliseconds Dec 23 21:51:00 volumio volumio[1352]: info: sendMpdCommand status took 3 milliseconds Dec 23 21:51:00 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 23 21:51:00 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:51:00 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:51:00 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:51:00 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:51:00 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:51:00 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:51:00 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:51:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:00 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46480,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:51:00 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:51:00 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:51:00 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:51:00 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:51:00 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:00 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:51:00 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:00 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:00 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:00 volumio volumio[1352]: info: ------------------------------ 23ms Dec 23 21:51:00 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 23 21:51:00 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 23 21:51:00 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:51:00 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:51:00 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:51:00 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:51:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:00 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46480,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:51:00 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:51:00 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:51:00 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:51:00 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:51:00 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:00 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:00 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:00 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:00 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:51:00 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:51:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:00 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46480,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:51:00 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:51:00 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:51:00 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:51:00 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:51:00 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:00 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:00 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:00 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:00 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:00 volumio volumio[1352]: info: ------------------------------ 47ms Dec 23 21:51:00 volumio volumio[1352]: info: ------------------------------ 47ms Dec 23 21:51:05 volumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 21:51:05 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 23 21:51:05 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 21:51:05 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 23 21:51:05 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 21:51:05 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 21:51:05 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 21:51:05 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 21:51:05 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 21:51:05 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 21:51:05 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 21:51:05 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 23 21:51:05 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 23 21:51:11 volumio volumio[1352]: info: VolumeController::SetAlsaVolume76 Dec 23 21:51:11 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:11 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:11 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:51:11 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:11 volumio volumio[1352]: info: Dec 23 21:51:11 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:51:11 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:51:11 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:51:11 volumio volumio[1352]: info: Dec 23 21:51:11 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:51:11 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:51:11 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:51:11 volumio volumio[1352]: info: Dec 23 21:51:11 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:51:11 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:51:11 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:51:11 volumio volumio[1352]: info: sendMpdCommand status took 4 milliseconds Dec 23 21:51:11 volumio volumio[1352]: info: sendMpdCommand status took 2 milliseconds Dec 23 21:51:11 volumio volumio[1352]: info: sendMpdCommand status took 1 milliseconds Dec 23 21:51:11 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:51:11 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:51:11 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:51:11 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:51:11 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:51:11 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:51:11 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 23 21:51:11 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 23 21:51:11 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 23 21:51:11 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:51:11 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:51:11 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:51:11 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:51:11 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:51:11 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:11 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":56855,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:51:11 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:51:11 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:51:11 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:51:11 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:51:11 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:11 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:11 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:51:11 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:11 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:11 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:11 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:11 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:51:11 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:51:11 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:11 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":56855,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:51:11 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:51:11 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:51:11 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:51:11 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:51:11 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:11 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:11 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:11 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:11 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:11 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:11 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:51:11 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:51:11 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:11 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":56855,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:51:11 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:51:11 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:51:11 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:51:11 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:51:11 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:11 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:11 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:11 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:11 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:11 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:11 volumio volumio[1352]: info: ------------------------------ 52ms Dec 23 21:51:11 volumio volumio[1352]: info: ------------------------------ 51ms Dec 23 21:51:11 volumio volumio[1352]: info: ------------------------------ 50ms Dec 23 21:51:18 volumio volumio[1352]: info: VolumeController::SetAlsaVolume71 Dec 23 21:51:18 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:18 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:18 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:51:18 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:18 volumio volumio[1352]: info: Dec 23 21:51:18 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:51:18 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:51:18 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:51:18 volumio volumio[1352]: info: Dec 23 21:51:18 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:51:18 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:51:18 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:51:18 volumio volumio[1352]: info: Dec 23 21:51:18 volumio volumio[1352]: ---------------------------- MPD announces state update: mixer Dec 23 21:51:18 volumio volumio[1352]: info: ControllerMpd::getState Dec 23 21:51:18 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand status Dec 23 21:51:18 volumio volumio[1352]: info: sendMpdCommand status took 3 milliseconds Dec 23 21:51:18 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:51:18 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:51:18 volumio volumio[1352]: info: sendMpdCommand status took 5 milliseconds Dec 23 21:51:18 volumio volumio[1352]: info: sendMpdCommand status took 4 milliseconds Dec 23 21:51:18 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 23 21:51:18 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:51:18 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:51:18 volumio volumio[1352]: verbose: ControllerMpd::parseState Dec 23 21:51:18 volumio volumio[1352]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 21:51:18 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:51:18 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:51:18 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:51:18 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:18 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63978,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:51:18 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:51:18 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:51:18 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:51:18 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:51:18 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:18 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:18 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 21:51:18 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:18 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:18 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:18 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:18 volumio volumio[1352]: info: ------------------------------ 25ms Dec 23 21:51:18 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 18 milliseconds Dec 23 21:51:18 volumio volumio[1352]: info: sendMpdCommand playlistinfo took 18 milliseconds Dec 23 21:51:18 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:51:18 volumio volumio[1352]: verbose: ControllerMpd::parseTrackInfo Dec 23 21:51:18 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:51:18 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:51:18 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:18 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63978,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:51:18 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:51:18 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:51:18 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:51:18 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:51:18 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:18 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:18 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:18 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:18 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:18 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:18 volumio volumio[1352]: info: ControllerMpd::pushState Dec 23 21:51:18 volumio volumio[1352]: info: CoreCommandRouter::servicePushState Dec 23 21:51:18 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:18 volumio volumio[1352]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63978,"duration":228,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Shall We Talk","artist":"陈奕迅","album":"七","uri":"NAS/Mymusic/MUSIC/陈奕迅/陈奕迅 -【2003】七/陈奕迅 - Shall We Talk.m4a","trackType":"m4a"} Dec 23 21:51:18 volumio volumio[1352]: verbose: CURRENT POSITION 1 Dec 23 21:51:18 volumio volumio[1352]: info: CoreStateMachine::syncState stateService play Dec 23 21:51:18 volumio volumio[1352]: info: CoreStateMachine::syncState currentStatus play Dec 23 21:51:18 volumio volumio[1352]: info: Received an update from plugin. extracting info from payload Dec 23 21:51:18 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:18 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:18 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:18 volumio volumio[1352]: info: CoreStateMachine::pushState Dec 23 21:51:18 volumio volumio[1352]: info: CorePlayQueue::getTrack 1 Dec 23 21:51:18 volumio volumio[1352]: info: CoreCommandRouter::volumioPushState Dec 23 21:51:18 volumio volumio[1352]: info: ------------------------------ 48ms Dec 23 21:51:18 volumio volumio[1352]: info: ------------------------------ 48ms Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 21:51:21 volumio volumio[1352]: info: Retrieving Cloud Streaming UI Dec 23 21:51:21 volumio volumio[1352]: info: Getting Tidal Cloud Configuration Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 21:51:21 volumio volumio[1352]: info: Getting Qobuz Cloud Configuration Dec 23 21:51:21 volumio volumio[1352]: info: Asking plugin for UI Config Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 21:51:21 volumio volumio[1352]: info: Getting Spotify Cloud Configuration Dec 23 21:51:21 volumio volumio[1352]: info: Asking plugin for UI Config Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 21:51:21 volumio volumio[1352]: info: Saving Spotify Acccount Dec 23 21:51:21 volumio volumio[1352]: info: Got Tidal Cloud Configuration Dec 23 21:51:21 volumio volumio[1352]: info: Got it Dec 23 21:51:21 volumio volumio[1352]: info: Got it Dec 23 21:51:21 volumio volumio[1352]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 21:51:21 volumio volumio[1352]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::volumioGetBrowseSources Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::volumioGetBrowseSources Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::volumioGetBrowseSources Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 23 21:51:21 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 23 21:51:24 volumio volumio[1352]: info: CoreCommandRouter::volumioGetVisibleSources Dec 23 21:51:24 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 23 21:51:26 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 23 21:51:26 volumio volumio[1352]: info: CURURI: music-library Dec 23 21:51:26 volumio volumio[1352]: info: Preload queue cleared Dec 23 21:51:31 volumio volumio[1352]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 23 21:51:31 volumio volumio[1352]: info: CURURI: albums:// Dec 23 21:51:31 volumio volumio[1352]: info: listAlbums - loading Albums from cache Dec 23 21:51:31 volumio volumio[1352]: info: Preload queue cleared Dec 23 21:51:34 volumio volumio[1352]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20xx/xx/3006b442-1721-4298-91d7-d86b1b9ea265.png' Dec 23 21:51:34 volumio volumio[1352]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Joe%20Hisaishi/%E8%8F%8A%E6%AC%A1%E9%83%8E%E3%81%AE%E5%A4%8F/6457158f-3159-4a80-844f-ab8921456f58.jpg' Dec 23 21:51:34 volumio volumio[1352]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%B1%AA%E5%B3%B0/%E4%BF%A1%E4%BB%B0%E5%9C%A8%E7%A9%BA%E4%B8%AD%E9%A3%98%E6%89%AC/ab5a0a6f-f88a-4a1a-8643-3c5055bbcf5a.jpg' Dec 23 21:51:34 volumio volumio[1352]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E5%8A%9B%E5%AE%8F/%E5%BF%83%E8%B7%B3/3eedda0a-507a-43d3-8a61-bb97669885f5.png' Dec 23 21:51:34 volumio volumio[1352]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Innocence%20Mission/Now%20The%20Day%20Is%20Over/e5caa5f5-4355-4869-9cd6-9d4da7ca3eb9.jpg' Dec 23 21:51:34 volumio volumio[1352]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E8%8F%B2/%E9%98%BF%E8%8F%B2%E6%AD%A3%E4%BC%A0/1573e8c9-19ac-4f39-98c4-0415e60fbc86.png' Dec 23 21:51:34 volumio volumio[1352]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%A2%81%E9%9D%99%E8%8C%B9/%E6%81%8B%E7%88%B1%E7%9A%84%E5%8A%9B%E9%87%8F/d8a74aa7-1a0f-4b58-8c9a-e183b7a57b2f.jpg' Dec 23 21:51:58 volumio volumio[1352]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 21:51:58 volumio volumio[1352]: Error: connect ETIMEDOUT 43.226.16.8:443 Dec 23 21:51:58 volumio volumio[1352]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Dec 23 21:51:58 volumio volumio[1352]: errno: -110, Dec 23 21:51:58 volumio volumio[1352]: code: 'ETIMEDOUT', Dec 23 21:51:58 volumio volumio[1352]: syscall: 'connect', Dec 23 21:51:58 volumio volumio[1352]: address: '43.226.16.8', Dec 23 21:51:58 volumio volumio[1352]: port: 443 Dec 23 21:51:58 volumio volumio[1352]: } Dec 23 21:51:58 volumio volumio[1352]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 21:51:59 volumio sudo[3007]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-23 21:50' Dec 23 21:51:59 volumio sudo[3007]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"