-- Logs begin at Thu 2019-02-14 18:12:00 CST, end at Sun 2025-07-06 19:27:07 CST. -- Jul 06 19:26:00 volumio volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 06 19:26:00 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 06 19:26:00 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 06 19:26:00 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 06 19:26:00 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jul 06 19:26:00 volumio volumio[912]: info: Received Get System Version Jul 06 19:26:00 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 06 19:26:00 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Jul 06 19:26:23 volumio sudo[6403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 06 19:26:23 volumio sudo[6403]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 19:26:23 volumio sudo[6403]: pam_unix(sudo:session): session closed for user root Jul 06 19:26:23 volumio sudo[6405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 06 19:26:23 volumio sudo[6405]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 19:26:23 volumio sudo[6405]: pam_unix(sudo:session): session closed for user root Jul 06 19:26:23 volumio volumio[912]: verbose: New Socket.io Connection to 192.168.1.252 from 192.168.1.117 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jul 06 19:26:23 volumio volumio[912]: info: CoreCommandRouter::volumioGetVisibleSources Jul 06 19:26:23 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 06 19:26:23 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Jul 06 19:26:23 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:23 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 06 19:26:23 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 06 19:26:23 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 06 19:26:23 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 06 19:26:24 volumio sudo[6409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 06 19:26:24 volumio sudo[6409]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 19:26:24 volumio sudo[6409]: pam_unix(sudo:session): session closed for user root Jul 06 19:26:24 volumio sudo[6411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 06 19:26:24 volumio sudo[6411]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 19:26:24 volumio sudo[6411]: pam_unix(sudo:session): session closed for user root Jul 06 19:26:24 volumio volumio[912]: verbose: New Socket.io Connection to 192.168.1.252 from 192.168.1.117 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jul 06 19:26:24 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Jul 06 19:26:24 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:24 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 06 19:26:24 volumio volumio[912]: info: Listing playlists Jul 06 19:26:24 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 06 19:26:24 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 06 19:26:24 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 06 19:26:24 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 06 19:26:24 volumio volumio[912]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, scandir '/mnt/USB/MUSIC' Jul 06 19:26:24 volumio volumio[912]: at Object.readdirSync (fs.js:1021:3) Jul 06 19:26:24 volumio volumio[912]: at searchInFolder (/volumio/app/plugins/miscellanea/albumart/albumart.js:250:20) Jul 06 19:26:24 volumio volumio[912]: at processRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:386:11) Jul 06 19:26:24 volumio volumio[912]: at processExpressRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:437:17) Jul 06 19:26:24 volumio volumio[912]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 06 19:26:24 volumio volumio[912]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jul 06 19:26:24 volumio volumio[912]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jul 06 19:26:24 volumio volumio[912]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 06 19:26:24 volumio volumio[912]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jul 06 19:26:24 volumio volumio[912]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jul 06 19:26:24 volumio volumio[912]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jul 06 19:26:24 volumio volumio[912]: at allowCrossDomain (/volumio/http/index.js:34:5) Jul 06 19:26:24 volumio volumio[912]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 06 19:26:24 volumio volumio[912]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Jul 06 19:26:24 volumio volumio[912]: at /volumio/node_modules/express/lib/router/index.js:284:7 Jul 06 19:26:24 volumio volumio[912]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jul 06 19:26:25 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 06 19:26:25 volumio volumio[912]: info: Received Get System Info Jul 06 19:26:25 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 06 19:26:25 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 06 19:26:25 volumio volumio[912]: info: Discovery: Getting this device information Jul 06 19:26:25 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Jul 06 19:26:25 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:25 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioSeek Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::seek Jul 06 19:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:28 volumio volumio[912]: info: TRACKBLOCK {"uri":"mnt/USB/MUSIC/08 - 半调子.mp3","service":"mpd","name":"半调子","artist":"徐若瑄","album":"梦幻珍藏","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=725&web=%E5%BE%90%E8%8B%A5%E7%91%84/%E6%A2%A6%E5%B9%BB%E7%8F%8D%E8%97%8F/extralarge&path=%2FUSB%2FMUSIC&metadata=false","duration":311,"trackType":"mp3"} Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::startPlaybackTimer Jul 06 19:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:28 volumio volumio[912]: info: ControllerMpd::seek Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:28 volumio volumio[912]: error: null Jul 06 19:26:28 volumio volumio[912]: info: Jul 06 19:26:28 volumio volumio[912]: ---------------------------- MPD announces state update: player Jul 06 19:26:28 volumio volumio[912]: info: ControllerMpd::getState Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Jul 06 19:26:28 volumio volumio[912]: info: Jul 06 19:26:28 volumio volumio[912]: ---------------------------- MPD announces state update: player Jul 06 19:26:28 volumio volumio[912]: info: ControllerMpd::getState Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Jul 06 19:26:28 volumio volumio[912]: info: Jul 06 19:26:28 volumio volumio[912]: ---------------------------- MPD announces state update: player Jul 06 19:26:28 volumio volumio[912]: info: ControllerMpd::getState Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Jul 06 19:26:28 volumio volumio[912]: info: Jul 06 19:26:28 volumio volumio[912]: ---------------------------- MPD announces state update: player Jul 06 19:26:28 volumio volumio[912]: info: ControllerMpd::getState Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Jul 06 19:26:28 volumio volumio[912]: info: sendMpdCommand status took 19 milliseconds Jul 06 19:26:28 volumio volumio[912]: info: sendMpdCommand status took 17 milliseconds Jul 06 19:26:28 volumio volumio[912]: info: sendMpdCommand status took 15 milliseconds Jul 06 19:26:28 volumio volumio[912]: info: sendMpdCommand status took 14 milliseconds Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::parseState Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::parseState Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::parseState Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::parseState Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 06 19:26:28 volumio volumio[912]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 06 19:26:28 volumio volumio[912]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 06 19:26:28 volumio volumio[912]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 06 19:26:28 volumio volumio[912]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Jul 06 19:26:28 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Jul 06 19:26:28 volumio volumio[912]: info: ControllerMpd::pushState Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::servicePushState Jul 06 19:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:28 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":175000,"duration":311,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"半调子","artist":"徐若瑄","album":"梦幻珍藏","uri":"USB/MUSIC/08 - 半调子.mp3","trackType":"mp3"} Jul 06 19:26:28 volumio volumio[912]: verbose: CURRENT POSITION 579 Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Jul 06 19:26:28 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:28 volumio volumio[912]: info: ControllerMpd::pushState Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::servicePushState Jul 06 19:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:28 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":175000,"duration":311,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"半调子","artist":"徐若瑄","album":"梦幻珍藏","uri":"USB/MUSIC/08 - 半调子.mp3","trackType":"mp3"} Jul 06 19:26:28 volumio volumio[912]: verbose: CURRENT POSITION 579 Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Jul 06 19:26:28 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:28 volumio volumio[912]: info: ControllerMpd::pushState Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::servicePushState Jul 06 19:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:28 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":175000,"duration":311,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"半调子","artist":"徐若瑄","album":"梦幻珍藏","uri":"USB/MUSIC/08 - 半调子.mp3","trackType":"mp3"} Jul 06 19:26:28 volumio volumio[912]: verbose: CURRENT POSITION 579 Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Jul 06 19:26:28 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:28 volumio volumio[912]: info: ControllerMpd::pushState Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::servicePushState Jul 06 19:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:28 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":175000,"duration":311,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"半调子","artist":"徐若瑄","album":"梦幻珍藏","uri":"USB/MUSIC/08 - 半调子.mp3","trackType":"mp3"} Jul 06 19:26:28 volumio volumio[912]: verbose: CURRENT POSITION 579 Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Jul 06 19:26:28 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:28 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:28 volumio volumio[912]: info: ------------------------------ 184ms Jul 06 19:26:28 volumio volumio[912]: info: ------------------------------ 184ms Jul 06 19:26:28 volumio volumio[912]: info: ------------------------------ 182ms Jul 06 19:26:28 volumio volumio[912]: info: ------------------------------ 181ms Jul 06 19:26:29 volumio volumio[912]: info: CoreCommandRouter::volumioSeek Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::seek Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: info: TRACKBLOCK {"uri":"mnt/USB/MUSIC/08 - 半调子.mp3","service":"mpd","name":"半调子","artist":"徐若瑄","album":"梦幻珍藏","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=725&web=%E5%BE%90%E8%8B%A5%E7%91%84/%E6%A2%A6%E5%B9%BB%E7%8F%8D%E8%97%8F/extralarge&path=%2FUSB%2FMUSIC&metadata=false","duration":311,"samplerate":"44.1 kHz","bitdepth":"24 bit","trackType":"mp3","channels":2} Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::startPlaybackTimer Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: info: ControllerMpd::seek Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 19:26:29 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:29 volumio volumio[912]: error: null Jul 06 19:26:29 volumio volumio[912]: info: Jul 06 19:26:29 volumio volumio[912]: ---------------------------- MPD announces state update: player Jul 06 19:26:29 volumio volumio[912]: info: ControllerMpd::getState Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Jul 06 19:26:29 volumio volumio[912]: info: Jul 06 19:26:29 volumio volumio[912]: ---------------------------- MPD announces state update: player Jul 06 19:26:29 volumio volumio[912]: info: ControllerMpd::getState Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Jul 06 19:26:29 volumio volumio[912]: info: Jul 06 19:26:29 volumio volumio[912]: ---------------------------- MPD announces state update: player Jul 06 19:26:29 volumio volumio[912]: info: ControllerMpd::getState Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Jul 06 19:26:29 volumio volumio[912]: info: Jul 06 19:26:29 volumio volumio[912]: ---------------------------- MPD announces state update: player Jul 06 19:26:29 volumio volumio[912]: info: ControllerMpd::getState Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Jul 06 19:26:29 volumio volumio[912]: info: sendMpdCommand status took 9 milliseconds Jul 06 19:26:29 volumio volumio[912]: info: sendMpdCommand status took 8 milliseconds Jul 06 19:26:29 volumio volumio[912]: info: sendMpdCommand status took 6 milliseconds Jul 06 19:26:29 volumio volumio[912]: info: sendMpdCommand status took 4 milliseconds Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::parseState Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::parseState Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::parseState Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::parseState Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 06 19:26:29 volumio volumio[912]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 06 19:26:29 volumio volumio[912]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 06 19:26:29 volumio volumio[912]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 06 19:26:29 volumio volumio[912]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Jul 06 19:26:29 volumio volumio[912]: info: ControllerMpd::pushState Jul 06 19:26:29 volumio volumio[912]: info: CoreCommandRouter::servicePushState Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":309000,"duration":311,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"半调子","artist":"徐若瑄","album":"梦幻珍藏","uri":"USB/MUSIC/08 - 半调子.mp3","trackType":"mp3"} Jul 06 19:26:29 volumio volumio[912]: verbose: CURRENT POSITION 579 Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Jul 06 19:26:29 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:29 volumio volumio[912]: info: ControllerMpd::pushState Jul 06 19:26:29 volumio volumio[912]: info: CoreCommandRouter::servicePushState Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":309000,"duration":311,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"半调子","artist":"徐若瑄","album":"梦幻珍藏","uri":"USB/MUSIC/08 - 半调子.mp3","trackType":"mp3"} Jul 06 19:26:29 volumio volumio[912]: verbose: CURRENT POSITION 579 Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Jul 06 19:26:29 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:29 volumio volumio[912]: info: ControllerMpd::pushState Jul 06 19:26:29 volumio volumio[912]: info: CoreCommandRouter::servicePushState Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":309000,"duration":311,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"半调子","artist":"徐若瑄","album":"梦幻珍藏","uri":"USB/MUSIC/08 - 半调子.mp3","trackType":"mp3"} Jul 06 19:26:29 volumio volumio[912]: verbose: CURRENT POSITION 579 Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Jul 06 19:26:29 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:29 volumio volumio[912]: info: ControllerMpd::pushState Jul 06 19:26:29 volumio volumio[912]: info: CoreCommandRouter::servicePushState Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":309000,"duration":311,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"半调子","artist":"徐若瑄","album":"梦幻珍藏","uri":"USB/MUSIC/08 - 半调子.mp3","trackType":"mp3"} Jul 06 19:26:29 volumio volumio[912]: verbose: CURRENT POSITION 579 Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Jul 06 19:26:29 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:29 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:29 volumio volumio[912]: info: ------------------------------ 158ms Jul 06 19:26:29 volumio volumio[912]: info: ------------------------------ 156ms Jul 06 19:26:29 volumio volumio[912]: info: ------------------------------ 156ms Jul 06 19:26:29 volumio volumio[912]: info: ------------------------------ 154ms Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 579 Jul 06 19:26:29 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:29 volumio volumio[912]: info: Prefetching next song Jul 06 19:26:29 volumio volumio[912]: info: DOING PREFETCH IN MPD Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/10 - 小小.mp3" Jul 06 19:26:29 volumio volumio[912]: info: sendMpdCommand add "USB/MUSIC/10 - 小小.mp3" took 2 milliseconds Jul 06 19:26:29 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 06 19:26:29 volumio volumio[912]: info: Jul 06 19:26:29 volumio volumio[912]: ---------------------------- MPD announces system playlist update Jul 06 19:26:29 volumio volumio[912]: info: Ignoring MPD Status Update Jul 06 19:26:29 volumio volumio[912]: info: sendMpdCommand consume 1 took 24 milliseconds Jul 06 19:26:29 volumio volumio[912]: info: Jul 06 19:26:29 volumio volumio[912]: ---------------------------- MPD announces system playlist update Jul 06 19:26:29 volumio volumio[912]: info: Ignoring MPD Status Update Jul 06 19:26:29 volumio volumio[912]: info: Jul 06 19:26:29 volumio volumio[912]: ---------------------------- MPD announces system playlist update Jul 06 19:26:29 volumio volumio[912]: info: Ignoring MPD Status Update Jul 06 19:26:29 volumio volumio[912]: info: Jul 06 19:26:29 volumio volumio[912]: ---------------------------- MPD announces system playlist update Jul 06 19:26:29 volumio volumio[912]: info: Ignoring MPD Status Update Jul 06 19:26:29 volumio volumio[912]: info: ------------------------------ 14ms Jul 06 19:26:29 volumio volumio[912]: info: ------------------------------ 10ms Jul 06 19:26:29 volumio volumio[912]: info: ------------------------------ 7ms Jul 06 19:26:29 volumio volumio[912]: info: ------------------------------ 5ms Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::startPlaybackTimer Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::volumioSeek Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::seek Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: info: TRACKBLOCK {"uri":"mnt/USB/MUSIC/10 - 小小.mp3","service":"mpd","name":"小小","artist":"戴佩妮","album":"iPenny","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=725&web=%E6%88%B4%E4%BD%A9%E5%A6%AE/iPenny/extralarge&path=%2FUSB%2FMUSIC&metadata=false","duration":225,"trackType":"mp3"} Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::startPlaybackTimer Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: info: ControllerMpd::seek Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:30 volumio volumio[912]: error: null Jul 06 19:26:30 volumio volumio[912]: info: Jul 06 19:26:30 volumio volumio[912]: ---------------------------- MPD announces state update: player Jul 06 19:26:30 volumio volumio[912]: info: ControllerMpd::getState Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Jul 06 19:26:30 volumio volumio[912]: info: Jul 06 19:26:30 volumio volumio[912]: ---------------------------- MPD announces state update: player Jul 06 19:26:30 volumio volumio[912]: info: ControllerMpd::getState Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Jul 06 19:26:30 volumio volumio[912]: info: Jul 06 19:26:30 volumio volumio[912]: ---------------------------- MPD announces state update: player Jul 06 19:26:30 volumio volumio[912]: info: ControllerMpd::getState Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Jul 06 19:26:30 volumio volumio[912]: info: Jul 06 19:26:30 volumio volumio[912]: ---------------------------- MPD announces state update: player Jul 06 19:26:30 volumio volumio[912]: info: ControllerMpd::getState Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Jul 06 19:26:30 volumio volumio[912]: info: sendMpdCommand status took 23 milliseconds Jul 06 19:26:30 volumio volumio[912]: info: sendMpdCommand status took 21 milliseconds Jul 06 19:26:30 volumio volumio[912]: info: sendMpdCommand status took 19 milliseconds Jul 06 19:26:30 volumio volumio[912]: info: sendMpdCommand status took 17 milliseconds Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::parseState Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::parseState Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::parseState Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::parseState Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 06 19:26:30 volumio volumio[912]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 06 19:26:30 volumio volumio[912]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 06 19:26:30 volumio volumio[912]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 06 19:26:30 volumio volumio[912]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Jul 06 19:26:30 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Jul 06 19:26:30 volumio volumio[912]: info: ControllerMpd::pushState Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::servicePushState Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":111000,"duration":311,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"半调子","artist":"徐若瑄","album":"梦幻珍藏","uri":"USB/MUSIC/08 - 半调子.mp3","trackType":"mp3"} Jul 06 19:26:30 volumio volumio[912]: verbose: CURRENT POSITION 143 Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Jul 06 19:26:30 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:30 volumio volumio[912]: info: ControllerMpd::pushState Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::servicePushState Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":111000,"duration":311,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"半调子","artist":"徐若瑄","album":"梦幻珍藏","uri":"USB/MUSIC/08 - 半调子.mp3","trackType":"mp3"} Jul 06 19:26:30 volumio volumio[912]: verbose: CURRENT POSITION 143 Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Jul 06 19:26:30 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:30 volumio volumio[912]: info: ControllerMpd::pushState Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::servicePushState Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":111000,"duration":311,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"半调子","artist":"徐若瑄","album":"梦幻珍藏","uri":"USB/MUSIC/08 - 半调子.mp3","trackType":"mp3"} Jul 06 19:26:30 volumio volumio[912]: verbose: CURRENT POSITION 143 Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Jul 06 19:26:30 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:30 volumio volumio[912]: info: ControllerMpd::pushState Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::servicePushState Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":111000,"duration":311,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"半调子","artist":"徐若瑄","album":"梦幻珍藏","uri":"USB/MUSIC/08 - 半调子.mp3","trackType":"mp3"} Jul 06 19:26:30 volumio volumio[912]: verbose: CURRENT POSITION 143 Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Jul 06 19:26:30 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:30 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:30 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:30 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:31 volumio volumio[912]: info: ------------------------------ 197ms Jul 06 19:26:31 volumio volumio[912]: info: ------------------------------ 195ms Jul 06 19:26:31 volumio volumio[912]: info: ------------------------------ 194ms Jul 06 19:26:31 volumio volumio[912]: info: ------------------------------ 192ms Jul 06 19:26:31 volumio volumio[912]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, scandir '/mnt/USB/MUSIC' Jul 06 19:26:31 volumio volumio[912]: at Object.readdirSync (fs.js:1021:3) Jul 06 19:26:31 volumio volumio[912]: at searchInFolder (/volumio/app/plugins/miscellanea/albumart/albumart.js:250:20) Jul 06 19:26:31 volumio volumio[912]: at processRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:386:11) Jul 06 19:26:31 volumio volumio[912]: at processExpressRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:437:17) Jul 06 19:26:31 volumio volumio[912]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 06 19:26:31 volumio volumio[912]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jul 06 19:26:31 volumio volumio[912]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jul 06 19:26:31 volumio volumio[912]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 06 19:26:31 volumio volumio[912]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jul 06 19:26:31 volumio volumio[912]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jul 06 19:26:31 volumio volumio[912]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jul 06 19:26:31 volumio volumio[912]: at allowCrossDomain (/volumio/http/index.js:34:5) Jul 06 19:26:31 volumio volumio[912]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 06 19:26:31 volumio volumio[912]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Jul 06 19:26:31 volumio volumio[912]: at /volumio/node_modules/express/lib/router/index.js:284:7 Jul 06 19:26:31 volumio volumio[912]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jul 06 19:26:31 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:31 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:31 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 19:26:31 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:38 volumio volumio[912]: info: VolumeController::SetAlsaVolume31 Jul 06 19:26:38 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:38 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:38 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 19:26:38 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:39 volumio volumio[912]: info: VolumeController::SetAlsaVolume61 Jul 06 19:26:39 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:39 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:39 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 19:26:39 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:43 volumio volumio[912]: info: VolumeController::SetAlsaVolume89 Jul 06 19:26:43 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:43 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:43 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 19:26:43 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:43 volumio volumio[912]: info: VolumeController::SetAlsaVolume96 Jul 06 19:26:43 volumio volumio[912]: info: CoreStateMachine::pushState Jul 06 19:26:43 volumio volumio[912]: info: CorePlayQueue::getTrack 143 Jul 06 19:26:43 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 19:26:43 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 06 19:26:55 volumio volumio[912]: info: Retrieving Cloud Streaming UI Jul 06 19:26:55 volumio volumio[912]: info: Getting Tidal Cloud Configuration Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 06 19:26:55 volumio volumio[912]: info: Getting Qobuz Cloud Configuration Jul 06 19:26:55 volumio volumio[912]: info: Asking plugin for UI Config Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 06 19:26:55 volumio volumio[912]: info: Getting Spotify Cloud Configuration Jul 06 19:26:55 volumio volumio[912]: info: Asking plugin for UI Config Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 06 19:26:55 volumio volumio[912]: info: Saving Spotify Acccount Jul 06 19:26:55 volumio volumio[912]: info: Got Tidal Cloud Configuration Jul 06 19:26:55 volumio volumio[912]: info: Got it Jul 06 19:26:55 volumio volumio[912]: info: Got it Jul 06 19:26:55 volumio volumio[912]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 06 19:26:55 volumio volumio[912]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::volumioGetBrowseSources Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::volumioGetBrowseSources Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::volumioGetBrowseSources Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 19:26:55 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 06 19:26:59 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 19:26:59 volumio volumio[912]: info: Disabling MyMusic plugin upnp_browser Jul 06 19:26:59 volumio volumio[912]: info: CoreCommandRouter::volumioRemoveToBrowseSources媒体服务器 Jul 06 19:26:59 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 06 19:26:59 volumio volumio[912]: info: Disabling plugin upnp_browser Jul 06 19:26:59 volumio volumio[912]: info: Done. Jul 06 19:27:01 volumio volumio[912]: info: Enabling MyMusic plugin upnp_browser Jul 06 19:27:01 volumio volumio[912]: info: Enabling plugin upnp_browser Jul 06 19:27:01 volumio volumio[912]: info: Loading plugin "upnp_browser"... Jul 06 19:27:01 volumio volumio[912]: info: PLUGIN START: upnp_browser Jul 06 19:27:01 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 06 19:27:01 volumio volumio[912]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 06 19:27:01 volumio volumio[912]: info: [1751801221058] CoreMusicLibrary::Adding element 媒体服务器 Jul 06 19:27:01 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 06 19:27:01 volumio volumio[912]: info: Done. Jul 06 19:27:02 volumio volumio[912]: info: Disabling MyMusic plugin airplay_emulation Jul 06 19:27:02 volumio volumio[912]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Jul 06 19:27:02 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 06 19:27:02 volumio volumio[912]: info: Disabling plugin airplay_emulation Jul 06 19:27:02 volumio volumio[912]: info: Done. Jul 06 19:27:02 volumio sudo[6484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Jul 06 19:27:02 volumio sudo[6484]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 19:27:02 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 06 19:27:02 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 06 19:27:02 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 06 19:27:02 volumio sudo[6484]: pam_unix(sudo:session): session closed for user root Jul 06 19:27:02 volumio volumio[912]: info: Shairport-Sync Stopped Jul 06 19:27:03 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 06 19:27:03 volumio volumio[912]: info: Enabling MyMusic plugin airplay_emulation Jul 06 19:27:03 volumio volumio[912]: info: Enabling plugin airplay_emulation Jul 06 19:27:03 volumio volumio[912]: info: Loading plugin "airplay_emulation"... Jul 06 19:27:03 volumio volumio[912]: info: Starting Shairport Sync Jul 06 19:27:03 volumio volumio[912]: info: PLUGIN START: airplay_emulation Jul 06 19:27:03 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 19:27:03 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 19:27:03 volumio volumio[912]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 06 19:27:03 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 19:27:03 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 19:27:03 volumio volumio[912]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 06 19:27:03 volumio volumio[912]: info: Done. Jul 06 19:27:03 volumio volumio[912]: info: Starting Shairport Sync Jul 06 19:27:03 volumio volumio[912]: info: Starting Shairport Sync Jul 06 19:27:03 volumio sudo[6493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 06 19:27:03 volumio sudo[6493]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 19:27:03 volumio sudo[6495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 06 19:27:03 volumio sudo[6495]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 19:27:03 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 06 19:27:03 volumio sudo[6493]: pam_unix(sudo:session): session closed for user root Jul 06 19:27:03 volumio volumio[912]: info: Shairport-Sync Started Jul 06 19:27:03 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 06 19:27:03 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jul 06 19:27:03 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 06 19:27:03 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 06 19:27:03 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 06 19:27:03 volumio sudo[6495]: pam_unix(sudo:session): session closed for user root Jul 06 19:27:03 volumio volumio[912]: info: Shairport-Sync Started Jul 06 19:27:05 volumio volumio[912]: info: Disabling MyMusic plugin upnp Jul 06 19:27:05 volumio sudo[6503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jul 06 19:27:05 volumio sudo[6503]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 19:27:05 volumio volumio[912]: error: Upnp client error: Error: This socket has been ended by the other party Jul 06 19:27:05 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Jul 06 19:27:05 volumio volumio[912]: info: Enabling MyMusic plugin upnp Jul 06 19:27:05 volumio volumio[912]: info: Enabling plugin upnp Jul 06 19:27:05 volumio volumio[912]: info: Loading plugin "upnp"... Jul 06 19:27:05 volumio volumio[912]: info: [1751801225951] Starting Upmpd Daemon Jul 06 19:27:05 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 06 19:27:05 volumio volumio[912]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 06 19:27:05 volumio volumio[912]: Error: listen EADDRINUSE: address already in use :::6599 Jul 06 19:27:05 volumio volumio[912]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Jul 06 19:27:05 volumio volumio[912]: at listenInCluster (net.js:1366:12) Jul 06 19:27:05 volumio volumio[912]: at Server.listen (net.js:1452:7) Jul 06 19:27:05 volumio volumio[912]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Jul 06 19:27:05 volumio volumio[912]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Jul 06 19:27:05 volumio volumio[912]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jul 06 19:27:05 volumio volumio[912]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jul 06 19:27:05 volumio volumio[912]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Jul 06 19:27:05 volumio volumio[912]: code: 'EADDRINUSE', Jul 06 19:27:05 volumio volumio[912]: errno: -98, Jul 06 19:27:05 volumio volumio[912]: syscall: 'listen', Jul 06 19:27:05 volumio volumio[912]: address: '::', Jul 06 19:27:05 volumio volumio[912]: port: 6599 Jul 06 19:27:05 volumio volumio[912]: } Jul 06 19:27:05 volumio volumio[912]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 06 19:27:07 volumio sudo[6528]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-06 19:26 Jul 06 19:27:07 volumio sudo[6528]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"