-- Logs begin at Mon 2025-12-22 04:50:48 UTC, end at Mon 2025-12-22 05:54:10 UTC. -- Dec 22 05:53:05 volumio volumio[1189]: info: CoreCommandRouter::volumioPlay Dec 22 05:53:05 volumio volumio[1189]: UNSET VOLATILE Dec 22 05:53:05 volumio volumio[1189]: info: CoreStateMachine::play index undefined Dec 22 05:53:05 volumio volumio[1189]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:53:05 volumio volumio[1189]: info: CorePlayQueue::getTrack 0 Dec 22 05:53:05 volumio volumio[1189]: info: CoreStateMachine::startPlaybackTimer Dec 22 05:53:05 volumio volumio[1189]: info: CorePlayQueue::getTrack 0 Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::clearAddPlayTracks USB/D18C-9A55/20240417/画久 - 谷底有花.flac Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand stop Dec 22 05:53:05 volumio volumio[1189]: info: sending command... Dec 22 05:53:05 volumio volumio[1189]: info: parsing response... Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand clear Dec 22 05:53:05 volumio volumio[1189]: info: sending command... Dec 22 05:53:05 volumio volumio[1189]: info: Dec 22 05:53:05 volumio volumio[1189]: ---------------------------- MPD announces system playlist update Dec 22 05:53:05 volumio volumio[1189]: info: Ignoring MPD Status Update Dec 22 05:53:05 volumio volumio[1189]: info: parsing response... Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand add "USB/D18C-9A55/20240417/画久 - 谷底有花.flac" Dec 22 05:53:05 volumio volumio[1189]: info: sending command... Dec 22 05:53:05 volumio volumio[1189]: info: Dec 22 05:53:05 volumio volumio[1189]: info: Dec 22 05:53:05 volumio volumio[1189]: ---------------------------- MPD announces system playlist update Dec 22 05:53:05 volumio volumio[1189]: info: Ignoring MPD Status Update Dec 22 05:53:05 volumio volumio[1189]: info: ------------------------------ 3ms Dec 22 05:53:05 volumio volumio[1189]: info: parsing response... Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand play Dec 22 05:53:05 volumio volumio[1189]: info: sending command... Dec 22 05:53:05 volumio volumio[1189]: info: ------------------------------ 2ms Dec 22 05:53:05 volumio volumio[1189]: info: parsing response... Dec 22 05:53:05 volumio volumio[1189]: info: Dec 22 05:53:05 volumio volumio[1189]: ---------------------------- MPD announces state update: player Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::getState Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand status Dec 22 05:53:05 volumio volumio[1189]: info: sending command... Dec 22 05:53:05 volumio volumio[1189]: info: Dec 22 05:53:05 volumio volumio[1189]: ---------------------------- MPD announces state update: player Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::getState Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand status Dec 22 05:53:05 volumio volumio[1189]: info: sending command... Dec 22 05:53:05 volumio volumio[1189]: info: parsing response... Dec 22 05:53:05 volumio volumio[1189]: info: parsing response... Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::parseState Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand playlistinfo Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::parseState Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand playlistinfo Dec 22 05:53:05 volumio volumio[1189]: info: sending command... Dec 22 05:53:05 volumio volumio[1189]: info: sending command... Dec 22 05:53:05 volumio volumio[1189]: info: parsing response... Dec 22 05:53:05 volumio volumio[1189]: info: parsing response... Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::parseTrackInfo Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::parseTrackInfo Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::pushState Dec 22 05:53:05 volumio volumio[1189]: info: CoreCommandRouter::servicePushState Dec 22 05:53:05 volumio volumio[1189]: info: CoreStateMachine::syncState Dec 22 05:53:05 volumio volumio[1189]: info: CorePlayQueue::getTrack 0 Dec 22 05:53:05 volumio volumio[1189]: info: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":245,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1146 Kbps","isStreaming":false,"title":"谷底有花","artist":"画久","album":"谷底有花","uri":"USB/D18C-9A55/20240417/画久 - 谷底有花.flac","trackType":"flac"} Dec 22 05:53:05 volumio volumio[1189]: info: CURRENT POSITION 0 Dec 22 05:53:05 volumio volumio[1189]: info: CoreStateMachine::syncState stateService play Dec 22 05:53:05 volumio volumio[1189]: info: CoreStateMachine::syncState currentStatus stop Dec 22 05:53:05 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:05 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:05 volumio volumio[1189]: info: CorePlayQueue::getTrack 0 Dec 22 05:53:05 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:05 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:05 volumio sudo[5707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:05 volumio volumio[1189]: info: ControllerMpd::pushState Dec 22 05:53:05 volumio volumio[1189]: info: CoreCommandRouter::servicePushState Dec 22 05:53:05 volumio volumio[1189]: info: CoreStateMachine::syncState Dec 22 05:53:05 volumio volumio[1189]: info: CorePlayQueue::getTrack 0 Dec 22 05:53:05 volumio volumio[1189]: info: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":245,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1143 Kbps","isStreaming":false,"title":"谷底有花","artist":"画久","album":"谷底有花","uri":"USB/D18C-9A55/20240417/画久 - 谷底有花.flac","trackType":"flac"} Dec 22 05:53:05 volumio volumio[1189]: info: CURRENT POSITION 0 Dec 22 05:53:05 volumio volumio[1189]: info: CoreStateMachine::syncState stateService play Dec 22 05:53:05 volumio volumio[1189]: info: CoreStateMachine::syncState currentStatus play Dec 22 05:53:05 volumio volumio[1189]: info: Received an update from plugin. extracting info from payload Dec 22 05:53:05 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:05 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:05 volumio volumio[1189]: info: CorePlayQueue::getTrack 0 Dec 22 05:53:05 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:05 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:05 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:05 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:05 volumio volumio[1189]: info: CorePlayQueue::getTrack 0 Dec 22 05:53:05 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:05 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:05 volumio sudo[5707]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:05 volumio sudo[5707]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:05 volumio sudo[5711]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:05 volumio volumio[1189]: info: ------------------------------ 62ms Dec 22 05:53:05 volumio volumio[1189]: info: ------------------------------ 61ms Dec 22 05:53:05 volumio sudo[5718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:05 volumio sudo[5711]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:05 volumio sudo[5718]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:05 volumio sudo[5711]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:05 volumio sudo[5718]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:09 volumio volumio[1189]: info: Dec 22 05:53:09 volumio volumio[1189]: ---------------------------- MPD announces state update: player Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::getState Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand status Dec 22 05:53:09 volumio volumio[1189]: info: sending command... Dec 22 05:53:09 volumio volumio[1189]: info: parsing response... Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::parseState Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::pushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreCommandRouter::servicePushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::syncState Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:09 volumio volumio[1189]: info: CorePlayQueue::getTrack 0 Dec 22 05:53:09 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:09 volumio volumio[1189]: info: CorePlayQueue::getTrack 0 Dec 22 05:53:09 volumio volumio[1189]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 22 05:53:09 volumio volumio[1189]: info: CURRENT POSITION 0 Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::syncState stateService stop Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::syncState currentStatus play Dec 22 05:53:09 volumio volumio[1189]: info: CURRENT POSITION 0 Dec 22 05:53:09 volumio volumio[1189]: info: CURRENT POSITION 1 Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::play index undefined Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:09 volumio volumio[1189]: info: CorePlayQueue::getTrack 1 Dec 22 05:53:09 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:09 volumio sudo[5742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:09 volumio sudo[5742]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:09 volumio volumio[1189]: info: CorePlayQueue::getTrack 1 Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::startPlaybackTimer Dec 22 05:53:09 volumio volumio[1189]: info: CorePlayQueue::getTrack 1 Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::clearAddPlayTracks USB/D18C-9A55/20240417/画久 - 谷底有花.flac Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand stop Dec 22 05:53:09 volumio sudo[5742]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:09 volumio volumio[1189]: info: ------------------------------ 38ms Dec 22 05:53:09 volumio volumio[1189]: info: sending command... Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:09 volumio volumio[1189]: info: CorePlayQueue::getTrack 1 Dec 22 05:53:09 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:09 volumio sudo[5748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:09 volumio sudo[5748]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:09 volumio volumio[1189]: info: parsing response... Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand clear Dec 22 05:53:09 volumio volumio[1189]: info: sending command... Dec 22 05:53:09 volumio volumio[1189]: info: Dec 22 05:53:09 volumio volumio[1189]: ---------------------------- MPD announces system playlist update Dec 22 05:53:09 volumio sudo[5748]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:09 volumio volumio[1189]: info: Ignoring MPD Status Update Dec 22 05:53:09 volumio volumio[1189]: info: parsing response... Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand add "USB/D18C-9A55/20240417/画久 - 谷底有花.flac" Dec 22 05:53:09 volumio volumio[1189]: info: sending command... Dec 22 05:53:09 volumio sudo[5755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:09 volumio volumio[1189]: info: Dec 22 05:53:09 volumio volumio[1189]: info: Dec 22 05:53:09 volumio volumio[1189]: ---------------------------- MPD announces system playlist update Dec 22 05:53:09 volumio volumio[1189]: info: Ignoring MPD Status Update Dec 22 05:53:09 volumio volumio[1189]: info: ------------------------------ 4ms Dec 22 05:53:09 volumio volumio[1189]: info: parsing response... Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand play Dec 22 05:53:09 volumio volumio[1189]: info: sending command... Dec 22 05:53:09 volumio volumio[1189]: info: ------------------------------ 3ms Dec 22 05:53:09 volumio volumio[1189]: info: parsing response... Dec 22 05:53:09 volumio volumio[1189]: info: Dec 22 05:53:09 volumio volumio[1189]: ---------------------------- MPD announces state update: player Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::getState Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand status Dec 22 05:53:09 volumio volumio[1189]: info: sending command... Dec 22 05:53:09 volumio volumio[1189]: info: Dec 22 05:53:09 volumio volumio[1189]: ---------------------------- MPD announces state update: player Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::getState Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand status Dec 22 05:53:09 volumio volumio[1189]: info: parsing response... Dec 22 05:53:09 volumio volumio[1189]: info: sending command... Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::parseState Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand playlistinfo Dec 22 05:53:09 volumio volumio[1189]: info: sending command... Dec 22 05:53:09 volumio volumio[1189]: info: parsing response... Dec 22 05:53:09 volumio volumio[1189]: info: parsing response... Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::parseState Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand playlistinfo Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::parseTrackInfo Dec 22 05:53:09 volumio volumio[1189]: info: sending command... Dec 22 05:53:09 volumio sudo[5755]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:09 volumio sudo[5755]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::pushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreCommandRouter::servicePushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::syncState Dec 22 05:53:09 volumio volumio[1189]: info: CorePlayQueue::getTrack 1 Dec 22 05:53:09 volumio volumio[1189]: info: STATE SERVICE {"status":"play","position":0,"seek":298,"duration":245,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1144 Kbps","isStreaming":false,"title":"谷底有花","artist":"画久","album":"谷底有花","uri":"USB/D18C-9A55/20240417/画久 - 谷底有花.flac","trackType":"flac"} Dec 22 05:53:09 volumio volumio[1189]: info: CURRENT POSITION 1 Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::syncState stateService play Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::syncState currentStatus stop Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:09 volumio volumio[1189]: info: CorePlayQueue::getTrack 1 Dec 22 05:53:09 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:09 volumio volumio[1189]: info: ------------------------------ 31ms Dec 22 05:53:09 volumio volumio[1189]: info: parsing response... Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::parseTrackInfo Dec 22 05:53:09 volumio volumio[1189]: info: ControllerMpd::pushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreCommandRouter::servicePushState Dec 22 05:53:09 volumio sudo[5769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::syncState Dec 22 05:53:09 volumio volumio[1189]: info: CorePlayQueue::getTrack 1 Dec 22 05:53:09 volumio volumio[1189]: info: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":245,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1145 Kbps","isStreaming":false,"title":"谷底有花","artist":"画久","album":"谷底有花","uri":"USB/D18C-9A55/20240417/画久 - 谷底有花.flac","trackType":"flac"} Dec 22 05:53:09 volumio volumio[1189]: info: CURRENT POSITION 1 Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::syncState stateService play Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::syncState currentStatus play Dec 22 05:53:09 volumio volumio[1189]: info: Received an update from plugin. extracting info from payload Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:09 volumio volumio[1189]: info: CorePlayQueue::getTrack 1 Dec 22 05:53:09 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:09 volumio sudo[5769]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:09 volumio sudo[5769]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:09 volumio volumio[1189]: info: CorePlayQueue::getTrack 1 Dec 22 05:53:09 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:09 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:09 volumio sudo[5777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:09 volumio volumio[1189]: info: ------------------------------ 80ms Dec 22 05:53:09 volumio sudo[5777]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:09 volumio sudo[5780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:09 volumio sudo[5777]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:09 volumio sudo[5780]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:09 volumio sudo[5780]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:12 volumio volumio[1189]: info: Dec 22 05:53:12 volumio volumio[1189]: ---------------------------- MPD announces state update: player Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::getState Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand status Dec 22 05:53:12 volumio volumio[1189]: info: sending command... Dec 22 05:53:12 volumio volumio[1189]: info: parsing response... Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::parseState Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::pushState Dec 22 05:53:12 volumio volumio[1189]: info: CoreCommandRouter::servicePushState Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::syncState Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:12 volumio volumio[1189]: info: CorePlayQueue::getTrack 1 Dec 22 05:53:12 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:12 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:12 volumio volumio[1189]: info: CorePlayQueue::getTrack 1 Dec 22 05:53:12 volumio volumio[1189]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 22 05:53:12 volumio volumio[1189]: info: CURRENT POSITION 1 Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::syncState stateService stop Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::syncState currentStatus play Dec 22 05:53:12 volumio volumio[1189]: info: CURRENT POSITION 1 Dec 22 05:53:12 volumio volumio[1189]: info: CURRENT POSITION 2 Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::play index undefined Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:12 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:12 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:12 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:12 volumio sudo[5821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:12 volumio sudo[5821]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:12 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::startPlaybackTimer Dec 22 05:53:12 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::clearAddPlayTracks USB/D18C-9A55/20240417/程响 - 念.flac Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand stop Dec 22 05:53:12 volumio sudo[5821]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:12 volumio volumio[1189]: info: ------------------------------ 41ms Dec 22 05:53:12 volumio volumio[1189]: info: sending command... Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:12 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:12 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:12 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:12 volumio sudo[5827]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:12 volumio volumio[1189]: info: parsing response... Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand clear Dec 22 05:53:12 volumio volumio[1189]: info: sending command... Dec 22 05:53:12 volumio sudo[5827]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:12 volumio volumio[1189]: info: Dec 22 05:53:12 volumio volumio[1189]: ---------------------------- MPD announces system playlist update Dec 22 05:53:12 volumio sudo[5832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:12 volumio volumio[1189]: info: Ignoring MPD Status Update Dec 22 05:53:12 volumio volumio[1189]: info: parsing response... Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand add "USB/D18C-9A55/20240417/程响 - 念.flac" Dec 22 05:53:12 volumio volumio[1189]: info: sending command... Dec 22 05:53:12 volumio volumio[1189]: info: Dec 22 05:53:12 volumio volumio[1189]: info: Dec 22 05:53:12 volumio volumio[1189]: ---------------------------- MPD announces system playlist update Dec 22 05:53:12 volumio volumio[1189]: info: Ignoring MPD Status Update Dec 22 05:53:12 volumio volumio[1189]: info: ------------------------------ 4ms Dec 22 05:53:12 volumio volumio[1189]: info: parsing response... Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand play Dec 22 05:53:12 volumio volumio[1189]: info: sending command... Dec 22 05:53:12 volumio sudo[5832]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:12 volumio sudo[5827]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:12 volumio volumio[1189]: info: Dec 22 05:53:12 volumio volumio[1189]: ---------------------------- MPD announces state update: player Dec 22 05:53:12 volumio volumio[1189]: info: ------------------------------ 7ms Dec 22 05:53:12 volumio volumio[1189]: info: parsing response... Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::getState Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand status Dec 22 05:53:12 volumio volumio[1189]: info: sending command... Dec 22 05:53:12 volumio sudo[5832]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:12 volumio volumio[1189]: info: Dec 22 05:53:12 volumio volumio[1189]: ---------------------------- MPD announces state update: player Dec 22 05:53:12 volumio volumio[1189]: info: parsing response... Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::getState Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand status Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::parseState Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand playlistinfo Dec 22 05:53:12 volumio volumio[1189]: info: sending command... Dec 22 05:53:12 volumio volumio[1189]: info: sending command... Dec 22 05:53:12 volumio volumio[1189]: info: parsing response... Dec 22 05:53:12 volumio volumio[1189]: info: parsing response... Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::parseState Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand playlistinfo Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::parseTrackInfo Dec 22 05:53:12 volumio volumio[1189]: info: sending command... Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::pushState Dec 22 05:53:12 volumio volumio[1189]: info: CoreCommandRouter::servicePushState Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::syncState Dec 22 05:53:12 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:12 volumio volumio[1189]: info: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":185,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1429 Kbps","isStreaming":false,"title":"念","artist":"程响","album":"念","uri":"USB/D18C-9A55/20240417/程响 - 念.flac","trackType":"flac"} Dec 22 05:53:12 volumio volumio[1189]: info: CURRENT POSITION 2 Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::syncState stateService play Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::syncState currentStatus stop Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:12 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:12 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:12 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:12 volumio volumio[1189]: info: ------------------------------ 32ms Dec 22 05:53:12 volumio volumio[1189]: info: parsing response... Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::parseTrackInfo Dec 22 05:53:12 volumio volumio[1189]: info: ControllerMpd::pushState Dec 22 05:53:12 volumio volumio[1189]: info: CoreCommandRouter::servicePushState Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::syncState Dec 22 05:53:12 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:12 volumio volumio[1189]: info: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":185,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1429 Kbps","isStreaming":false,"title":"念","artist":"程响","album":"念","uri":"USB/D18C-9A55/20240417/程响 - 念.flac","trackType":"flac"} Dec 22 05:53:12 volumio volumio[1189]: info: CURRENT POSITION 2 Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::syncState stateService play Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::syncState currentStatus play Dec 22 05:53:12 volumio volumio[1189]: info: Received an update from plugin. extracting info from payload Dec 22 05:53:12 volumio sudo[5848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:12 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:12 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:12 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:13 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:12 volumio sudo[5848]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:13 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:13 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:13 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:13 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:13 volumio sudo[5848]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:13 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:13 volumio sudo[5853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:13 volumio sudo[5853]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:13 volumio volumio[1189]: info: ------------------------------ 63ms Dec 22 05:53:13 volumio sudo[5853]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:13 volumio sudo[5860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:13 volumio sudo[5860]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:13 volumio sudo[5860]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:24 volumio volumio[1189]: info: CoreCommandRouter::volumioSeek Dec 22 05:53:24 volumio volumio[1189]: info: CoreStateMachine::seek Dec 22 05:53:24 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:24 volumio volumio[1189]: info: TRACKBLOCK {"uri":"music-library/USB/D18C-9A55/20240417/程响 - 念.flac","service":"mpd","name":"念","artist":"程响","album":"念","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=70&web=%E7%A8%8B%E5%93%8D/%E5%BF%B5/extralarge&path=%2Fmnt%2FUSB%2FD18C-9A55%2F20240417&metadata=false","duration":185,"trackType":"flac","samplerate":"48 kHz","bitdepth":"24 bit","channels":2} Dec 22 05:53:24 volumio volumio[1189]: info: CoreStateMachine::startPlaybackTimer Dec 22 05:53:24 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:24 volumio volumio[1189]: info: ControllerMpd::seek Dec 22 05:53:24 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:24 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:24 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:24 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:24 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:24 volumio sudo[5896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:24 volumio volumio[1189]: error: Dec 22 05:53:24 volumio volumio[1189]: info: Dec 22 05:53:24 volumio volumio[1189]: ---------------------------- MPD announces state update: player Dec 22 05:53:24 volumio volumio[1189]: info: ControllerMpd::getState Dec 22 05:53:24 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand status Dec 22 05:53:24 volumio volumio[1189]: info: sending command... Dec 22 05:53:24 volumio volumio[1189]: info: parsing response... Dec 22 05:53:24 volumio sudo[5896]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:24 volumio volumio[1189]: info: ControllerMpd::parseState Dec 22 05:53:24 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand playlistinfo Dec 22 05:53:24 volumio volumio[1189]: info: sending command... Dec 22 05:53:24 volumio volumio[1189]: info: parsing response... Dec 22 05:53:24 volumio volumio[1189]: info: ControllerMpd::parseTrackInfo Dec 22 05:53:24 volumio volumio[1189]: info: ControllerMpd::pushState Dec 22 05:53:24 volumio volumio[1189]: info: CoreCommandRouter::servicePushState Dec 22 05:53:24 volumio volumio[1189]: info: CoreStateMachine::syncState Dec 22 05:53:24 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:24 volumio volumio[1189]: info: STATE SERVICE {"status":"play","position":0,"seek":22000,"duration":185,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1418 Kbps","isStreaming":false,"title":"念","artist":"程响","album":"念","uri":"USB/D18C-9A55/20240417/程响 - 念.flac","trackType":"flac"} Dec 22 05:53:24 volumio volumio[1189]: info: CURRENT POSITION 2 Dec 22 05:53:24 volumio volumio[1189]: info: CoreStateMachine::syncState stateService play Dec 22 05:53:24 volumio volumio[1189]: info: CoreStateMachine::syncState currentStatus play Dec 22 05:53:24 volumio volumio[1189]: info: Received an update from plugin. extracting info from payload Dec 22 05:53:24 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:24 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:24 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:24 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:24 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:24 volumio sudo[5896]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:24 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:24 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:24 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:24 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:24 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:24 volumio sudo[5905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:24 volumio sudo[5905]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:24 volumio volumio[1189]: info: ------------------------------ 47ms Dec 22 05:53:24 volumio sudo[5905]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:24 volumio sudo[5912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:24 volumio sudo[5912]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:24 volumio sudo[5912]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:36 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 22 05:53:36 volumio volumio[1189]: info: CURURI: albums:// Dec 22 05:53:36 volumio volumio[1189]: listAlbums - loading Albums from cache Dec 22 05:53:36 volumio volumio[1189]: info: CoreCommandRouter::volumioGetQueue Dec 22 05:53:36 volumio volumio[1189]: info: CoreStateMachine::getQueue Dec 22 05:53:36 volumio volumio[1189]: info: CorePlayQueue::getQueue Dec 22 05:53:36 volumio volumio[1189]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dream%20Theater/Black%20Clouds%20%26%20Silver%20Linings/b8753a2c-490c-4981-a44c-0c21a1bd07f7.jpg' Dec 22 05:53:36 volumio volumio[1189]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/Hello/b15f3022-be41-4cb9-9f28-8b58e43ec829.png' Dec 22 05:53:36 volumio volumio[1189]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Bauhaus/In%20the%20Flat%20Field/5fe0dadb-3a74-40a7-a141-7fb07434897c.png' Dec 22 05:53:36 volumio volumio[1189]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Diana%20Panton/To%20Brazil%20with%20Love/b4c852ed-94b1-4a2c-ba27-2426be8f8baa.jpg' Dec 22 05:53:36 volumio volumio[1189]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Lisa%20Miskovsky/Fallingwater/a68dd145-8d37-4d4c-b078-6a80bca49344.jpg' Dec 22 05:53:37 volumio volumio[1189]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%A8%8B%E5%93%8D/%E5%BF%B5/5bbc320d-5ebe-4a2b-8464-a2025747c4c4.jpg' Dec 22 05:53:37 volumio volumio[1189]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E6%99%93%E6%A3%A0/%E6%83%85%E9%9A%BE%E6%B8%A1/3ab2ea0f-2dfa-413c-821e-162bbfbfa142.jpg' Dec 22 05:53:37 volumio volumio[1189]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%B5%B5%E9%9B%B7/%E7%BD%B2%E5%89%8D%E8%A1%97%E5%B0%91%E5%B9%B4/c7b111d5-bcc2-41fd-a6f7-0acefd20785e.jpg' Dec 22 05:53:38 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 22 05:53:38 volumio volumio[1189]: info: CURURI: music-library Dec 22 05:53:39 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 22 05:53:39 volumio volumio[1189]: info: CURURI: music-library/USB Dec 22 05:53:40 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 22 05:53:40 volumio volumio[1189]: info: CURURI: music-library/USB/D18C-9A55 Dec 22 05:53:41 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 22 05:53:41 volumio volumio[1189]: info: CURURI: music-library/USB/D18C-9A55/192k-24bit Dec 22 05:53:44 volumio volumio[1189]: info: CoreCommandRouter::volumioAddQueueItems Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::addQueueItems Dec 22 05:53:44 volumio volumio[1189]: info: CorePlayQueue::addQueueItems Dec 22 05:53:44 volumio volumio[1189]: info: Adding Item to queue: music-library/USB/D18C-9A55/192k-24bit/01. Adele - Hello.flac Dec 22 05:53:44 volumio volumio[1189]: info: Exploding uri music-library/USB/D18C-9A55/192k-24bit/01. Adele - Hello.flac in service mpd Dec 22 05:53:44 volumio volumio[1189]: info: ALBUMART /albumart?cacheid=70&web=Adele/Hello/extralarge&path=%2Fmnt%2FUSB%2FD18C-9A55%2F192k-24bit%2F01.%20Adele%20-%20Hello.flac&metadata=false Dec 22 05:53:44 volumio volumio[1189]: info: URI /mnt/USB/D18C-9A55/192k-24bit/01. Adele - Hello.flac Dec 22 05:53:44 volumio volumio[1189]: info: CorePlayQueue::saveQueue Dec 22 05:53:44 volumio volumio[1189]: info: CoreCommandRouter::volumioPushQueue Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::updateTrackBlock Dec 22 05:53:44 volumio volumio[1189]: info: CorePlayQueue::getTrackBlock Dec 22 05:53:44 volumio volumio[1189]: info: CoreCommandRouter::volumioPlay Dec 22 05:53:44 volumio volumio[1189]: UNSET VOLATILE Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::play index 3 Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::stop Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:53:44 volumio volumio[1189]: UNSET VOLATILE Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::stPlaybackTimer Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::updateTrackBlock Dec 22 05:53:44 volumio volumio[1189]: info: CorePlayQueue::getTrackBlock Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:44 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:44 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:44 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::serviceStop Dec 22 05:53:44 volumio volumio[1189]: info: CorePlayQueue::getTrack 2 Dec 22 05:53:44 volumio volumio[1189]: info: CoreCommandRouter::serviceStop Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::stop Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand stop Dec 22 05:53:44 volumio volumio[1189]: info: sending command... Dec 22 05:53:44 volumio sudo[5968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:44 volumio sudo[5968]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:44 volumio sudo[5968]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:44 volumio volumio[1189]: info: parsing response... Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::play index undefined Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:53:44 volumio volumio[1189]: info: CorePlayQueue::getTrack 3 Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::startPlaybackTimer Dec 22 05:53:44 volumio volumio[1189]: info: CorePlayQueue::getTrack 3 Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::clearAddPlayTracks USB/D18C-9A55/192k-24bit/01. Adele - Hello.flac Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand stop Dec 22 05:53:44 volumio volumio[1189]: info: sending command... Dec 22 05:53:44 volumio volumio[1189]: info: Dec 22 05:53:44 volumio volumio[1189]: ---------------------------- MPD announces state update: player Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::getState Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand status Dec 22 05:53:44 volumio volumio[1189]: info: parsing response... Dec 22 05:53:44 volumio volumio[1189]: info: sending command... Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand clear Dec 22 05:53:44 volumio volumio[1189]: info: sending command... Dec 22 05:53:44 volumio volumio[1189]: info: Dec 22 05:53:44 volumio volumio[1189]: ---------------------------- MPD announces system playlist update Dec 22 05:53:44 volumio volumio[1189]: info: Ignoring MPD Status Update Dec 22 05:53:44 volumio volumio[1189]: info: parsing response... Dec 22 05:53:44 volumio volumio[1189]: info: parsing response... Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::parseState Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand playlistinfo Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand add "USB/D18C-9A55/192k-24bit/01. Adele - Hello.flac" Dec 22 05:53:44 volumio volumio[1189]: info: sending command... Dec 22 05:53:44 volumio volumio[1189]: info: sending command... Dec 22 05:53:44 volumio volumio[1189]: info: Dec 22 05:53:44 volumio volumio[1189]: info: Dec 22 05:53:44 volumio volumio[1189]: ---------------------------- MPD announces system playlist update Dec 22 05:53:44 volumio volumio[1189]: info: Ignoring MPD Status Update Dec 22 05:53:44 volumio volumio[1189]: info: ------------------------------ 3ms Dec 22 05:53:44 volumio volumio[1189]: info: parsing response... Dec 22 05:53:44 volumio volumio[1189]: info: parsing response... Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::parseTrackInfo Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand play Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::pushError Dec 22 05:53:44 volumio volumio[1189]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined Dec 22 05:53:44 volumio volumio[1189]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:294:72) Dec 22 05:53:44 volumio volumio[1189]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Dec 22 05:53:44 volumio volumio[1189]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Dec 22 05:53:44 volumio volumio[1189]: at process._tickCallback (internal/process/next_tick.js:180:9) Dec 22 05:53:44 volumio volumio[1189]: info: sending command... Dec 22 05:53:44 volumio volumio[1189]: info: ------------------------------ 12ms Dec 22 05:53:44 volumio volumio[1189]: info: ------------------------------ 7ms Dec 22 05:53:44 volumio volumio[1189]: info: parsing response... Dec 22 05:53:44 volumio volumio[1189]: info: Dec 22 05:53:44 volumio volumio[1189]: ---------------------------- MPD announces state update: player Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::getState Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand status Dec 22 05:53:44 volumio volumio[1189]: info: sending command... Dec 22 05:53:44 volumio volumio[1189]: info: Dec 22 05:53:44 volumio volumio[1189]: ---------------------------- MPD announces state update: player Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::getState Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand status Dec 22 05:53:44 volumio volumio[1189]: info: sending command... Dec 22 05:53:44 volumio volumio[1189]: info: parsing response... Dec 22 05:53:44 volumio volumio[1189]: info: parsing response... Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::parseState Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand playlistinfo Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::parseState Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand playlistinfo Dec 22 05:53:44 volumio volumio[1189]: info: sending command... Dec 22 05:53:44 volumio volumio[1189]: info: sending command... Dec 22 05:53:44 volumio volumio[1189]: info: parsing response... Dec 22 05:53:44 volumio volumio[1189]: info: parsing response... Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::parseTrackInfo Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::parseTrackInfo Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::pushState Dec 22 05:53:44 volumio volumio[1189]: info: CoreCommandRouter::servicePushState Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::syncState Dec 22 05:53:44 volumio volumio[1189]: info: CorePlayQueue::getTrack 3 Dec 22 05:53:44 volumio volumio[1189]: info: STATE SERVICE {"status":"play","position":0,"seek":298,"duration":296,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1336 Kbps","isStreaming":false,"title":"Hello","artist":"Adele","album":"Hello","uri":"USB/D18C-9A55/192k-24bit/01. Adele - Hello.flac","trackType":"flac"} Dec 22 05:53:44 volumio volumio[1189]: info: CURRENT POSITION 3 Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::syncState stateService play Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::syncState currentStatus stop Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:44 volumio volumio[1189]: info: CorePlayQueue::getTrack 3 Dec 22 05:53:44 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:44 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:44 volumio volumio[1189]: info: ControllerMpd::pushState Dec 22 05:53:44 volumio volumio[1189]: info: CoreCommandRouter::servicePushState Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::syncState Dec 22 05:53:44 volumio volumio[1189]: info: CorePlayQueue::getTrack 3 Dec 22 05:53:44 volumio volumio[1189]: info: STATE SERVICE {"status":"play","position":0,"seek":338,"duration":296,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1536 Kbps","isStreaming":false,"title":"Hello","artist":"Adele","album":"Hello","uri":"USB/D18C-9A55/192k-24bit/01. Adele - Hello.flac","trackType":"flac"} Dec 22 05:53:44 volumio volumio[1189]: info: CURRENT POSITION 3 Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::syncState stateService play Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::syncState currentStatus play Dec 22 05:53:44 volumio volumio[1189]: info: Received an update from plugin. extracting info from payload Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:44 volumio volumio[1189]: info: CorePlayQueue::getTrack 3 Dec 22 05:53:44 volumio sudo[5977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:44 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:44 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:44 volumio sudo[5977]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:44 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:44 volumio volumio[1189]: info: CorePlayQueue::getTrack 3 Dec 22 05:53:44 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:44 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:44 volumio sudo[5977]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:45 volumio sudo[5983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:45 volumio volumio[1189]: info: ------------------------------ 66ms Dec 22 05:53:45 volumio volumio[1189]: info: ------------------------------ 65ms Dec 22 05:53:45 volumio sudo[5983]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:45 volumio sudo[5987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:45 volumio sudo[5983]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:45 volumio volumio[1189]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/Hello/b15f3022-be41-4cb9-9f28-8b58e43ec829.png' Dec 22 05:53:45 volumio sudo[5987]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:45 volumio sudo[5987]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:46 volumio volumio[1189]: info: CoreCommandRouter::volumioSeek Dec 22 05:53:46 volumio volumio[1189]: info: CoreStateMachine::seek Dec 22 05:53:46 volumio volumio[1189]: info: CorePlayQueue::getTrack 3 Dec 22 05:53:46 volumio volumio[1189]: info: TRACKBLOCK {"uri":"mnt/USB/D18C-9A55/192k-24bit/01. Adele - Hello.flac","service":"mpd","name":"Hello","artist":"Adele","album":"Hello","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=70&web=Adele/Hello/extralarge&path=%2FUSB%2FD18C-9A55%2F192k-24bit&metadata=false","duration":296,"samplerate":"192 kHz","bitdepth":"24 bit","trackType":"flac","channels":2} Dec 22 05:53:46 volumio volumio[1189]: info: CoreStateMachine::startPlaybackTimer Dec 22 05:53:46 volumio volumio[1189]: info: CorePlayQueue::getTrack 3 Dec 22 05:53:46 volumio volumio[1189]: info: ControllerMpd::seek Dec 22 05:53:46 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:46 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:46 volumio volumio[1189]: info: CorePlayQueue::getTrack 3 Dec 22 05:53:46 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:46 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:46 volumio sudo[6006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:46 volumio volumio[1189]: error: Dec 22 05:53:46 volumio sudo[6006]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:46 volumio volumio[1189]: info: Dec 22 05:53:46 volumio volumio[1189]: ---------------------------- MPD announces state update: player Dec 22 05:53:46 volumio volumio[1189]: info: ControllerMpd::getState Dec 22 05:53:46 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand status Dec 22 05:53:46 volumio volumio[1189]: info: sending command... Dec 22 05:53:46 volumio volumio[1189]: info: parsing response... Dec 22 05:53:46 volumio volumio[1189]: info: ControllerMpd::parseState Dec 22 05:53:46 volumio volumio[1189]: info: ControllerMpd::sendMpdCommand playlistinfo Dec 22 05:53:46 volumio volumio[1189]: info: sending command... Dec 22 05:53:46 volumio volumio[1189]: info: parsing response... Dec 22 05:53:46 volumio volumio[1189]: info: ControllerMpd::parseTrackInfo Dec 22 05:53:46 volumio volumio[1189]: info: ControllerMpd::pushState Dec 22 05:53:46 volumio volumio[1189]: info: CoreCommandRouter::servicePushState Dec 22 05:53:46 volumio volumio[1189]: info: CoreStateMachine::syncState Dec 22 05:53:46 volumio volumio[1189]: info: CorePlayQueue::getTrack 3 Dec 22 05:53:46 volumio volumio[1189]: info: STATE SERVICE {"status":"play","position":0,"seek":41000,"duration":296,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2647 Kbps","isStreaming":false,"title":"Hello","artist":"Adele","album":"Hello","uri":"USB/D18C-9A55/192k-24bit/01. Adele - Hello.flac","trackType":"flac"} Dec 22 05:53:46 volumio volumio[1189]: info: CURRENT POSITION 3 Dec 22 05:53:46 volumio volumio[1189]: info: CoreStateMachine::syncState stateService play Dec 22 05:53:46 volumio volumio[1189]: info: CoreStateMachine::syncState currentStatus play Dec 22 05:53:46 volumio volumio[1189]: info: Received an update from plugin. extracting info from payload Dec 22 05:53:46 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:46 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:46 volumio volumio[1189]: info: CorePlayQueue::getTrack 3 Dec 22 05:53:46 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:46 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:46 volumio sudo[6006]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:46 volumio volumio[1189]: info: CoreStateMachine::pushState Dec 22 05:53:46 volumio volumio[1189]: info: CoreStateMachine::getState Dec 22 05:53:46 volumio volumio[1189]: info: CorePlayQueue::getTrack 3 Dec 22 05:53:46 volumio volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 22 05:53:46 volumio volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:53:46 volumio sudo[6014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:46 volumio sudo[6014]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:46 volumio volumio[1189]: info: ------------------------------ 48ms Dec 22 05:53:46 volumio sudo[6014]: pam_unix(sudo:session): session closed for user root Dec 22 05:53:46 volumio sudo[6020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:53:46 volumio sudo[6020]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:53:46 volumio sudo[6020]: pam_unix(sudo:session): session closed for user root Dec 22 05:54:09 volumio volumio[1189]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 05:54:09 volumio volumio[1189]: { Error: connect ETIMEDOUT 69.63.176.59:443 Dec 22 05:54:09 volumio volumio[1189]: at Object._errnoException (util.js:1022:11) Dec 22 05:54:09 volumio volumio[1189]: at _exceptionWithHostPort (util.js:1044:20) Dec 22 05:54:09 volumio volumio[1189]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Dec 22 05:54:09 volumio volumio[1189]: code: 'ETIMEDOUT', Dec 22 05:54:09 volumio volumio[1189]: errno: 'ETIMEDOUT', Dec 22 05:54:09 volumio volumio[1189]: syscall: 'connect', Dec 22 05:54:09 volumio volumio[1189]: address: '69.63.176.59', Dec 22 05:54:09 volumio volumio[1189]: port: 443 } Dec 22 05:54:09 volumio volumio[1189]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 05:54:10 volumio sudo[6106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-22 05:53 Dec 22 05:54:10 volumio sudo[6106]: 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"