-- Logs begin at Mon 2025-02-24 13:51:34 UTC, end at Fri 2025-02-28 14:11:54 UTC. -- Feb 28 14:10:35 volumio volumio[1237]: info: CoreCommandRouter::volumioGetQueue Feb 28 14:10:35 volumio volumio[1237]: info: CoreStateMachine::getQueue Feb 28 14:10:35 volumio volumio[1237]: info: CorePlayQueue::getQueue Feb 28 14:10:38 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 28 14:10:38 volumio volumio[1237]: info: CURURI: playlists Feb 28 14:10:38 volumio volumio[1237]: info: Listing playlists Feb 28 14:10:39 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 28 14:10:39 volumio volumio[1237]: info: CURURI: music-library Feb 28 14:10:40 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 28 14:10:40 volumio volumio[1237]: info: CURURI: artists:// Feb 28 14:10:42 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Academy%20of%20St.%20Martin%20In%20the%20F/8c8adcbc-cb28-4cf5-adc3-5a990d4314a8.jpg' Feb 28 14:10:42 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 28 14:10:42 volumio volumio[1237]: info: CURURI: albums:// Feb 28 14:10:42 volumio volumio[1237]: listAlbums - loading Albums from cache Feb 28 14:10:44 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 28 14:10:44 volumio volumio[1237]: info: CURURI: music-library Feb 28 14:10:45 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mariss%20Jansons/100%20Best%20Film%20Classics/fd9565b7-6119-4616-8861-90a8199a65e2.jpg' Feb 28 14:10:48 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/David%20Abel/100%20Best%20Film%20Classics/109ff167-8f81-4d1d-89e7-02e527c7805b.jpg' Feb 28 14:10:52 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Alex%20Slobodyanik/fefd71ba-acf9-43ac-803d-116e7d7b9c38.jpg' Feb 28 14:10:54 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Andrei%20Gavrilov/b168d4b7-c670-4581-815d-c745e9a2014c.jpg' Feb 28 14:10:57 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Anne%20Queffelec/b1c4d3bb-bc34-47b0-814d-14ca1853e6e6.jpg' Feb 28 14:11:01 volumio volumio[1237]: info: CoreCommandRouter::volumioPause Feb 28 14:11:01 volumio volumio[1237]: info: CoreStateMachine::pause Feb 28 14:11:01 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Feb 28 14:11:01 volumio volumio[1237]: info: CoreStateMachine::servicePause Feb 28 14:11:01 volumio volumio[1237]: info: CorePlayQueue::getTrack 218 Feb 28 14:11:01 volumio volumio[1237]: info: CoreCommandRouter::servicePause Feb 28 14:11:01 volumio volumio[1237]: info: ControllerMpd::pause Feb 28 14:11:01 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand pause Feb 28 14:11:01 volumio volumio[1237]: info: sending command... Feb 28 14:11:01 volumio volumio[1237]: info: parsing response... Feb 28 14:11:01 volumio volumio[1237]: info: Feb 28 14:11:01 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:01 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:01 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:01 volumio volumio[1237]: info: sending command... Feb 28 14:11:01 volumio volumio[1237]: info: parsing response... Feb 28 14:11:01 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:01 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:01 volumio volumio[1237]: info: sending command... Feb 28 14:11:01 volumio volumio[1237]: info: parsing response... Feb 28 14:11:01 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:01 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:01 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:01 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:01 volumio volumio[1237]: info: CorePlayQueue::getTrack 218 Feb 28 14:11:01 volumio volumio[1237]: info: STATE SERVICE {"status":"pause","position":0,"seek":73120,"duration":265,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4616 Kbps","isStreaming":false,"title":"今すぐ会いに来て","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/008-今すぐ会いに来て.flac","trackType":"flac"} Feb 28 14:11:01 volumio volumio[1237]: info: CURRENT POSITION 218 Feb 28 14:11:01 volumio volumio[1237]: info: CoreStateMachine::syncState stateService pause Feb 28 14:11:01 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus pause Feb 28 14:11:01 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:01 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:01 volumio volumio[1237]: info: CorePlayQueue::getTrack 218 Feb 28 14:11:01 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:01 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:01 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Feb 28 14:11:01 volumio volumio[1237]: info: ------------------------------ 37ms Feb 28 14:11:01 volumio sudo[25110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:01 volumio sudo[25110]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:01 volumio sudo[25110]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:01 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Arthur%20Bliss/cc379a35-f632-4fef-b955-dc798c91a38a.jpg' Feb 28 14:11:02 volumio volumio[1237]: info: CoreCommandRouter::volumioPlay Feb 28 14:11:02 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:02 volumio volumio[1237]: info: CoreStateMachine::play index undefined Feb 28 14:11:02 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:02 volumio volumio[1237]: info: CorePlayQueue::getTrack 218 Feb 28 14:11:02 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Feb 28 14:11:02 volumio volumio[1237]: info: CorePlayQueue::getTrack 218 Feb 28 14:11:02 volumio volumio[1237]: info: ControllerMpd::resume Feb 28 14:11:02 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand play Feb 28 14:11:02 volumio volumio[1237]: info: sending command... Feb 28 14:11:02 volumio volumio[1237]: info: Feb 28 14:11:02 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:02 volumio volumio[1237]: info: parsing response... Feb 28 14:11:02 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:02 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:02 volumio volumio[1237]: info: sending command... Feb 28 14:11:02 volumio volumio[1237]: info: parsing response... Feb 28 14:11:02 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:02 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:02 volumio volumio[1237]: info: sending command... Feb 28 14:11:02 volumio volumio[1237]: info: parsing response... Feb 28 14:11:02 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:02 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:02 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:02 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:02 volumio volumio[1237]: info: CorePlayQueue::getTrack 218 Feb 28 14:11:02 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":73616,"duration":265,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4616 Kbps","isStreaming":false,"title":"今すぐ会いに来て","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/008-今すぐ会いに来て.flac","trackType":"flac"} Feb 28 14:11:02 volumio volumio[1237]: info: CURRENT POSITION 218 Feb 28 14:11:02 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:02 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus pause Feb 28 14:11:02 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:02 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:03 volumio volumio[1237]: info: CorePlayQueue::getTrack 218 Feb 28 14:11:03 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:03 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:03 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:03 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:03 volumio volumio[1237]: info: CorePlayQueue::getTrack 218 Feb 28 14:11:03 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:03 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:03 volumio sudo[25123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:03 volumio sudo[25123]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:03 volumio sudo[25123]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:03 volumio volumio[1237]: info: ------------------------------ 71ms Feb 28 14:11:03 volumio sudo[25129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:03 volumio sudo[25129]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:03 volumio sudo[25129]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:03 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/BEYOND/40bc689e-dfb8-469a-b112-2b5c47256420.jpg' Feb 28 14:11:11 volumio volumio[1237]: info: CoreCommandRouter::volumioPlay Feb 28 14:11:11 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::play index 224 Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::stop Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:11 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::updateTrackBlock Feb 28 14:11:11 volumio volumio[1237]: info: CorePlayQueue::getTrackBlock Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 218 Feb 28 14:11:11 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:11 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::serviceStop Feb 28 14:11:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 218 Feb 28 14:11:11 volumio volumio[1237]: info: CoreCommandRouter::serviceStop Feb 28 14:11:11 volumio volumio[1237]: info: ControllerMpd::stop Feb 28 14:11:11 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:11 volumio volumio[1237]: info: sending command... Feb 28 14:11:11 volumio sudo[25174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:11 volumio sudo[25174]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:11 volumio sudo[25174]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:11 volumio volumio[1237]: info: Feb 28 14:11:11 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:11 volumio volumio[1237]: info: parsing response... Feb 28 14:11:11 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:11 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::play index undefined Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:11 volumio volumio[1237]: info: sending command... Feb 28 14:11:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 224 Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Feb 28 14:11:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 224 Feb 28 14:11:11 volumio volumio[1237]: info: ControllerMpd::clearAddPlayTracks USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/014-星のかがやきよ.flac Feb 28 14:11:11 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:11 volumio volumio[1237]: info: sending command... Feb 28 14:11:11 volumio volumio[1237]: info: parsing response... Feb 28 14:11:11 volumio volumio[1237]: info: parsing response... Feb 28 14:11:11 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:11 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:11 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand clear Feb 28 14:11:11 volumio volumio[1237]: info: sending command... Feb 28 14:11:11 volumio volumio[1237]: info: sending command... Feb 28 14:11:11 volumio volumio[1237]: info: Feb 28 14:11:11 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:11 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:11 volumio volumio[1237]: info: parsing response... Feb 28 14:11:11 volumio volumio[1237]: info: parsing response... Feb 28 14:11:11 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:11 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand add "USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/014-星のかがやきよ.flac" Feb 28 14:11:11 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:11 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 224 Feb 28 14:11:11 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:11 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 224 Feb 28 14:11:11 volumio volumio[1237]: info: 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":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/008-今すぐ会いに来て.flac","trackType":"flac"} Feb 28 14:11:11 volumio volumio[1237]: info: CURRENT POSITION 224 Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::syncState stateService stop Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 224 Feb 28 14:11:11 volumio sudo[25183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:11 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:11 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:11 volumio sudo[25183]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:11 volumio volumio[1237]: info: No code Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:11 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:11 volumio sudo[25183]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 224 Feb 28 14:11:11 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:11 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:11 volumio sudo[25188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:11 volumio sudo[25188]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:11 volumio sudo[25188]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:11 volumio volumio[1237]: info: sending command... Feb 28 14:11:11 volumio volumio[1237]: info: ------------------------------ 119ms Feb 28 14:11:11 volumio volumio[1237]: info: Feb 28 14:11:11 volumio volumio[1237]: info: Feb 28 14:11:11 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:11 volumio sudo[25200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:11 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:11 volumio volumio[1237]: info: ------------------------------ 107ms Feb 28 14:11:11 volumio volumio[1237]: info: parsing response... Feb 28 14:11:11 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand play Feb 28 14:11:11 volumio volumio[1237]: info: sending command... Feb 28 14:11:11 volumio sudo[25200]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:11 volumio sudo[25200]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:11 volumio volumio[1237]: info: ------------------------------ 26ms Feb 28 14:11:11 volumio volumio[1237]: info: parsing response... Feb 28 14:11:12 volumio volumio[1237]: info: Feb 28 14:11:12 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:12 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:12 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:12 volumio volumio[1237]: info: sending command... Feb 28 14:11:12 volumio volumio[1237]: info: parsing response... Feb 28 14:11:12 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:12 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:12 volumio volumio[1237]: info: sending command... Feb 28 14:11:12 volumio volumio[1237]: info: parsing response... Feb 28 14:11:12 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:12 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:12 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:12 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:12 volumio volumio[1237]: info: CorePlayQueue::getTrack 224 Feb 28 14:11:12 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":448,"duration":227,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"星のかがやきよ","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/014-星のかがやきよ.flac","trackType":"flac"} Feb 28 14:11:12 volumio volumio[1237]: info: CURRENT POSITION 224 Feb 28 14:11:12 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:12 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:12 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:12 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:12 volumio volumio[1237]: info: CorePlayQueue::getTrack 224 Feb 28 14:11:12 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:12 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:12 volumio volumio[1237]: info: ------------------------------ 62ms Feb 28 14:11:12 volumio sudo[25212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:12 volumio sudo[25212]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:12 volumio sudo[25212]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:12 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Beyond/618e92fa-9f81-4e29-baa8-73b3a7adf8e9.jpg' Feb 28 14:11:12 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/CHAGE%20%26%20ASKA/eb9b5eaf-575e-47d3-bf5f-924939f3edee.jpg' Feb 28 14:11:12 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Carl%20Nielsen/08a94e41-b339-4ccd-acc1-46aeccf603d9.jpg' Feb 28 14:11:12 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Carl%20Philipp%20Emanuel%20Bach/810a687d-06a7-475d-b1d1-5fce5ea8022c.jpg' Feb 28 14:11:14 volumio volumio[1237]: info: CoreCommandRouter::volumioPlay Feb 28 14:11:14 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:14 volumio volumio[1237]: info: CoreStateMachine::play index 222 Feb 28 14:11:14 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:14 volumio volumio[1237]: info: CoreStateMachine::stop Feb 28 14:11:14 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:14 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:14 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Feb 28 14:11:14 volumio volumio[1237]: info: CoreStateMachine::updateTrackBlock Feb 28 14:11:14 volumio volumio[1237]: info: CorePlayQueue::getTrackBlock Feb 28 14:11:15 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:15 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 224 Feb 28 14:11:15 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:15 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:15 volumio volumio[1237]: info: CoreStateMachine::serviceStop Feb 28 14:11:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 224 Feb 28 14:11:15 volumio volumio[1237]: info: CoreCommandRouter::serviceStop Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::stop Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:15 volumio volumio[1237]: info: sending command... Feb 28 14:11:15 volumio sudo[25225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:15 volumio volumio[1237]: info: parsing response... Feb 28 14:11:15 volumio volumio[1237]: info: CoreStateMachine::play index undefined Feb 28 14:11:15 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 222 Feb 28 14:11:15 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Feb 28 14:11:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 222 Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::clearAddPlayTracks USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/012-翼を広げて.flac Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:15 volumio volumio[1237]: info: sending command... Feb 28 14:11:15 volumio volumio[1237]: info: Feb 28 14:11:15 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:15 volumio sudo[25225]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:15 volumio volumio[1237]: info: parsing response... Feb 28 14:11:15 volumio volumio[1237]: info: sending command... Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand clear Feb 28 14:11:15 volumio volumio[1237]: info: sending command... Feb 28 14:11:15 volumio sudo[25225]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:15 volumio volumio[1237]: info: Feb 28 14:11:15 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:15 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:15 volumio volumio[1237]: info: parsing response... Feb 28 14:11:15 volumio volumio[1237]: info: parsing response... Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand add "USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/012-翼を広げて.flac" Feb 28 14:11:15 volumio volumio[1237]: info: sending command... Feb 28 14:11:15 volumio volumio[1237]: info: sending command... Feb 28 14:11:15 volumio volumio[1237]: info: Feb 28 14:11:15 volumio volumio[1237]: info: Feb 28 14:11:15 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:15 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:15 volumio volumio[1237]: info: ------------------------------ 9ms Feb 28 14:11:15 volumio volumio[1237]: info: parsing response... Feb 28 14:11:15 volumio volumio[1237]: info: parsing response... Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand play Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::pushError Feb 28 14:11:15 volumio volumio[1237]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined Feb 28 14:11:15 volumio volumio[1237]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:294:72) Feb 28 14:11:15 volumio volumio[1237]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 28 14:11:15 volumio volumio[1237]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Feb 28 14:11:15 volumio volumio[1237]: at process._tickCallback (internal/process/next_tick.js:180:9) Feb 28 14:11:15 volumio volumio[1237]: info: sending command... Feb 28 14:11:15 volumio volumio[1237]: info: ------------------------------ 30ms Feb 28 14:11:15 volumio volumio[1237]: info: ------------------------------ 9ms Feb 28 14:11:15 volumio volumio[1237]: info: parsing response... Feb 28 14:11:15 volumio volumio[1237]: info: Feb 28 14:11:15 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:15 volumio volumio[1237]: info: sending command... Feb 28 14:11:15 volumio volumio[1237]: info: parsing response... Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:15 volumio volumio[1237]: info: sending command... Feb 28 14:11:15 volumio volumio[1237]: info: parsing response... Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:15 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:15 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:15 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 222 Feb 28 14:11:15 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":352,"duration":270,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"翼を広げて","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/012-翼を広げて.flac","trackType":"flac"} Feb 28 14:11:15 volumio volumio[1237]: info: CURRENT POSITION 222 Feb 28 14:11:15 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:15 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:15 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:15 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 222 Feb 28 14:11:15 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:15 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:15 volumio volumio[1237]: info: ------------------------------ 37ms Feb 28 14:11:15 volumio sudo[25236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:15 volumio sudo[25236]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:15 volumio sudo[25236]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:15 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Charles%20Gounod/58b4ed65-d41d-45f0-89e7-92fe6bda4565.jpg' Feb 28 14:11:16 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Christopher%20Parkening/42e9e833-608c-44f1-bb34-d7f5009b62a6.jpg' Feb 28 14:11:16 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/City%20of%20Prague%20Philharmonic%20Or/970c822b-09a4-46f7-9846-3fa80f023eca.jpg' Feb 28 14:11:18 volumio volumio[1237]: info: CoreCommandRouter::volumioPlay Feb 28 14:11:18 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::play index 208 Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::stop Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:18 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::updateTrackBlock Feb 28 14:11:18 volumio volumio[1237]: info: CorePlayQueue::getTrackBlock Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:18 volumio volumio[1237]: info: CorePlayQueue::getTrack 222 Feb 28 14:11:18 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:18 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::serviceStop Feb 28 14:11:18 volumio volumio[1237]: info: CorePlayQueue::getTrack 222 Feb 28 14:11:18 volumio volumio[1237]: info: CoreCommandRouter::serviceStop Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::stop Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:18 volumio volumio[1237]: info: sending command... Feb 28 14:11:18 volumio sudo[25253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:18 volumio sudo[25253]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:18 volumio sudo[25253]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:18 volumio volumio[1237]: info: parsing response... Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::play index undefined Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:18 volumio volumio[1237]: info: CorePlayQueue::getTrack 208 Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Feb 28 14:11:18 volumio volumio[1237]: info: CorePlayQueue::getTrack 208 Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::clearAddPlayTracks USB/6D82-CD6C/music/中森明菜 - オールタイム・ベスト ‐歌姫(カヴァー)‐/CD2/14 - 中森明菜 - 恋の奴隷.m4a Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:18 volumio volumio[1237]: info: sending command... Feb 28 14:11:18 volumio volumio[1237]: info: Feb 28 14:11:18 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:18 volumio volumio[1237]: info: parsing response... Feb 28 14:11:18 volumio volumio[1237]: info: sending command... Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand clear Feb 28 14:11:18 volumio volumio[1237]: info: sending command... Feb 28 14:11:18 volumio volumio[1237]: info: Feb 28 14:11:18 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:18 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:18 volumio volumio[1237]: info: parsing response... Feb 28 14:11:18 volumio volumio[1237]: info: parsing response... Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand add "USB/6D82-CD6C/music/中森明菜 - オールタイム・ベスト ‐歌姫(カヴァー)‐/CD2/14 - 中森明菜 - 恋の奴隷.m4a" Feb 28 14:11:18 volumio volumio[1237]: info: sending command... Feb 28 14:11:18 volumio volumio[1237]: info: sending command... Feb 28 14:11:18 volumio volumio[1237]: info: Feb 28 14:11:18 volumio volumio[1237]: info: Feb 28 14:11:18 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:18 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:18 volumio volumio[1237]: info: ------------------------------ 6ms Feb 28 14:11:18 volumio volumio[1237]: info: parsing response... Feb 28 14:11:18 volumio volumio[1237]: info: parsing response... Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand play Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::pushError Feb 28 14:11:18 volumio volumio[1237]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined Feb 28 14:11:18 volumio volumio[1237]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:294:72) Feb 28 14:11:18 volumio volumio[1237]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 28 14:11:18 volumio volumio[1237]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Feb 28 14:11:18 volumio volumio[1237]: at process._tickCallback (internal/process/next_tick.js:180:9) Feb 28 14:11:18 volumio volumio[1237]: info: sending command... Feb 28 14:11:18 volumio volumio[1237]: info: ------------------------------ 16ms Feb 28 14:11:18 volumio volumio[1237]: info: ------------------------------ 7ms Feb 28 14:11:18 volumio volumio[1237]: info: parsing response... Feb 28 14:11:18 volumio volumio[1237]: info: Feb 28 14:11:18 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:18 volumio volumio[1237]: info: sending command... Feb 28 14:11:18 volumio volumio[1237]: info: Feb 28 14:11:18 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:18 volumio volumio[1237]: info: parsing response... Feb 28 14:11:18 volumio volumio[1237]: info: sending command... Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:18 volumio volumio[1237]: info: sending command... Feb 28 14:11:18 volumio volumio[1237]: info: parsing response... Feb 28 14:11:18 volumio volumio[1237]: info: parsing response... Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:18 volumio volumio[1237]: info: sending command... Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:18 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:18 volumio volumio[1237]: info: CorePlayQueue::getTrack 208 Feb 28 14:11:18 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":142,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"319 Kbps","isStreaming":false,"title":"恋の奴隷","artist":"中森明菜","album":"オールタイム・ベスト -歌姫 (カヴァー)-","uri":"USB/6D82-CD6C/music/中森明菜 - オールタイム・ベスト ‐歌姫(カヴァー)‐/CD2/14 - 中森明菜 - 恋の奴隷.m4a","trackType":"m4a"} Feb 28 14:11:18 volumio volumio[1237]: info: CURRENT POSITION 208 Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:18 volumio volumio[1237]: info: CorePlayQueue::getTrack 208 Feb 28 14:11:18 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:18 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:18 volumio volumio[1237]: info: ------------------------------ 46ms Feb 28 14:11:18 volumio volumio[1237]: info: parsing response... Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:18 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:18 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:18 volumio volumio[1237]: info: CorePlayQueue::getTrack 208 Feb 28 14:11:18 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":142,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"319 Kbps","isStreaming":false,"title":"恋の奴隷","artist":"中森明菜","album":"オールタイム・ベスト -歌姫 (カヴァー)-","uri":"USB/6D82-CD6C/music/中森明菜 - オールタイム・ベスト ‐歌姫(カヴァー)‐/CD2/14 - 中森明菜 - 恋の奴隷.m4a","trackType":"m4a"} Feb 28 14:11:18 volumio volumio[1237]: info: CURRENT POSITION 208 Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Feb 28 14:11:18 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:18 volumio volumio[1237]: info: CorePlayQueue::getTrack 208 Feb 28 14:11:18 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:18 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:18 volumio sudo[25262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:18 volumio sudo[25262]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:18 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:18 volumio volumio[1237]: info: CorePlayQueue::getTrack 208 Feb 28 14:11:18 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:18 volumio sudo[25262]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:18 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:18 volumio sudo[25267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:18 volumio volumio[1237]: info: ------------------------------ 108ms Feb 28 14:11:18 volumio sudo[25267]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:18 volumio sudo[25267]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:18 volumio sudo[25275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:18 volumio sudo[25275]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:18 volumio sudo[25275]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:20 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/DREAMS%20COME%20TRUE/318b7ff8-01ec-41e6-b38f-cb352c88d152.jpg' Feb 28 14:11:20 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/David%20Abel/69f0ea41-3df5-4e1c-95ed-3f738d4ab4e6.jpg' Feb 28 14:11:20 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dmitri%20Alexeev/3459da16-f8a3-4f35-8fb4-f718c467cdb7.jpg' Feb 28 14:11:20 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Edward%20Elgar/fb17423d-7140-4018-a7cd-734ceb807069.jpg' Feb 28 14:11:20 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Emanuel%20Chabrier/5a3d9f66-7826-409b-bb95-8fd901415aff.jpg' Feb 28 14:11:20 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ennio%20Morricone/46a02e63-1ae0-4ff9-8a82-1186be1b6812.jpg' Feb 28 14:11:20 volumio volumio[1237]: info: CoreCommandRouter::volumioPlay Feb 28 14:11:20 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::play index 211 Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::stop Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:20 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::updateTrackBlock Feb 28 14:11:20 volumio volumio[1237]: info: CorePlayQueue::getTrackBlock Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:20 volumio volumio[1237]: info: CorePlayQueue::getTrack 208 Feb 28 14:11:20 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::serviceStop Feb 28 14:11:20 volumio volumio[1237]: info: CorePlayQueue::getTrack 208 Feb 28 14:11:20 volumio volumio[1237]: info: CoreCommandRouter::serviceStop Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::stop Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:20 volumio volumio[1237]: info: sending command... Feb 28 14:11:20 volumio sudo[25293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:20 volumio sudo[25293]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:20 volumio sudo[25293]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:20 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eric%20Coates/b6daaa11-a6a2-4c6d-a8ce-791721611bf5.jpg' Feb 28 14:11:20 volumio volumio[1237]: info: Feb 28 14:11:20 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:20 volumio volumio[1237]: info: parsing response... Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::play index undefined Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:20 volumio volumio[1237]: info: sending command... Feb 28 14:11:20 volumio volumio[1237]: info: CorePlayQueue::getTrack 211 Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Feb 28 14:11:20 volumio volumio[1237]: info: CorePlayQueue::getTrack 211 Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::clearAddPlayTracks USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/001-Don't you see!.flac Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:20 volumio volumio[1237]: info: sending command... Feb 28 14:11:20 volumio volumio[1237]: info: parsing response... Feb 28 14:11:20 volumio volumio[1237]: info: parsing response... Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand clear Feb 28 14:11:20 volumio volumio[1237]: info: sending command... Feb 28 14:11:20 volumio volumio[1237]: info: sending command... Feb 28 14:11:20 volumio volumio[1237]: info: Feb 28 14:11:20 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:20 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:20 volumio volumio[1237]: info: parsing response... Feb 28 14:11:20 volumio volumio[1237]: info: parsing response... Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand add "USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/001-Don't you see!.flac" Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:20 volumio volumio[1237]: info: CorePlayQueue::getTrack 211 Feb 28 14:11:20 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:20 volumio volumio[1237]: info: CorePlayQueue::getTrack 211 Feb 28 14:11:20 volumio volumio[1237]: info: 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":"USB/6D82-CD6C/music/中森明菜 - オールタイム・ベスト ‐歌姫(カヴァー)‐/CD2/14 - 中森明菜 - 恋の奴隷.m4a","trackType":"m4a"} Feb 28 14:11:20 volumio volumio[1237]: info: CURRENT POSITION 211 Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::syncState stateService stop Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:20 volumio volumio[1237]: info: CorePlayQueue::getTrack 211 Feb 28 14:11:20 volumio sudo[25302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:20 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:20 volumio sudo[25302]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:20 volumio sudo[25302]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:20 volumio volumio[1237]: info: No code Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:20 volumio volumio[1237]: info: CorePlayQueue::getTrack 211 Feb 28 14:11:20 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:20 volumio sudo[25310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:20 volumio volumio[1237]: info: sending command... Feb 28 14:11:20 volumio sudo[25310]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:20 volumio volumio[1237]: info: ------------------------------ 137ms Feb 28 14:11:20 volumio volumio[1237]: info: Feb 28 14:11:20 volumio volumio[1237]: info: Feb 28 14:11:20 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:20 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:20 volumio volumio[1237]: info: ------------------------------ 110ms Feb 28 14:11:20 volumio volumio[1237]: info: parsing response... Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand play Feb 28 14:11:20 volumio sudo[25310]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:20 volumio volumio[1237]: info: sending command... Feb 28 14:11:20 volumio sudo[25314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:20 volumio sudo[25314]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:20 volumio volumio[1237]: info: ------------------------------ 27ms Feb 28 14:11:20 volumio volumio[1237]: info: parsing response... Feb 28 14:11:20 volumio sudo[25314]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:20 volumio volumio[1237]: info: Feb 28 14:11:20 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:20 volumio volumio[1237]: info: sending command... Feb 28 14:11:20 volumio volumio[1237]: info: Feb 28 14:11:20 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:20 volumio volumio[1237]: info: parsing response... Feb 28 14:11:20 volumio volumio[1237]: info: sending command... Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:20 volumio volumio[1237]: info: sending command... Feb 28 14:11:20 volumio volumio[1237]: info: parsing response... Feb 28 14:11:20 volumio volumio[1237]: info: parsing response... Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:20 volumio volumio[1237]: info: sending command... Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:20 volumio volumio[1237]: info: CorePlayQueue::getTrack 211 Feb 28 14:11:20 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":410,"duration":299,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"Don't you see!","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/001-Don't you see!.flac","trackType":"flac"} Feb 28 14:11:20 volumio volumio[1237]: info: CURRENT POSITION 211 Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:20 volumio volumio[1237]: info: CorePlayQueue::getTrack 211 Feb 28 14:11:20 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:20 volumio volumio[1237]: info: ------------------------------ 46ms Feb 28 14:11:20 volumio volumio[1237]: info: parsing response... Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:20 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:20 volumio volumio[1237]: info: CorePlayQueue::getTrack 211 Feb 28 14:11:20 volumio sudo[25329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:20 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":410,"duration":299,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"Don't you see!","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/001-Don't you see!.flac","trackType":"flac"} Feb 28 14:11:20 volumio volumio[1237]: info: CURRENT POSITION 211 Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Feb 28 14:11:20 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:20 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:21 volumio volumio[1237]: info: CorePlayQueue::getTrack 211 Feb 28 14:11:21 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:21 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:20 volumio sudo[25329]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:21 volumio sudo[25329]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:21 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:21 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:21 volumio volumio[1237]: info: CorePlayQueue::getTrack 211 Feb 28 14:11:21 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:21 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:21 volumio sudo[25337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:21 volumio sudo[25337]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:21 volumio volumio[1237]: info: ------------------------------ 113ms Feb 28 14:11:21 volumio sudo[25337]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:21 volumio sudo[25342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:21 volumio sudo[25342]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:21 volumio sudo[25342]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:21 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Felix%20Mendelssohn/6653f39c-b829-4eed-b9e3-d446700077ce.jpg' Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::volumioPlay Feb 28 14:11:23 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::play index 213 Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::stop Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:23 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::updateTrackBlock Feb 28 14:11:23 volumio volumio[1237]: info: CorePlayQueue::getTrackBlock Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:23 volumio volumio[1237]: info: CorePlayQueue::getTrack 211 Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::serviceStop Feb 28 14:11:23 volumio volumio[1237]: info: CorePlayQueue::getTrack 211 Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::serviceStop Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::stop Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:23 volumio volumio[1237]: info: sending command... Feb 28 14:11:23 volumio sudo[25360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:23 volumio volumio[1237]: info: Feb 28 14:11:23 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:23 volumio volumio[1237]: info: parsing response... Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::play index undefined Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:23 volumio volumio[1237]: info: sending command... Feb 28 14:11:23 volumio sudo[25360]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:23 volumio volumio[1237]: info: CorePlayQueue::getTrack 213 Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Feb 28 14:11:23 volumio volumio[1237]: info: CorePlayQueue::getTrack 213 Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::clearAddPlayTracks USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/003-この愛に泳ぎ疲れても.flac Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:23 volumio volumio[1237]: info: sending command... Feb 28 14:11:23 volumio volumio[1237]: info: parsing response... Feb 28 14:11:23 volumio volumio[1237]: info: parsing response... Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:23 volumio sudo[25360]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand clear Feb 28 14:11:23 volumio volumio[1237]: info: sending command... Feb 28 14:11:23 volumio volumio[1237]: info: sending command... Feb 28 14:11:23 volumio volumio[1237]: info: Feb 28 14:11:23 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:23 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:23 volumio volumio[1237]: info: parsing response... Feb 28 14:11:23 volumio volumio[1237]: info: parsing response... Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand add "USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/003-この愛に泳ぎ疲れても.flac" Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:23 volumio volumio[1237]: info: CorePlayQueue::getTrack 213 Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:23 volumio volumio[1237]: info: CorePlayQueue::getTrack 213 Feb 28 14:11:23 volumio volumio[1237]: info: 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":"Don't you see!","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/001-Don't you see!.flac","trackType":"flac"} Feb 28 14:11:23 volumio volumio[1237]: info: CURRENT POSITION 213 Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::syncState stateService stop Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:23 volumio volumio[1237]: info: CorePlayQueue::getTrack 213 Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:23 volumio sudo[25369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:23 volumio sudo[25369]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:23 volumio volumio[1237]: info: No code Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:23 volumio volumio[1237]: info: CorePlayQueue::getTrack 213 Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:23 volumio sudo[25369]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:23 volumio sudo[25374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:23 volumio sudo[25374]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:23 volumio volumio[1237]: info: sending command... Feb 28 14:11:23 volumio sudo[25374]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:23 volumio volumio[1237]: info: ------------------------------ 109ms Feb 28 14:11:23 volumio volumio[1237]: info: Feb 28 14:11:23 volumio volumio[1237]: info: Feb 28 14:11:23 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:23 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:23 volumio volumio[1237]: info: ------------------------------ 94ms Feb 28 14:11:23 volumio volumio[1237]: info: parsing response... Feb 28 14:11:23 volumio sudo[25382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand play Feb 28 14:11:23 volumio volumio[1237]: info: sending command... Feb 28 14:11:23 volumio sudo[25382]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:23 volumio sudo[25382]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:23 volumio volumio[1237]: info: ------------------------------ 31ms Feb 28 14:11:23 volumio volumio[1237]: info: parsing response... Feb 28 14:11:23 volumio volumio[1237]: info: Feb 28 14:11:23 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:23 volumio volumio[1237]: info: sending command... Feb 28 14:11:23 volumio volumio[1237]: info: parsing response... Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:23 volumio volumio[1237]: info: sending command... Feb 28 14:11:23 volumio volumio[1237]: info: Feb 28 14:11:23 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:23 volumio volumio[1237]: info: parsing response... Feb 28 14:11:23 volumio volumio[1237]: info: sending command... Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:23 volumio volumio[1237]: info: CorePlayQueue::getTrack 213 Feb 28 14:11:23 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"0 Kbps","isStreaming":false,"title":"この愛に泳ぎ疲れても","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/003-この愛に泳ぎ疲れても.flac","trackType":"flac"} Feb 28 14:11:23 volumio volumio[1237]: info: CURRENT POSITION 213 Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:23 volumio volumio[1237]: info: CorePlayQueue::getTrack 213 Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:23 volumio sudo[25398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:23 volumio volumio[1237]: info: ------------------------------ 54ms Feb 28 14:11:23 volumio volumio[1237]: info: parsing response... Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:23 volumio volumio[1237]: info: sending command... Feb 28 14:11:23 volumio sudo[25398]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:23 volumio sudo[25398]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:23 volumio volumio[1237]: info: parsing response... Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:23 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:23 volumio volumio[1237]: info: CorePlayQueue::getTrack 213 Feb 28 14:11:23 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":448,"duration":256,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"この愛に泳ぎ疲れても","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/003-この愛に泳ぎ疲れても.flac","trackType":"flac"} Feb 28 14:11:23 volumio volumio[1237]: info: CURRENT POSITION 213 Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Feb 28 14:11:23 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:23 volumio volumio[1237]: info: CorePlayQueue::getTrack 213 Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:23 volumio volumio[1237]: info: CorePlayQueue::getTrack 213 Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:23 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:23 volumio sudo[25407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:23 volumio sudo[25407]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:23 volumio volumio[1237]: info: ------------------------------ 130ms Feb 28 14:11:23 volumio sudo[25407]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:23 volumio sudo[25410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:23 volumio sudo[25410]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:23 volumio sudo[25410]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:23 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/George%20Frideric%20Handel/98327660-c6b3-4c41-a47b-bf2d687dbcd0.jpg' Feb 28 14:11:23 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Georges%20Bizet/5b44862b-df78-4762-9c61-209164b13f78.jpg' Feb 28 14:11:24 volumio volumio[1237]: info: CoreCommandRouter::volumioPlay Feb 28 14:11:24 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::play index 214 Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::stop Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:24 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::updateTrackBlock Feb 28 14:11:24 volumio volumio[1237]: info: CorePlayQueue::getTrackBlock Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:24 volumio volumio[1237]: info: CorePlayQueue::getTrack 213 Feb 28 14:11:24 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:24 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::serviceStop Feb 28 14:11:24 volumio volumio[1237]: info: CorePlayQueue::getTrack 213 Feb 28 14:11:24 volumio volumio[1237]: info: CoreCommandRouter::serviceStop Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::stop Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:24 volumio volumio[1237]: info: sending command... Feb 28 14:11:24 volumio sudo[25427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:24 volumio sudo[25427]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:24 volumio sudo[25427]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:24 volumio volumio[1237]: info: parsing response... Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::play index undefined Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:24 volumio volumio[1237]: info: CorePlayQueue::getTrack 214 Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Feb 28 14:11:24 volumio volumio[1237]: info: CorePlayQueue::getTrack 214 Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::clearAddPlayTracks USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/004-Good-bye My Loneliness.flac Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:24 volumio volumio[1237]: info: sending command... Feb 28 14:11:24 volumio volumio[1237]: info: Feb 28 14:11:24 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:24 volumio volumio[1237]: info: parsing response... Feb 28 14:11:24 volumio volumio[1237]: info: sending command... Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand clear Feb 28 14:11:24 volumio volumio[1237]: info: sending command... Feb 28 14:11:24 volumio volumio[1237]: info: Feb 28 14:11:24 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:24 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:24 volumio volumio[1237]: info: parsing response... Feb 28 14:11:24 volumio volumio[1237]: info: parsing response... Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand add "USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/004-Good-bye My Loneliness.flac" Feb 28 14:11:24 volumio volumio[1237]: info: sending command... Feb 28 14:11:24 volumio volumio[1237]: info: sending command... Feb 28 14:11:24 volumio volumio[1237]: info: Feb 28 14:11:24 volumio volumio[1237]: info: Feb 28 14:11:24 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:24 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:24 volumio volumio[1237]: info: ------------------------------ 6ms Feb 28 14:11:24 volumio volumio[1237]: info: parsing response... Feb 28 14:11:24 volumio volumio[1237]: info: parsing response... Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand play Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::pushError Feb 28 14:11:24 volumio volumio[1237]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined Feb 28 14:11:24 volumio volumio[1237]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:294:72) Feb 28 14:11:24 volumio volumio[1237]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 28 14:11:24 volumio volumio[1237]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Feb 28 14:11:24 volumio volumio[1237]: at process._tickCallback (internal/process/next_tick.js:180:9) Feb 28 14:11:24 volumio volumio[1237]: info: sending command... Feb 28 14:11:24 volumio volumio[1237]: info: ------------------------------ 17ms Feb 28 14:11:24 volumio volumio[1237]: info: ------------------------------ 7ms Feb 28 14:11:24 volumio volumio[1237]: info: parsing response... Feb 28 14:11:24 volumio volumio[1237]: info: Feb 28 14:11:24 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:24 volumio volumio[1237]: info: sending command... Feb 28 14:11:24 volumio volumio[1237]: info: parsing response... Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:24 volumio volumio[1237]: info: sending command... Feb 28 14:11:24 volumio volumio[1237]: info: parsing response... Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:24 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:24 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:24 volumio volumio[1237]: info: CorePlayQueue::getTrack 214 Feb 28 14:11:24 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":410,"duration":274,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"Good-bye My Loneliness","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/004-Good-bye My Loneliness.flac","trackType":"flac"} Feb 28 14:11:24 volumio volumio[1237]: info: CURRENT POSITION 214 Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:24 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:24 volumio volumio[1237]: info: CorePlayQueue::getTrack 214 Feb 28 14:11:24 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:24 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:24 volumio volumio[1237]: info: ------------------------------ 35ms Feb 28 14:11:24 volumio sudo[25436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:24 volumio sudo[25436]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:24 volumio sudo[25436]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:25 volumio volumio[1237]: info: CoreCommandRouter::volumioPlay Feb 28 14:11:25 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:25 volumio volumio[1237]: info: CoreStateMachine::play index 215 Feb 28 14:11:25 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:25 volumio volumio[1237]: info: CoreStateMachine::stop Feb 28 14:11:25 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:25 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:25 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Feb 28 14:11:25 volumio volumio[1237]: info: CoreStateMachine::updateTrackBlock Feb 28 14:11:25 volumio volumio[1237]: info: CorePlayQueue::getTrackBlock Feb 28 14:11:25 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:25 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:25 volumio volumio[1237]: info: CorePlayQueue::getTrack 214 Feb 28 14:11:25 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:25 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:25 volumio volumio[1237]: info: CoreStateMachine::serviceStop Feb 28 14:11:25 volumio volumio[1237]: info: CorePlayQueue::getTrack 214 Feb 28 14:11:25 volumio volumio[1237]: info: CoreCommandRouter::serviceStop Feb 28 14:11:25 volumio volumio[1237]: info: ControllerMpd::stop Feb 28 14:11:25 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:25 volumio sudo[25447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:25 volumio volumio[1237]: info: sending command... Feb 28 14:11:25 volumio sudo[25447]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:25 volumio sudo[25447]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:25 volumio volumio[1237]: info: parsing response... Feb 28 14:11:25 volumio volumio[1237]: info: CoreStateMachine::play index undefined Feb 28 14:11:25 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:25 volumio volumio[1237]: info: CorePlayQueue::getTrack 215 Feb 28 14:11:25 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Feb 28 14:11:25 volumio volumio[1237]: info: CorePlayQueue::getTrack 215 Feb 28 14:11:25 volumio volumio[1237]: info: ControllerMpd::clearAddPlayTracks USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/005-WAKE UP MAKE THE MORNING LAST ~忘れがたき人へ~.flac Feb 28 14:11:25 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:25 volumio volumio[1237]: info: sending command... Feb 28 14:11:25 volumio volumio[1237]: info: Feb 28 14:11:25 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:25 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:25 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:25 volumio volumio[1237]: info: parsing response... Feb 28 14:11:25 volumio volumio[1237]: info: sending command... Feb 28 14:11:25 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand clear Feb 28 14:11:25 volumio volumio[1237]: info: sending command... Feb 28 14:11:25 volumio volumio[1237]: info: Feb 28 14:11:25 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:25 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:25 volumio volumio[1237]: info: parsing response... Feb 28 14:11:25 volumio volumio[1237]: info: parsing response... Feb 28 14:11:25 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:25 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:25 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand add "USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/005-WAKE UP MAKE THE MORNING LAST ~忘れがたき人へ~.flac" Feb 28 14:11:25 volumio volumio[1237]: info: sending command... Feb 28 14:11:25 volumio volumio[1237]: info: sending command... Feb 28 14:11:25 volumio volumio[1237]: info: Feb 28 14:11:25 volumio volumio[1237]: info: Feb 28 14:11:25 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:25 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:25 volumio volumio[1237]: info: ------------------------------ 6ms Feb 28 14:11:25 volumio volumio[1237]: info: parsing response... Feb 28 14:11:25 volumio volumio[1237]: info: parsing response... Feb 28 14:11:25 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:25 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand play Feb 28 14:11:25 volumio volumio[1237]: info: ControllerMpd::pushError Feb 28 14:11:25 volumio volumio[1237]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined Feb 28 14:11:25 volumio volumio[1237]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:294:72) Feb 28 14:11:25 volumio volumio[1237]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 28 14:11:25 volumio volumio[1237]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Feb 28 14:11:25 volumio volumio[1237]: at process._tickCallback (internal/process/next_tick.js:180:9) Feb 28 14:11:25 volumio volumio[1237]: info: sending command... Feb 28 14:11:25 volumio volumio[1237]: info: ------------------------------ 17ms Feb 28 14:11:25 volumio volumio[1237]: info: ------------------------------ 8ms Feb 28 14:11:25 volumio volumio[1237]: info: parsing response... Feb 28 14:11:26 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Giacomo%20Meyerbeer/d63428d5-5ebb-43a4-9d37-2d638e6c2846.jpg' Feb 28 14:11:26 volumio volumio[1237]: info: Feb 28 14:11:26 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:26 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:26 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:26 volumio volumio[1237]: info: sending command... Feb 28 14:11:26 volumio volumio[1237]: info: parsing response... Feb 28 14:11:26 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:26 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:26 volumio volumio[1237]: info: sending command... Feb 28 14:11:26 volumio volumio[1237]: info: parsing response... Feb 28 14:11:26 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:26 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:26 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:26 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:26 volumio volumio[1237]: info: CorePlayQueue::getTrack 215 Feb 28 14:11:26 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":341,"duration":236,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"WAKE UP MAKE THE MORNING LAST ~忘れがたき人へ~","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/005-WAKE UP MAKE THE MORNING LAST ~忘れがたき人へ~.flac","trackType":"flac"} Feb 28 14:11:26 volumio volumio[1237]: info: CURRENT POSITION 215 Feb 28 14:11:26 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:26 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:26 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:26 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:26 volumio volumio[1237]: info: CorePlayQueue::getTrack 215 Feb 28 14:11:26 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:26 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:26 volumio volumio[1237]: info: ------------------------------ 52ms Feb 28 14:11:26 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Giuseppe%20Verdi/4dbe7ba0-899d-4caa-86c7-d49b3317d66b.jpg' Feb 28 14:11:26 volumio sudo[25456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:26 volumio sudo[25456]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:26 volumio sudo[25456]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:26 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Globe/c82600ad-5869-427e-a310-011469be554e.jpg' Feb 28 14:11:27 volumio volumio[1237]: info: CoreCommandRouter::volumioPlay Feb 28 14:11:27 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::play index 216 Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::stop Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:27 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::updateTrackBlock Feb 28 14:11:27 volumio volumio[1237]: info: CorePlayQueue::getTrackBlock Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:27 volumio volumio[1237]: info: CorePlayQueue::getTrack 215 Feb 28 14:11:27 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:27 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::serviceStop Feb 28 14:11:27 volumio volumio[1237]: info: CorePlayQueue::getTrack 215 Feb 28 14:11:27 volumio volumio[1237]: info: CoreCommandRouter::serviceStop Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::stop Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:27 volumio volumio[1237]: info: sending command... Feb 28 14:11:27 volumio sudo[25469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:27 volumio sudo[25469]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:27 volumio sudo[25469]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:27 volumio volumio[1237]: info: parsing response... Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::play index undefined Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:27 volumio volumio[1237]: info: CorePlayQueue::getTrack 216 Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Feb 28 14:11:27 volumio volumio[1237]: info: CorePlayQueue::getTrack 216 Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::clearAddPlayTracks USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/006-君に逢いたくなったら・・・.flac Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:27 volumio volumio[1237]: info: sending command... Feb 28 14:11:27 volumio volumio[1237]: info: Feb 28 14:11:27 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:27 volumio volumio[1237]: info: parsing response... Feb 28 14:11:27 volumio volumio[1237]: info: sending command... Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand clear Feb 28 14:11:27 volumio volumio[1237]: info: sending command... Feb 28 14:11:27 volumio volumio[1237]: info: Feb 28 14:11:27 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:27 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:27 volumio volumio[1237]: info: parsing response... Feb 28 14:11:27 volumio volumio[1237]: info: parsing response... Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand add "USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/006-君に逢いたくなったら・・・.flac" Feb 28 14:11:27 volumio volumio[1237]: info: sending command... Feb 28 14:11:27 volumio volumio[1237]: info: sending command... Feb 28 14:11:27 volumio volumio[1237]: info: Feb 28 14:11:27 volumio volumio[1237]: info: Feb 28 14:11:27 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:27 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:27 volumio volumio[1237]: info: ------------------------------ 18ms Feb 28 14:11:27 volumio volumio[1237]: info: parsing response... Feb 28 14:11:27 volumio volumio[1237]: info: parsing response... Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand play Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::pushError Feb 28 14:11:27 volumio volumio[1237]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined Feb 28 14:11:27 volumio volumio[1237]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:294:72) Feb 28 14:11:27 volumio volumio[1237]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 28 14:11:27 volumio volumio[1237]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Feb 28 14:11:27 volumio volumio[1237]: at process._tickCallback (internal/process/next_tick.js:180:9) Feb 28 14:11:27 volumio volumio[1237]: info: sending command... Feb 28 14:11:27 volumio volumio[1237]: info: ------------------------------ 31ms Feb 28 14:11:27 volumio volumio[1237]: info: ------------------------------ 7ms Feb 28 14:11:27 volumio volumio[1237]: info: parsing response... Feb 28 14:11:27 volumio volumio[1237]: info: Feb 28 14:11:27 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:27 volumio volumio[1237]: info: sending command... Feb 28 14:11:27 volumio volumio[1237]: info: Feb 28 14:11:27 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:27 volumio volumio[1237]: info: parsing response... Feb 28 14:11:27 volumio volumio[1237]: info: sending command... Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:27 volumio volumio[1237]: info: sending command... Feb 28 14:11:27 volumio volumio[1237]: info: parsing response... Feb 28 14:11:27 volumio volumio[1237]: info: parsing response... Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:27 volumio volumio[1237]: info: sending command... Feb 28 14:11:27 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:27 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:27 volumio volumio[1237]: info: CorePlayQueue::getTrack 216 Feb 28 14:11:27 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":352,"duration":226,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"君に逢いたくなったら・・・","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/006-君に逢いたくなったら・・・.flac","trackType":"flac"} Feb 28 14:11:27 volumio volumio[1237]: info: CURRENT POSITION 216 Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:27 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:27 volumio volumio[1237]: info: CorePlayQueue::getTrack 216 Feb 28 14:11:27 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:27 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:41 volumio systemd-journal[183]: Suppressed 442 messages from /system.slice/volumio.service Feb 28 14:11:41 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/MC%20HotDog/fe1df9f2-b0ad-4fe8-ba46-87cbcbc16a97.jpg' Feb 28 14:11:41 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Maria%20Tipo/ae555e1b-147b-4a1f-b8fb-aa75bab9bea9.jpg' Feb 28 14:11:41 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mariss%20Jansons/f48246a1-647d-4b04-a796-42b69644a75a.jpg' Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::volumioPlay Feb 28 14:11:46 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::play index 241 Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::stop Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:46 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::updateTrackBlock Feb 28 14:11:46 volumio volumio[1237]: info: CorePlayQueue::getTrackBlock Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:46 volumio volumio[1237]: info: CorePlayQueue::getTrack 224 Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::serviceStop Feb 28 14:11:46 volumio volumio[1237]: info: CorePlayQueue::getTrack 224 Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::serviceStop Feb 28 14:11:46 volumio sudo[25660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::stop Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:46 volumio volumio[1237]: info: sending command... Feb 28 14:11:46 volumio sudo[25660]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:46 volumio sudo[25660]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:46 volumio volumio[1237]: info: Feb 28 14:11:46 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:46 volumio volumio[1237]: info: parsing response... Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::play index undefined Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:46 volumio volumio[1237]: info: sending command... Feb 28 14:11:46 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Feb 28 14:11:46 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::clearAddPlayTracks USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/031-突然.flac Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:46 volumio volumio[1237]: info: sending command... Feb 28 14:11:46 volumio volumio[1237]: info: parsing response... Feb 28 14:11:46 volumio volumio[1237]: info: parsing response... Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand clear Feb 28 14:11:46 volumio volumio[1237]: info: sending command... Feb 28 14:11:46 volumio volumio[1237]: info: sending command... Feb 28 14:11:46 volumio volumio[1237]: info: Feb 28 14:11:46 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:46 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:46 volumio volumio[1237]: info: parsing response... Feb 28 14:11:46 volumio volumio[1237]: info: parsing response... Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand add "USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/031-突然.flac" Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:46 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:46 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:46 volumio volumio[1237]: info: 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":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/014-星のかがやきよ.flac","trackType":"flac"} Feb 28 14:11:46 volumio volumio[1237]: info: CURRENT POSITION 241 Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::syncState stateService stop Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:46 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:46 volumio sudo[25669]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:46 volumio sudo[25669]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:46 volumio volumio[1237]: info: No code Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:46 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:46 volumio sudo[25669]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:46 volumio sudo[25675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:46 volumio sudo[25675]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:46 volumio volumio[1237]: info: sending command... Feb 28 14:11:46 volumio volumio[1237]: info: ------------------------------ 103ms Feb 28 14:11:46 volumio volumio[1237]: info: Feb 28 14:11:46 volumio volumio[1237]: info: Feb 28 14:11:46 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:46 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:46 volumio volumio[1237]: info: ------------------------------ 93ms Feb 28 14:11:46 volumio volumio[1237]: info: parsing response... Feb 28 14:11:46 volumio sudo[25675]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand play Feb 28 14:11:46 volumio volumio[1237]: info: sending command... Feb 28 14:11:46 volumio sudo[25683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:46 volumio volumio[1237]: info: ------------------------------ 19ms Feb 28 14:11:46 volumio volumio[1237]: info: parsing response... Feb 28 14:11:46 volumio sudo[25683]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:46 volumio sudo[25683]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:46 volumio volumio[1237]: info: Feb 28 14:11:46 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:46 volumio volumio[1237]: info: sending command... Feb 28 14:11:46 volumio volumio[1237]: info: Feb 28 14:11:46 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:46 volumio volumio[1237]: info: parsing response... Feb 28 14:11:46 volumio volumio[1237]: info: sending command... Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:46 volumio volumio[1237]: info: sending command... Feb 28 14:11:46 volumio volumio[1237]: info: parsing response... Feb 28 14:11:46 volumio volumio[1237]: info: parsing response... Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:46 volumio volumio[1237]: info: sending command... Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:46 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:46 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":378,"duration":273,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"突然","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/031-突然.flac","trackType":"flac"} Feb 28 14:11:46 volumio volumio[1237]: info: CURRENT POSITION 241 Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:46 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:46 volumio volumio[1237]: info: ------------------------------ 50ms Feb 28 14:11:46 volumio volumio[1237]: info: parsing response... Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:46 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:46 volumio sudo[25698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:46 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:46 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":448,"duration":273,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"突然","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/031-突然.flac","trackType":"flac"} Feb 28 14:11:46 volumio volumio[1237]: info: CURRENT POSITION 241 Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Feb 28 14:11:46 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:46 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:46 volumio sudo[25698]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:46 volumio sudo[25698]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:46 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:46 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:46 volumio sudo[25704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:46 volumio sudo[25704]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:46 volumio sudo[25704]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:46 volumio sudo[25711]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:46 volumio volumio[1237]: info: ------------------------------ 129ms Feb 28 14:11:46 volumio sudo[25711]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:46 volumio sudo[25711]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::volumioPlay Feb 28 14:11:48 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::play index 243 Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::stop Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:48 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::updateTrackBlock Feb 28 14:11:48 volumio volumio[1237]: info: CorePlayQueue::getTrackBlock Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::serviceStop Feb 28 14:11:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::serviceStop Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::stop Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:48 volumio volumio[1237]: info: sending command... Feb 28 14:11:48 volumio sudo[25727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:48 volumio sudo[25727]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:48 volumio volumio[1237]: info: Feb 28 14:11:48 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:48 volumio volumio[1237]: info: parsing response... Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:48 volumio sudo[25727]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::play index undefined Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:48 volumio volumio[1237]: info: sending command... Feb 28 14:11:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 243 Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Feb 28 14:11:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 243 Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::clearAddPlayTracks USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/033-Season.flac Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:48 volumio volumio[1237]: info: sending command... Feb 28 14:11:48 volumio volumio[1237]: info: parsing response... Feb 28 14:11:48 volumio volumio[1237]: info: parsing response... Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand clear Feb 28 14:11:48 volumio volumio[1237]: info: sending command... Feb 28 14:11:48 volumio volumio[1237]: info: sending command... Feb 28 14:11:48 volumio volumio[1237]: info: Feb 28 14:11:48 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:48 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:48 volumio volumio[1237]: info: parsing response... Feb 28 14:11:48 volumio volumio[1237]: info: parsing response... Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand add "USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/033-Season.flac" Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 243 Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 243 Feb 28 14:11:48 volumio volumio[1237]: info: 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":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/031-突然.flac","trackType":"flac"} Feb 28 14:11:48 volumio volumio[1237]: info: CURRENT POSITION 243 Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::syncState stateService stop Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 243 Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:48 volumio sudo[25738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:48 volumio sudo[25738]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:48 volumio volumio[1237]: info: No code Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 243 Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:48 volumio sudo[25738]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:48 volumio sudo[25744]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:48 volumio sudo[25744]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:48 volumio volumio[1237]: info: sending command... Feb 28 14:11:48 volumio sudo[25744]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:48 volumio sudo[25751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:48 volumio volumio[1237]: info: ------------------------------ 139ms Feb 28 14:11:48 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Michael%20Nyman/5062f0a6-4a50-4caa-8cde-f49a525f5d9a.jpg' Feb 28 14:11:48 volumio volumio[1237]: info: Feb 28 14:11:48 volumio volumio[1237]: info: Feb 28 14:11:48 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:48 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:48 volumio volumio[1237]: info: ------------------------------ 99ms Feb 28 14:11:48 volumio volumio[1237]: info: parsing response... Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand play Feb 28 14:11:48 volumio sudo[25751]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:48 volumio volumio[1237]: info: sending command... Feb 28 14:11:48 volumio sudo[25751]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:48 volumio volumio[1237]: info: ------------------------------ 18ms Feb 28 14:11:48 volumio volumio[1237]: info: parsing response... Feb 28 14:11:48 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Moura%20Lympany/adc48ce1-816b-447a-80ae-6055661c19f0.jpg' Feb 28 14:11:48 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mr.Children/5130adc4-631f-4f4c-b02b-2339bcbfd9ca.jpg' Feb 28 14:11:48 volumio volumio[1237]: info: Feb 28 14:11:48 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:48 volumio volumio[1237]: info: sending command... Feb 28 14:11:48 volumio volumio[1237]: info: Feb 28 14:11:48 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:48 volumio volumio[1237]: info: parsing response... Feb 28 14:11:48 volumio volumio[1237]: info: sending command... Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:48 volumio volumio[1237]: info: sending command... Feb 28 14:11:48 volumio volumio[1237]: info: parsing response... Feb 28 14:11:48 volumio volumio[1237]: info: parsing response... Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:48 volumio volumio[1237]: info: sending command... Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 243 Feb 28 14:11:48 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":373,"duration":244,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"Season","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/033-Season.flac","trackType":"flac"} Feb 28 14:11:48 volumio volumio[1237]: info: CURRENT POSITION 243 Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 243 Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:48 volumio volumio[1237]: info: ------------------------------ 47ms Feb 28 14:11:48 volumio volumio[1237]: info: parsing response... Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:48 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 243 Feb 28 14:11:48 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":448,"duration":244,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"Season","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/033-Season.flac","trackType":"flac"} Feb 28 14:11:48 volumio volumio[1237]: info: CURRENT POSITION 243 Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Feb 28 14:11:48 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 243 Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:48 volumio sudo[25765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:48 volumio sudo[25765]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 243 Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:48 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:48 volumio sudo[25765]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:48 volumio sudo[25769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:48 volumio volumio[1237]: info: ------------------------------ 109ms Feb 28 14:11:48 volumio sudo[25769]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:48 volumio sudo[25778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:48 volumio sudo[25769]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:48 volumio sudo[25778]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:48 volumio sudo[25778]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:48 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Nakajima%20Miyuki/d5d28b78-4c74-4499-92c9-f5ca6fe73def.jpg' Feb 28 14:11:50 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Nikolai%20Rimsky-Korsakov/7143c722-b500-4c36-9e22-d310f4017f34.jpg' Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::volumioPlay Feb 28 14:11:50 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::play index 241 Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::stop Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:50 volumio volumio[1237]: UNSET VOLATILE Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::updateTrackBlock Feb 28 14:11:50 volumio volumio[1237]: info: CorePlayQueue::getTrackBlock Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:50 volumio volumio[1237]: info: CorePlayQueue::getTrack 243 Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::serviceStop Feb 28 14:11:50 volumio volumio[1237]: info: CorePlayQueue::getTrack 243 Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::serviceStop Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::stop Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:50 volumio volumio[1237]: info: sending command... Feb 28 14:11:50 volumio sudo[25794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:50 volumio sudo[25794]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:50 volumio sudo[25794]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:50 volumio volumio[1237]: info: Feb 28 14:11:50 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:50 volumio volumio[1237]: info: parsing response... Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::play index undefined Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 28 14:11:50 volumio volumio[1237]: info: sending command... Feb 28 14:11:50 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Feb 28 14:11:50 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::clearAddPlayTracks USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/031-突然.flac Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand stop Feb 28 14:11:50 volumio volumio[1237]: info: sending command... Feb 28 14:11:50 volumio volumio[1237]: info: parsing response... Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:50 volumio volumio[1237]: info: sending command... Feb 28 14:11:50 volumio volumio[1237]: info: parsing response... Feb 28 14:11:50 volumio volumio[1237]: info: parsing response... Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand clear Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:50 volumio volumio[1237]: info: sending command... Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:50 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:50 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:50 volumio volumio[1237]: info: 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":"Season","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/033-Season.flac","trackType":"flac"} Feb 28 14:11:50 volumio volumio[1237]: info: CURRENT POSITION 241 Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::syncState stateService stop Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:50 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:50 volumio sudo[25803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:50 volumio sudo[25803]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:50 volumio volumio[1237]: info: No code Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:50 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:50 volumio sudo[25803]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:50 volumio sudo[25808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:50 volumio sudo[25808]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:50 volumio volumio[1237]: info: ------------------------------ 102ms Feb 28 14:11:50 volumio volumio[1237]: info: Feb 28 14:11:50 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:50 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:50 volumio sudo[25816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:50 volumio volumio[1237]: info: parsing response... Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand add "USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/031-突然.flac" Feb 28 14:11:50 volumio volumio[1237]: info: sending command... Feb 28 14:11:50 volumio sudo[25808]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:50 volumio sudo[25816]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:50 volumio sudo[25816]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:50 volumio volumio[1237]: info: Feb 28 14:11:50 volumio volumio[1237]: info: Feb 28 14:11:50 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Feb 28 14:11:50 volumio volumio[1237]: info: Ignoring MPD Status Update Feb 28 14:11:50 volumio volumio[1237]: info: ------------------------------ 35ms Feb 28 14:11:50 volumio volumio[1237]: info: parsing response... Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand play Feb 28 14:11:50 volumio volumio[1237]: info: sending command... Feb 28 14:11:50 volumio volumio[1237]: info: ------------------------------ 6ms Feb 28 14:11:50 volumio volumio[1237]: info: parsing response... Feb 28 14:11:50 volumio volumio[1237]: info: Feb 28 14:11:50 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:50 volumio volumio[1237]: info: sending command... Feb 28 14:11:50 volumio volumio[1237]: info: Feb 28 14:11:50 volumio volumio[1237]: ---------------------------- MPD announces state update: player Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::getState Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand status Feb 28 14:11:50 volumio volumio[1237]: info: parsing response... Feb 28 14:11:50 volumio volumio[1237]: info: sending command... Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:50 volumio volumio[1237]: info: sending command... Feb 28 14:11:50 volumio volumio[1237]: info: parsing response... Feb 28 14:11:50 volumio volumio[1237]: info: parsing response... Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::parseState Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::sendMpdCommand playlistinfo Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:50 volumio volumio[1237]: info: sending command... Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:50 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:50 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":277,"duration":273,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"突然","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/031-突然.flac","trackType":"flac"} Feb 28 14:11:50 volumio volumio[1237]: info: CURRENT POSITION 241 Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:50 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:50 volumio volumio[1237]: info: ------------------------------ 50ms Feb 28 14:11:50 volumio volumio[1237]: info: parsing response... Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::parseTrackInfo Feb 28 14:11:50 volumio volumio[1237]: info: ControllerMpd::pushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::syncState Feb 28 14:11:50 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:50 volumio volumio[1237]: info: STATE SERVICE {"status":"play","position":0,"seek":277,"duration":273,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"突然","artist":"ZARD","album":"ZARD Forever Best ~25th Anniversary~","uri":"USB/6D82-CD6C/music/ZARD Forever Best ~25th Anniversary~ FLAC 24-96 [20200210]/031-突然.flac","trackType":"flac"} Feb 28 14:11:50 volumio volumio[1237]: info: CURRENT POSITION 241 Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Feb 28 14:11:50 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Feb 28 14:11:50 volumio sudo[25832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:50 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:50 volumio sudo[25832]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:50 volumio sudo[25832]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::pushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreStateMachine::getState Feb 28 14:11:50 volumio volumio[1237]: info: CorePlayQueue::getTrack 241 Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Feb 28 14:11:50 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:11:50 volumio sudo[25839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:50 volumio sudo[25839]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:50 volumio volumio[1237]: info: ------------------------------ 122ms Feb 28 14:11:50 volumio sudo[25839]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:50 volumio sudo[25846]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:11:50 volumio sudo[25846]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:11:50 volumio sudo[25846]: pam_unix(sudo:session): session closed for user root Feb 28 14:11:51 volumio volumio[1237]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Noriyuki%20Asakura/70ec31c3-e764-47f0-ac5f-f5a62059c673.jpg' Feb 28 14:11:53 volumio volumio[1237]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 28 14:11:53 volumio volumio[1237]: { Error: connect ETIMEDOUT 52.175.9.80:80 Feb 28 14:11:53 volumio volumio[1237]: at Object._errnoException (util.js:1022:11) Feb 28 14:11:53 volumio volumio[1237]: at _exceptionWithHostPort (util.js:1044:20) Feb 28 14:11:53 volumio volumio[1237]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Feb 28 14:11:53 volumio volumio[1237]: code: 'ETIMEDOUT', Feb 28 14:11:53 volumio volumio[1237]: errno: 'ETIMEDOUT', Feb 28 14:11:53 volumio volumio[1237]: syscall: 'connect', Feb 28 14:11:53 volumio volumio[1237]: address: '52.175.9.80', Feb 28 14:11:53 volumio volumio[1237]: port: 80 } Feb 28 14:11:53 volumio volumio[1237]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 28 14:11:54 volumio sudo[25870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-28 14:10 Feb 28 14:11:54 volumio sudo[25870]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="ba22215fabbe766d668749499a1c25fcefd90f0a" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="043dcaee624f27d121213b83af11a9f2feac0945" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Mar 18 01:32:43 CET 2020" VOLUMIO_VERSION="2.729" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="5a0b29326faa8f5d0f5fe95d9e58c069"