-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sat 2024-04-20 14:20:54 CST. -- Apr 20 14:19:05 volumiokk volumio[813]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 20 14:19:05 volumiokk volumio[813]: info: Retrying Login Due to Network Error Apr 20 14:19:05 volumiokk volumio[813]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 9 Apr 20 14:19:05 volumiokk volumio[813]: info: CoreCommandRouter::volumioGetState Apr 20 14:19:05 volumiokk volumio[813]: info: CorePlayQueue::getTrack 63 Apr 20 14:19:06 volumiokk volumio[813]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Wanted/Battleground/476ef736-96bd-498e-8950-4bd8f3a71813.png' Apr 20 14:19:15 volumiokk volumio[813]: info: MyVolumio login type: Token Apr 20 14:19:15 volumiokk volumio[813]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 20 14:19:15 volumiokk volumio[813]: info: Retrying Login Due to Network Error Apr 20 14:19:25 volumiokk volumio[813]: info: MyVolumio login type: Token Apr 20 14:19:45 volumiokk volumio[813]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 20 14:19:45 volumiokk volumio[813]: info: Retrying Login Due to Network Error Apr 20 14:19:48 volumiokk volumio[813]: info: CoreCommandRouter::volumioNext Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::next Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::stop Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::stPlaybackTimer Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::updateTrackBlock Apr 20 14:19:48 volumiokk volumio[813]: info: CorePlayQueue::getTrackBlock Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:19:48 volumiokk volumio[813]: info: CorePlayQueue::getTrack 63 Apr 20 14:19:48 volumiokk volumio[813]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 14:19:48 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::serviceStop Apr 20 14:19:48 volumiokk volumio[813]: info: CorePlayQueue::getTrack 63 Apr 20 14:19:48 volumiokk volumio[813]: info: CoreCommandRouter::serviceStop Apr 20 14:19:48 volumiokk volumio[813]: info: ControllerMpd::stop Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 14:19:48 volumiokk volumio[813]: info: Apr 20 14:19:48 volumiokk volumio[813]: ---------------------------- MPD announces state update: player Apr 20 14:19:48 volumiokk volumio[813]: info: sendMpdCommand stop took 134 milliseconds Apr 20 14:19:48 volumiokk volumio[813]: info: ControllerMpd::getState Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand status Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::play index undefined Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 14:19:48 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::startPlaybackTimer Apr 20 14:19:48 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::clearAddPlayTracks NAS/229/DMU2/合辑/合辑A/Toxic - CALLmeKAT.mp3 Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::updateTrackBlock Apr 20 14:19:48 volumiokk volumio[813]: info: CorePlayQueue::getTrackBlock Apr 20 14:19:48 volumiokk volumio[813]: info: Apr 20 14:19:48 volumiokk volumio[813]: ---------------------------- MPD announces state update: player Apr 20 14:19:48 volumiokk volumio[813]: info: ControllerMpd::getState Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand status Apr 20 14:19:48 volumiokk volumio[813]: info: sendMpdCommand status took 16 milliseconds Apr 20 14:19:48 volumiokk volumio[813]: info: sendMpdCommand stop took 12 milliseconds Apr 20 14:19:48 volumiokk volumio[813]: info: sendMpdCommand status took 10 milliseconds Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::parseState Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::parseState Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 14:19:48 volumiokk volumio[813]: info: Apr 20 14:19:48 volumiokk volumio[813]: ---------------------------- MPD announces system playlist update Apr 20 14:19:48 volumiokk volumio[813]: info: Ignoring MPD Status Update Apr 20 14:19:48 volumiokk volumio[813]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 20 14:19:48 volumiokk volumio[813]: info: sendMpdCommand clear took 8 milliseconds Apr 20 14:19:48 volumiokk volumio[813]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::parseTrackInfo Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand add "NAS/229/DMU2/合辑/合辑A/Toxic - CALLmeKAT.mp3" Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::parseTrackInfo Apr 20 14:19:48 volumiokk volumio[813]: info: ControllerMpd::pushState Apr 20 14:19:48 volumiokk volumio[813]: info: CoreCommandRouter::servicePushState Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:19:48 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:48 volumiokk volumio[813]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 14:19:48 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:19:48 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:48 volumiokk volumio[813]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Glad You Came","artist":"The Wanted","album":"Battleground","uri":"NAS/229/DMU2/合辑/合辑A/Glad You Came.mp3","trackType":"mp3"} Apr 20 14:19:48 volumiokk volumio[813]: verbose: CURRENT POSITION 174 Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::syncState stateService stop Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::syncState currentStatus stop Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:19:48 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:48 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:19:48 volumiokk volumio[813]: info: No code Apr 20 14:19:48 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:19:48 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:48 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:19:48 volumiokk volumio[813]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 20 14:19:48 volumiokk volumio[813]: info: ------------------------------ 131ms Apr 20 14:19:48 volumiokk volumio[813]: info: ------------------------------ 124ms Apr 20 14:19:48 volumiokk volumio[813]: info: Apr 20 14:19:48 volumiokk volumio[813]: ---------------------------- MPD announces system playlist update Apr 20 14:19:48 volumiokk volumio[813]: info: Ignoring MPD Status Update Apr 20 14:19:48 volumiokk volumio[813]: error: updateQueue error: null Apr 20 14:19:48 volumiokk volumio[813]: info: Apr 20 14:19:48 volumiokk volumio[813]: ---------------------------- MPD announces system playlist update Apr 20 14:19:48 volumiokk volumio[813]: info: Ignoring MPD Status Update Apr 20 14:19:48 volumiokk volumio[813]: info: ------------------------------ 113ms Apr 20 14:19:48 volumiokk volumio[813]: info: sendMpdCommand add "NAS/229/DMU2/合辑/合辑A/Toxic - CALLmeKAT.mp3" took 109 milliseconds Apr 20 14:19:48 volumiokk volumio[813]: info: ------------------------------ 8ms Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand play Apr 20 14:19:48 volumiokk volumio[813]: info: Apr 20 14:19:48 volumiokk volumio[813]: ---------------------------- MPD announces system playlist update Apr 20 14:19:48 volumiokk volumio[813]: info: Ignoring MPD Status Update Apr 20 14:19:48 volumiokk volumio[813]: info: touch_display: Setting screensaver timeout to 10 seconds. Apr 20 14:19:48 volumiokk volumio[813]: info: ------------------------------ 50ms Apr 20 14:19:48 volumiokk volumio[813]: info: sendMpdCommand play took 46 milliseconds Apr 20 14:19:48 volumiokk volumio[813]: info: ------------------------------ 45ms Apr 20 14:19:48 volumiokk volumio[813]: info: Apr 20 14:19:48 volumiokk volumio[813]: ---------------------------- MPD announces state update: player Apr 20 14:19:48 volumiokk volumio[813]: info: ControllerMpd::getState Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand status Apr 20 14:19:48 volumiokk volumio[813]: info: Apr 20 14:19:48 volumiokk volumio[813]: ---------------------------- MPD announces state update: player Apr 20 14:19:48 volumiokk volumio[813]: info: ControllerMpd::getState Apr 20 14:19:48 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand status Apr 20 14:19:49 volumiokk volumio[813]: info: sendMpdCommand status took 311 milliseconds Apr 20 14:19:49 volumiokk volumio[813]: verbose: ControllerMpd::parseState Apr 20 14:19:49 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 14:19:49 volumiokk volumio[813]: info: Apr 20 14:19:49 volumiokk volumio[813]: ---------------------------- MPD announces state update: player Apr 20 14:19:49 volumiokk volumio[813]: info: ControllerMpd::getState Apr 20 14:19:49 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand status Apr 20 14:19:49 volumiokk volumio[813]: info: sendMpdCommand status took 313 milliseconds Apr 20 14:19:49 volumiokk volumio[813]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 20 14:19:49 volumiokk volumio[813]: verbose: ControllerMpd::parseState Apr 20 14:19:49 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 14:19:49 volumiokk volumio[813]: verbose: ControllerMpd::parseTrackInfo Apr 20 14:19:49 volumiokk volumio[813]: info: ControllerMpd::pushState Apr 20 14:19:49 volumiokk volumio[813]: info: CoreCommandRouter::servicePushState Apr 20 14:19:49 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:49 volumiokk volumio[813]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":243,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Toxic","artist":"CALLmeKAT","album":"Fall Down","uri":"NAS/229/DMU2/合辑/合辑A/Toxic - CALLmeKAT.mp3","trackType":"mp3"} Apr 20 14:19:49 volumiokk volumio[813]: verbose: CURRENT POSITION 174 Apr 20 14:19:49 volumiokk volumio[813]: info: CoreStateMachine::syncState stateService play Apr 20 14:19:49 volumiokk volumio[813]: info: CoreStateMachine::syncState currentStatus stop Apr 20 14:19:49 volumiokk volumio[813]: info: ------------------------------ 325ms Apr 20 14:19:49 volumiokk volumio[813]: info: Apr 20 14:19:49 volumiokk volumio[813]: ---------------------------- MPD announces state update: player Apr 20 14:19:49 volumiokk volumio[813]: info: ControllerMpd::getState Apr 20 14:19:49 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand status Apr 20 14:19:49 volumiokk volumio[813]: info: sendMpdCommand status took 12 milliseconds Apr 20 14:19:49 volumiokk volumio[813]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 20 14:19:49 volumiokk volumio[813]: verbose: ControllerMpd::parseState Apr 20 14:19:49 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 14:19:49 volumiokk volumio[813]: verbose: ControllerMpd::parseTrackInfo Apr 20 14:19:49 volumiokk volumio[813]: info: ControllerMpd::pushState Apr 20 14:19:49 volumiokk volumio[813]: info: CoreCommandRouter::servicePushState Apr 20 14:19:49 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:49 volumiokk volumio[813]: verbose: STATE SERVICE {"status":"play","position":0,"seek":628,"duration":243,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Toxic","artist":"CALLmeKAT","album":"Fall Down","uri":"NAS/229/DMU2/合辑/合辑A/Toxic - CALLmeKAT.mp3","trackType":"mp3"} Apr 20 14:19:49 volumiokk volumio[813]: verbose: CURRENT POSITION 174 Apr 20 14:19:49 volumiokk volumio[813]: info: CoreStateMachine::syncState stateService play Apr 20 14:19:49 volumiokk volumio[813]: info: CoreStateMachine::syncState currentStatus play Apr 20 14:19:49 volumiokk volumio[813]: info: Received an update from plugin. extracting info from payload Apr 20 14:19:49 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:19:49 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:49 volumiokk volumio[813]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 14:19:49 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:19:49 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:19:49 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:49 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:19:49 volumiokk volumio[813]: info: ------------------------------ 403ms Apr 20 14:19:49 volumiokk volumio[813]: info: sendMpdCommand status took 82 milliseconds Apr 20 14:19:49 volumiokk volumio[813]: info: sendMpdCommand playlistinfo took 76 milliseconds Apr 20 14:19:49 volumiokk volumio[813]: verbose: ControllerMpd::parseState Apr 20 14:19:49 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 14:19:49 volumiokk volumio[813]: verbose: ControllerMpd::parseTrackInfo Apr 20 14:19:49 volumiokk volumio[813]: info: ControllerMpd::pushState Apr 20 14:19:49 volumiokk volumio[813]: info: CoreCommandRouter::servicePushState Apr 20 14:19:49 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:49 volumiokk volumio[813]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":243,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Toxic","artist":"CALLmeKAT","album":"Fall Down","uri":"NAS/229/DMU2/合辑/合辑A/Toxic - CALLmeKAT.mp3","trackType":"mp3"} Apr 20 14:19:49 volumiokk volumio[813]: verbose: CURRENT POSITION 174 Apr 20 14:19:49 volumiokk volumio[813]: info: CoreStateMachine::syncState stateService play Apr 20 14:19:49 volumiokk volumio[813]: info: CoreStateMachine::syncState currentStatus play Apr 20 14:19:49 volumiokk volumio[813]: info: Received an update from plugin. extracting info from payload Apr 20 14:19:49 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:19:49 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:49 volumiokk volumio[813]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 14:19:49 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:19:49 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:19:49 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:49 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:19:49 volumiokk volumio[813]: info: ------------------------------ 186ms Apr 20 14:19:49 volumiokk volumio[813]: info: sendMpdCommand playlistinfo took 170 milliseconds Apr 20 14:19:49 volumiokk volumio[813]: verbose: ControllerMpd::parseTrackInfo Apr 20 14:19:49 volumiokk volumio[813]: info: ControllerMpd::pushState Apr 20 14:19:49 volumiokk volumio[813]: info: CoreCommandRouter::servicePushState Apr 20 14:19:49 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:49 volumiokk volumio[813]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":243,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Toxic","artist":"CALLmeKAT","album":"Fall Down","uri":"NAS/229/DMU2/合辑/合辑A/Toxic - CALLmeKAT.mp3","trackType":"mp3"} Apr 20 14:19:49 volumiokk volumio[813]: verbose: CURRENT POSITION 174 Apr 20 14:19:49 volumiokk volumio[813]: info: CoreStateMachine::syncState stateService play Apr 20 14:19:49 volumiokk volumio[813]: info: CoreStateMachine::syncState currentStatus play Apr 20 14:19:49 volumiokk volumio[813]: info: Received an update from plugin. extracting info from payload Apr 20 14:19:49 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:19:49 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:49 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:19:49 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:19:49 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:19:49 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:19:49 volumiokk volumio[813]: info: ------------------------------ 311ms Apr 20 14:19:49 volumiokk volumio[813]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 20 14:19:49 volumiokk volumio[813]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/CALLmeKAT/Fall%20Down/2f37ed72-e0cc-439f-bca0-531011d1005c.jpg' Apr 20 14:19:55 volumiokk volumio[813]: info: MyVolumio login type: Token Apr 20 14:19:55 volumiokk volumio[813]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 20 14:19:55 volumiokk volumio[813]: info: Retrying Login Due to Network Error Apr 20 14:20:05 volumiokk volumio[813]: info: MyVolumio login type: Token Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::volumioNext Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::next Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::stop Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::stPlaybackTimer Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::updateTrackBlock Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrackBlock Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::serviceStop Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrack 174 Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::serviceStop Apr 20 14:20:14 volumiokk volumio[813]: info: ControllerMpd::stop Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 14:20:14 volumiokk volumio[813]: info: Apr 20 14:20:14 volumiokk volumio[813]: ---------------------------- MPD announces state update: player Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand stop took 66 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: info: ControllerMpd::getState Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand status Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::play index undefined Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::startPlaybackTimer Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::clearAddPlayTracks NAS/229/DMU2/合辑/合辑A/One More Night.mp3 Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::updateTrackBlock Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrackBlock Apr 20 14:20:14 volumiokk volumio[813]: info: Apr 20 14:20:14 volumiokk volumio[813]: ---------------------------- MPD announces state update: player Apr 20 14:20:14 volumiokk volumio[813]: info: ControllerMpd::getState Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand status Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand status took 13 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand stop took 7 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand status took 4 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::parseState Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::parseState Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 14:20:14 volumiokk volumio[813]: info: touch_display: Setting screensaver timeout to 10 seconds. Apr 20 14:20:14 volumiokk volumio[813]: info: Apr 20 14:20:14 volumiokk volumio[813]: ---------------------------- MPD announces system playlist update Apr 20 14:20:14 volumiokk volumio[813]: info: Ignoring MPD Status Update Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand clear took 9 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::parseTrackInfo Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand add "NAS/229/DMU2/合辑/合辑A/One More Night.mp3" Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::parseTrackInfo Apr 20 14:20:14 volumiokk volumio[813]: info: ControllerMpd::pushState Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::servicePushState Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:14 volumiokk volumio[813]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Toxic","artist":"CALLmeKAT","album":"Fall Down","uri":"NAS/229/DMU2/合辑/合辑A/Toxic - CALLmeKAT.mp3","trackType":"mp3"} Apr 20 14:20:14 volumiokk volumio[813]: verbose: CURRENT POSITION 123 Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::syncState stateService stop Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::syncState currentStatus stop Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:20:14 volumiokk volumio[813]: info: No code Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:20:14 volumiokk volumio[813]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 20 14:20:14 volumiokk volumio[813]: info: ------------------------------ 117ms Apr 20 14:20:14 volumiokk volumio[813]: info: ------------------------------ 102ms Apr 20 14:20:14 volumiokk volumio[813]: info: Apr 20 14:20:14 volumiokk volumio[813]: ---------------------------- MPD announces system playlist update Apr 20 14:20:14 volumiokk volumio[813]: info: Ignoring MPD Status Update Apr 20 14:20:14 volumiokk volumio[813]: error: updateQueue error: null Apr 20 14:20:14 volumiokk volumio[813]: info: Apr 20 14:20:14 volumiokk volumio[813]: ---------------------------- MPD announces system playlist update Apr 20 14:20:14 volumiokk volumio[813]: info: Ignoring MPD Status Update Apr 20 14:20:14 volumiokk volumio[813]: info: ------------------------------ 100ms Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand add "NAS/229/DMU2/合辑/合辑A/One More Night.mp3" took 98 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: info: ------------------------------ 14ms Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand play Apr 20 14:20:14 volumiokk volumio[813]: info: Apr 20 14:20:14 volumiokk volumio[813]: ---------------------------- MPD announces system playlist update Apr 20 14:20:14 volumiokk volumio[813]: info: Ignoring MPD Status Update Apr 20 14:20:14 volumiokk volumio[813]: info: Apr 20 14:20:14 volumiokk volumio[813]: ---------------------------- MPD announces state update: player Apr 20 14:20:14 volumiokk volumio[813]: info: ------------------------------ 78ms Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand play took 73 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: info: ------------------------------ 70ms Apr 20 14:20:14 volumiokk volumio[813]: info: ControllerMpd::getState Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand status Apr 20 14:20:14 volumiokk volumio[813]: info: Apr 20 14:20:14 volumiokk volumio[813]: ---------------------------- MPD announces state update: player Apr 20 14:20:14 volumiokk volumio[813]: info: ControllerMpd::getState Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand status Apr 20 14:20:14 volumiokk volumio[813]: info: Apr 20 14:20:14 volumiokk volumio[813]: ---------------------------- MPD announces state update: player Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand status took 194 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: info: ControllerMpd::getState Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand status Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand status took 190 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::parseState Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::parseState Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 14:20:14 volumiokk volumio[813]: info: Apr 20 14:20:14 volumiokk volumio[813]: ---------------------------- MPD announces state update: player Apr 20 14:20:14 volumiokk volumio[813]: info: ControllerMpd::getState Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand status Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand status took 12 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand status took 8 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::parseState Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::parseTrackInfo Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::parseTrackInfo Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::parseState Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 14:20:14 volumiokk volumio[813]: info: ControllerMpd::pushState Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::servicePushState Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:14 volumiokk volumio[813]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":220,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"One More Night.mp3","artist":null,"album":null,"uri":"NAS/229/DMU2/合辑/合辑A/One More Night.mp3","trackType":"mp3"} Apr 20 14:20:14 volumiokk volumio[813]: verbose: CURRENT POSITION 123 Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::syncState stateService play Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::syncState currentStatus stop Apr 20 14:20:14 volumiokk volumio[813]: info: ControllerMpd::pushState Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::servicePushState Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:14 volumiokk volumio[813]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57,"duration":220,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"One More Night.mp3","artist":null,"album":null,"uri":"NAS/229/DMU2/合辑/合辑A/One More Night.mp3","trackType":"mp3"} Apr 20 14:20:14 volumiokk volumio[813]: verbose: CURRENT POSITION 123 Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::syncState stateService play Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::syncState currentStatus play Apr 20 14:20:14 volumiokk volumio[813]: info: Received an update from plugin. extracting info from payload Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:20:14 volumiokk volumio[813]: info: ------------------------------ 281ms Apr 20 14:20:14 volumiokk volumio[813]: info: ------------------------------ 333ms Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand playlistinfo took 125 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: info: sendMpdCommand playlistinfo took 123 milliseconds Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::parseTrackInfo Apr 20 14:20:14 volumiokk volumio[813]: verbose: ControllerMpd::parseTrackInfo Apr 20 14:20:14 volumiokk volumio[813]: info: ControllerMpd::pushState Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::servicePushState Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:14 volumiokk volumio[813]: verbose: STATE SERVICE {"status":"play","position":0,"seek":822,"duration":220,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"One More Night.mp3","artist":null,"album":null,"uri":"NAS/229/DMU2/合辑/合辑A/One More Night.mp3","trackType":"mp3"} Apr 20 14:20:14 volumiokk volumio[813]: verbose: CURRENT POSITION 123 Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::syncState stateService play Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::syncState currentStatus play Apr 20 14:20:14 volumiokk volumio[813]: info: Received an update from plugin. extracting info from payload Apr 20 14:20:14 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:20:14 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:14 volumiokk volumio[813]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 14:20:15 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:20:15 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:20:15 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:15 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:20:15 volumiokk volumio[813]: info: ControllerMpd::pushState Apr 20 14:20:15 volumiokk volumio[813]: info: CoreCommandRouter::servicePushState Apr 20 14:20:15 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:15 volumiokk volumio[813]: verbose: STATE SERVICE {"status":"play","position":0,"seek":822,"duration":220,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"One More Night.mp3","artist":null,"album":null,"uri":"NAS/229/DMU2/合辑/合辑A/One More Night.mp3","trackType":"mp3"} Apr 20 14:20:15 volumiokk volumio[813]: verbose: CURRENT POSITION 123 Apr 20 14:20:15 volumiokk volumio[813]: info: CoreStateMachine::syncState stateService play Apr 20 14:20:15 volumiokk volumio[813]: info: CoreStateMachine::syncState currentStatus play Apr 20 14:20:15 volumiokk volumio[813]: info: Received an update from plugin. extracting info from payload Apr 20 14:20:15 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:20:15 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:15 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:20:15 volumiokk volumio[813]: info: CoreStateMachine::pushState Apr 20 14:20:15 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:15 volumiokk volumio[813]: info: CoreCommandRouter::volumioPushState Apr 20 14:20:15 volumiokk volumio[813]: info: ------------------------------ 400ms Apr 20 14:20:15 volumiokk volumio[813]: info: ------------------------------ 393ms Apr 20 14:20:15 volumiokk volumio[813]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 20 14:20:21 volumiokk volumio[813]: info: CoreCommandRouter::volumioGetState Apr 20 14:20:21 volumiokk volumio[813]: info: CorePlayQueue::getTrack 123 Apr 20 14:20:25 volumiokk volumio[813]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 20 14:20:25 volumiokk volumio[813]: info: Retrying Login Due to Network Error Apr 20 14:20:35 volumiokk volumio[813]: info: MyVolumio login type: Token Apr 20 14:20:35 volumiokk volumio[813]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 20 14:20:35 volumiokk volumio[813]: info: Retrying Login Due to Network Error Apr 20 14:20:35 volumiokk volumio[813]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 20 14:20:35 volumiokk volumio[813]: info: Retrying Login Due to Network Error Apr 20 14:20:45 volumiokk volumio[813]: info: MyVolumio login type: Token Apr 20 14:20:45 volumiokk volumio[813]: info: MyVolumio login type: Token Apr 20 14:20:46 volumiokk volumio[813]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 20 14:20:46 volumiokk volumio[813]: info: Retrying Login Due to Network Error Apr 20 14:20:53 volumiokk volumio[813]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 14:20:53 volumiokk volumio[813]: Error: connect ETIMEDOUT 108.160.162.109:443 Apr 20 14:20:53 volumiokk volumio[813]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Apr 20 14:20:53 volumiokk volumio[813]: errno: -110, Apr 20 14:20:53 volumiokk volumio[813]: code: 'ETIMEDOUT', Apr 20 14:20:53 volumiokk volumio[813]: syscall: 'connect', Apr 20 14:20:53 volumiokk volumio[813]: address: '108.160.162.109', Apr 20 14:20:53 volumiokk volumio[813]: port: 443 Apr 20 14:20:53 volumiokk volumio[813]: } Apr 20 14:20:53 volumiokk volumio[813]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 14:20:54 volumiokk sudo[1893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-20 14:19 Apr 20 14:20:54 volumiokk sudo[1893]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"