-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Sun 2026-01-25 19:37:50 CST. -- Jan 25 19:36:02 volumio-rpi volumio[972]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Xeuphoria/For%20When%20You%20Are%20Alone/1f8a8ee4-5d49-4a1a-898f-ae9dff8271ae.jpg' Jan 25 19:36:06 volumio-rpi volumio[972]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E4%B8%AD%E5%B3%B6%E3%83%8E%E3%83%96%E3%83%A6%E3%82%AD/%E4%BA%BA%E9%96%93%E5%A4%B1%E6%A0%BC/ba136c1c-48ac-418c-9601-86d1881fb73f.jpg' Jan 25 19:36:06 volumio-rpi volumio[972]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%BA%E7%BE%BD%E8%89%AF%E5%BD%B0/%E5%87%AA%E3%81%AE%E3%81%82%E3%81%99%E3%81%8B%E3%82%89%20ORIGINAL%20SOUNDTRACK%201/7d1962f4-82d5-4551-a8db-c0cc3d2aa3a6.jpg' Jan 25 19:36:06 volumio-rpi volumio[972]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%90%89%E6%A3%AE%E4%BF%A1/%E5%A4%8F%E7%9B%AE%E5%8F%8B%E4%BA%BA%E5%B8%B3%20%E5%8F%82%C2%B7%E8%82%86%20%E9%9F%B3%E6%A5%BD%E9%9B%86%20%E3%81%B2%E3%81%AD%E3%82%82%E3%81%99%E3%81%8D%E3%82%89%E3%82%8A%E3%81%8D%E3%82%89%E3%82%8A/be57e8d1-b7db-4297-a65b-ae4690b8b471.jpg' Jan 25 19:36:06 volumio-rpi volumio[972]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%90%89%E7%94%B0%E6%BD%94/%E5%92%8C%E5%B9%B3%E4%B9%8B%E6%9C%88%C2%B7%E6%97%A5%E6%9C%AC%E4%BA%BA%E7%9A%84%E9%81%A5%E8%BF%9C%E6%97%85%E9%80%94/c80265a7-f207-449c-80aa-8b2a6dda09d8.jpg' Jan 25 19:36:07 volumio-rpi volumio[972]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%8A%BC%E5%B0%BE%E3%82%B3%E3%83%BC%E3%82%BF%E3%83%AD%E3%83%BC/Blue%20Sky%20-Kotaro%20Oshio%20Best%20Album-/15a7e7ee-8082-406b-a825-c83baf4ac653.jpg' Jan 25 19:36:07 volumio-rpi volumio[972]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%97%A5%E6%9C%ACACG/850fe034-c72b-4243-9170-f7784fcfd63e.jpg' Jan 25 19:36:07 volumio-rpi volumio[972]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E6%B5%B7/%E9%99%88%E6%83%85%E4%BB%A4%20%E5%8E%9F%E5%A3%B0%E9%9F%B3%E4%B9%90%E4%B8%93%E8%BE%91/4606e5b4-c27f-4302-b962-b4bacfc3a0c2.jpg' Jan 25 19:36:09 volumio-rpi volumio[972]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jan 25 19:36:09 volumio-rpi volumio[972]: info: Retrying Login Due to Network Error Jan 25 19:36:10 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 25 19:36:10 volumio-rpi volumio[972]: info: CURURI: music-library Jan 25 19:36:10 volumio-rpi volumio[972]: info: Preload queue cleared Jan 25 19:36:13 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 25 19:36:13 volumio-rpi volumio[972]: info: CURURI: music-library/NAS Jan 25 19:36:13 volumio-rpi volumio[972]: info: Preload queue cleared Jan 25 19:36:15 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 25 19:36:15 volumio-rpi volumio[972]: info: CURURI: music-library/INTERNAL Jan 25 19:36:15 volumio-rpi volumio[972]: info: Preload queue cleared Jan 25 19:36:16 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 25 19:36:16 volumio-rpi volumio[972]: info: CURURI: music-library/INTERNAL/musics Jan 25 19:36:16 volumio-rpi volumio[972]: info: Preload queue cleared Jan 25 19:36:19 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 25 19:36:19 volumio-rpi volumio[972]: info: CURURI: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45 Jan 25 19:36:19 volumio-rpi volumio[972]: info: Preload queue cleared Jan 25 19:36:19 volumio-rpi volumio[972]: info: Preloading song: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/01.倩女幽魂.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Preloading song: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/02.拒绝再玩.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Preloading song: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/03.风再起时.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Preloading song: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/04.风继续吹.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Preloading song: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/05.共同渡过.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Preloading song: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/06.侧面.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Preloading song: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/07.奔向未来的日子.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Preloading song: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/08.沉默是金.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Preloading song: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/09.童年时.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Preloading song: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/10.无心睡眠.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Preloading song: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/11.但愿人长久.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Preloading song: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/12.爱的凶手.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Preloading song: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/13.当年情.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Preloading song: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/14.想你.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Exploding uri music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/01.倩女幽魂.wav in service mpd Jan 25 19:36:19 volumio-rpi volumio[972]: info: ALBUMART /albumart?cacheid=733&web=//medium&path=%2Fmnt%2FINTERNAL%2Fmusics%2F%E5%BC%A0%E5%9B%BD%E8%8D%A3%E3%80%8A%E9%A3%8E%E5%86%8D%E8%B5%B7%E6%97%B6%E3%80%8BLPCD45%2F01.%E5%80%A9%E5%A5%B3%E5%B9%BD%E9%AD%82.wav&metadata=false Jan 25 19:36:19 volumio-rpi volumio[972]: info: URI /mnt/INTERNAL/musics/张国荣《风再起时》LPCD45/01.倩女幽魂.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: MyVolumio login type: Token Jan 25 19:36:19 volumio-rpi volumio[972]: info: Exploding uri music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/02.拒绝再玩.wav in service mpd Jan 25 19:36:19 volumio-rpi volumio[972]: info: ALBUMART /albumart?cacheid=733&web=//medium&path=%2Fmnt%2FINTERNAL%2Fmusics%2F%E5%BC%A0%E5%9B%BD%E8%8D%A3%E3%80%8A%E9%A3%8E%E5%86%8D%E8%B5%B7%E6%97%B6%E3%80%8BLPCD45%2F02.%E6%8B%92%E7%BB%9D%E5%86%8D%E7%8E%A9.wav&metadata=false Jan 25 19:36:19 volumio-rpi volumio[972]: info: URI /mnt/INTERNAL/musics/张国荣《风再起时》LPCD45/02.拒绝再玩.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Exploding uri music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/03.风再起时.wav in service mpd Jan 25 19:36:19 volumio-rpi volumio[972]: info: ALBUMART /albumart?cacheid=733&web=//medium&path=%2Fmnt%2FINTERNAL%2Fmusics%2F%E5%BC%A0%E5%9B%BD%E8%8D%A3%E3%80%8A%E9%A3%8E%E5%86%8D%E8%B5%B7%E6%97%B6%E3%80%8BLPCD45%2F03.%E9%A3%8E%E5%86%8D%E8%B5%B7%E6%97%B6.wav&metadata=false Jan 25 19:36:19 volumio-rpi volumio[972]: info: URI /mnt/INTERNAL/musics/张国荣《风再起时》LPCD45/03.风再起时.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Exploding uri music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/04.风继续吹.wav in service mpd Jan 25 19:36:19 volumio-rpi volumio[972]: info: ALBUMART /albumart?cacheid=733&web=//medium&path=%2Fmnt%2FINTERNAL%2Fmusics%2F%E5%BC%A0%E5%9B%BD%E8%8D%A3%E3%80%8A%E9%A3%8E%E5%86%8D%E8%B5%B7%E6%97%B6%E3%80%8BLPCD45%2F04.%E9%A3%8E%E7%BB%A7%E7%BB%AD%E5%90%B9.wav&metadata=false Jan 25 19:36:19 volumio-rpi volumio[972]: info: URI /mnt/INTERNAL/musics/张国荣《风再起时》LPCD45/04.风继续吹.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Exploding uri music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/05.共同渡过.wav in service mpd Jan 25 19:36:19 volumio-rpi volumio[972]: info: ALBUMART /albumart?cacheid=733&web=//medium&path=%2Fmnt%2FINTERNAL%2Fmusics%2F%E5%BC%A0%E5%9B%BD%E8%8D%A3%E3%80%8A%E9%A3%8E%E5%86%8D%E8%B5%B7%E6%97%B6%E3%80%8BLPCD45%2F05.%E5%85%B1%E5%90%8C%E6%B8%A1%E8%BF%87.wav&metadata=false Jan 25 19:36:19 volumio-rpi volumio[972]: info: URI /mnt/INTERNAL/musics/张国荣《风再起时》LPCD45/05.共同渡过.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Exploding uri music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/06.侧面.wav in service mpd Jan 25 19:36:19 volumio-rpi volumio[972]: info: ALBUMART /albumart?cacheid=733&web=//medium&path=%2Fmnt%2FINTERNAL%2Fmusics%2F%E5%BC%A0%E5%9B%BD%E8%8D%A3%E3%80%8A%E9%A3%8E%E5%86%8D%E8%B5%B7%E6%97%B6%E3%80%8BLPCD45%2F06.%E4%BE%A7%E9%9D%A2.wav&metadata=false Jan 25 19:36:19 volumio-rpi volumio[972]: info: URI /mnt/INTERNAL/musics/张国荣《风再起时》LPCD45/06.侧面.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Exploding uri music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/07.奔向未来的日子.wav in service mpd Jan 25 19:36:19 volumio-rpi volumio[972]: info: ALBUMART /albumart?cacheid=733&web=//medium&path=%2Fmnt%2FINTERNAL%2Fmusics%2F%E5%BC%A0%E5%9B%BD%E8%8D%A3%E3%80%8A%E9%A3%8E%E5%86%8D%E8%B5%B7%E6%97%B6%E3%80%8BLPCD45%2F07.%E5%A5%94%E5%90%91%E6%9C%AA%E6%9D%A5%E7%9A%84%E6%97%A5%E5%AD%90.wav&metadata=false Jan 25 19:36:19 volumio-rpi volumio[972]: info: URI /mnt/INTERNAL/musics/张国荣《风再起时》LPCD45/07.奔向未来的日子.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Exploding uri music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/08.沉默是金.wav in service mpd Jan 25 19:36:19 volumio-rpi volumio[972]: info: ALBUMART /albumart?cacheid=733&web=//medium&path=%2Fmnt%2FINTERNAL%2Fmusics%2F%E5%BC%A0%E5%9B%BD%E8%8D%A3%E3%80%8A%E9%A3%8E%E5%86%8D%E8%B5%B7%E6%97%B6%E3%80%8BLPCD45%2F08.%E6%B2%89%E9%BB%98%E6%98%AF%E9%87%91.wav&metadata=false Jan 25 19:36:19 volumio-rpi volumio[972]: info: URI /mnt/INTERNAL/musics/张国荣《风再起时》LPCD45/08.沉默是金.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Exploding uri music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/09.童年时.wav in service mpd Jan 25 19:36:19 volumio-rpi volumio[972]: info: ALBUMART /albumart?cacheid=733&web=//medium&path=%2Fmnt%2FINTERNAL%2Fmusics%2F%E5%BC%A0%E5%9B%BD%E8%8D%A3%E3%80%8A%E9%A3%8E%E5%86%8D%E8%B5%B7%E6%97%B6%E3%80%8BLPCD45%2F09.%E7%AB%A5%E5%B9%B4%E6%97%B6.wav&metadata=false Jan 25 19:36:19 volumio-rpi volumio[972]: info: URI /mnt/INTERNAL/musics/张国荣《风再起时》LPCD45/09.童年时.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Exploding uri music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/10.无心睡眠.wav in service mpd Jan 25 19:36:19 volumio-rpi volumio[972]: info: ALBUMART /albumart?cacheid=733&web=//medium&path=%2Fmnt%2FINTERNAL%2Fmusics%2F%E5%BC%A0%E5%9B%BD%E8%8D%A3%E3%80%8A%E9%A3%8E%E5%86%8D%E8%B5%B7%E6%97%B6%E3%80%8BLPCD45%2F10.%E6%97%A0%E5%BF%83%E7%9D%A1%E7%9C%A0.wav&metadata=false Jan 25 19:36:19 volumio-rpi volumio[972]: info: URI /mnt/INTERNAL/musics/张国荣《风再起时》LPCD45/10.无心睡眠.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Exploding uri music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/11.但愿人长久.wav in service mpd Jan 25 19:36:19 volumio-rpi volumio[972]: info: ALBUMART /albumart?cacheid=733&web=//medium&path=%2Fmnt%2FINTERNAL%2Fmusics%2F%E5%BC%A0%E5%9B%BD%E8%8D%A3%E3%80%8A%E9%A3%8E%E5%86%8D%E8%B5%B7%E6%97%B6%E3%80%8BLPCD45%2F11.%E4%BD%86%E6%84%BF%E4%BA%BA%E9%95%BF%E4%B9%85.wav&metadata=false Jan 25 19:36:19 volumio-rpi volumio[972]: info: URI /mnt/INTERNAL/musics/张国荣《风再起时》LPCD45/11.但愿人长久.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Exploding uri music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/12.爱的凶手.wav in service mpd Jan 25 19:36:19 volumio-rpi volumio[972]: info: ALBUMART /albumart?cacheid=733&web=//medium&path=%2Fmnt%2FINTERNAL%2Fmusics%2F%E5%BC%A0%E5%9B%BD%E8%8D%A3%E3%80%8A%E9%A3%8E%E5%86%8D%E8%B5%B7%E6%97%B6%E3%80%8BLPCD45%2F12.%E7%88%B1%E7%9A%84%E5%87%B6%E6%89%8B.wav&metadata=false Jan 25 19:36:19 volumio-rpi volumio[972]: info: URI /mnt/INTERNAL/musics/张国荣《风再起时》LPCD45/12.爱的凶手.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Exploding uri music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/13.当年情.wav in service mpd Jan 25 19:36:19 volumio-rpi volumio[972]: info: ALBUMART /albumart?cacheid=733&web=//medium&path=%2Fmnt%2FINTERNAL%2Fmusics%2F%E5%BC%A0%E5%9B%BD%E8%8D%A3%E3%80%8A%E9%A3%8E%E5%86%8D%E8%B5%B7%E6%97%B6%E3%80%8BLPCD45%2F13.%E5%BD%93%E5%B9%B4%E6%83%85.wav&metadata=false Jan 25 19:36:19 volumio-rpi volumio[972]: info: URI /mnt/INTERNAL/musics/张国荣《风再起时》LPCD45/13.当年情.wav Jan 25 19:36:19 volumio-rpi volumio[972]: info: Exploding uri music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/14.想你.wav in service mpd Jan 25 19:36:19 volumio-rpi volumio[972]: info: ALBUMART /albumart?cacheid=733&web=//medium&path=%2Fmnt%2FINTERNAL%2Fmusics%2F%E5%BC%A0%E5%9B%BD%E8%8D%A3%E3%80%8A%E9%A3%8E%E5%86%8D%E8%B5%B7%E6%97%B6%E3%80%8BLPCD45%2F14.%E6%83%B3%E4%BD%A0.wav&metadata=false Jan 25 19:36:19 volumio-rpi volumio[972]: info: URI /mnt/INTERNAL/musics/张国荣《风再起时》LPCD45/14.想你.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Preload queue cleared Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::ClearQueue Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::stop Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::stPlaybackTimer Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::updateTrackBlock Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrackBlock Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 83 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::serviceStop Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 83 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::serviceStop Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::stop Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand stop Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::clearPlayQueue Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::saveQueue Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushQueue Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::addQueueItems Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::addQueueItems Jan 25 19:36:22 volumio-rpi volumio[972]: info: Preload queue cleared Jan 25 19:36:22 volumio-rpi volumio[972]: info: Adding Item to queue: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/01.倩女幽魂.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Using cached record of: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/01.倩女幽魂.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Adding Item to queue: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/02.拒绝再玩.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Using cached record of: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/02.拒绝再玩.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Adding Item to queue: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/03.风再起时.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Using cached record of: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/03.风再起时.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Adding Item to queue: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/04.风继续吹.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Using cached record of: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/04.风继续吹.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Adding Item to queue: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/05.共同渡过.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Using cached record of: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/05.共同渡过.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Adding Item to queue: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/06.侧面.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Using cached record of: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/06.侧面.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Adding Item to queue: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/07.奔向未来的日子.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Using cached record of: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/07.奔向未来的日子.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Adding Item to queue: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/08.沉默是金.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Using cached record of: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/08.沉默是金.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Adding Item to queue: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/09.童年时.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Using cached record of: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/09.童年时.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Adding Item to queue: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/10.无心睡眠.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Using cached record of: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/10.无心睡眠.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Adding Item to queue: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/11.但愿人长久.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Using cached record of: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/11.但愿人长久.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Adding Item to queue: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/12.爱的凶手.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Using cached record of: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/12.爱的凶手.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Adding Item to queue: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/13.当年情.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Using cached record of: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/13.当年情.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Adding Item to queue: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/14.想你.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: Using cached record of: music-library/INTERNAL/musics/张国荣《风再起时》LPCD45/14.想你.wav Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushQueue Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::saveQueue Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::updateTrackBlock Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrackBlock Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPlay Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::play index 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::stop Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::play index undefined Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::startPlaybackTimer Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/musics/张国荣《风再起时》LPCD45/14.想你.wav Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand stop Jan 25 19:36:22 volumio-rpi volumio[972]: info: Jan 25 19:36:22 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand stop took 50 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand stop took 7 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand clear Jan 25 19:36:22 volumio-rpi volumio[972]: info: Jan 25 19:36:22 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:36:22 volumio-rpi volumio[972]: info: Jan 25 19:36:22 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:36:22 volumio-rpi volumio[972]: info: Jan 25 19:36:22 volumio-rpi volumio[972]: ---------------------------- MPD announces system playlist update Jan 25 19:36:22 volumio-rpi volumio[972]: info: Ignoring MPD Status Update Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand status took 10 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand clear took 10 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand status took 9 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand status took 8 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/musics/张国荣《风再起时》LPCD45/14.想你.wav" Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::servicePushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: CURRENT POSITION 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState stateService stop Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: No code Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::servicePushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: CURRENT POSITION 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState stateService stop Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: No code Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: ------------------------------ 73ms Jan 25 19:36:22 volumio-rpi volumio[972]: info: ------------------------------ 71ms Jan 25 19:36:22 volumio-rpi volumio[972]: info: Jan 25 19:36:22 volumio-rpi volumio[972]: ---------------------------- MPD announces system playlist update Jan 25 19:36:22 volumio-rpi volumio[972]: info: Ignoring MPD Status Update Jan 25 19:36:22 volumio-rpi volumio[972]: info: Jan 25 19:36:22 volumio-rpi volumio[972]: ---------------------------- MPD announces system playlist update Jan 25 19:36:22 volumio-rpi volumio[972]: info: Ignoring MPD Status Update Jan 25 19:36:22 volumio-rpi volumio[972]: error: updateQueue error: null Jan 25 19:36:22 volumio-rpi volumio[972]: info: Jan 25 19:36:22 volumio-rpi volumio[972]: ---------------------------- MPD announces system playlist update Jan 25 19:36:22 volumio-rpi volumio[972]: info: Ignoring MPD Status Update Jan 25 19:36:22 volumio-rpi volumio[972]: info: ------------------------------ 101ms Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 95 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand add "INTERNAL/musics/张国荣《风再起时》LPCD45/14.想你.wav" took 95 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: ------------------------------ 35ms Jan 25 19:36:22 volumio-rpi volumio[972]: info: ------------------------------ 33ms Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand play Jan 25 19:36:22 volumio-rpi volumio[972]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 25 19:36:22 volumio-rpi volumio[972]: info: ------------------------------ 117ms Jan 25 19:36:22 volumio-rpi volumio[972]: info: Jan 25 19:36:22 volumio-rpi volumio[972]: ---------------------------- MPD announces system playlist update Jan 25 19:36:22 volumio-rpi volumio[972]: info: Ignoring MPD Status Update Jan 25 19:36:22 volumio-rpi volumio[972]: info: Jan 25 19:36:22 volumio-rpi volumio[972]: ---------------------------- MPD announces system playlist update Jan 25 19:36:22 volumio-rpi volumio[972]: info: Ignoring MPD Status Update Jan 25 19:36:22 volumio-rpi volumio[972]: info: Jan 25 19:36:22 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:36:22 volumio-rpi volumio[972]: info: ------------------------------ 21ms Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand play took 16 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: ------------------------------ 14ms Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:36:22 volumio-rpi volumio[972]: info: ------------------------------ 12ms Jan 25 19:36:22 volumio-rpi volumio[972]: info: Jan 25 19:36:22 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:36:22 volumio-rpi volumio[972]: info: Jan 25 19:36:22 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:36:22 volumio-rpi volumio[972]: info: touch_display: Setting screensaver timeout to 60 seconds. Jan 25 19:36:22 volumio-rpi volumio[972]: info: Jan 25 19:36:22 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand status took 9 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand status took 8 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand status took 8 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:36:22 volumio-rpi volumio[972]: info: Jan 25 19:36:22 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:36:22 volumio-rpi volumio[972]: info: Jan 25 19:36:22 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand status took 8 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand status took 4 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand status took 3 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::servicePushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"14.想你.wav","artist":null,"album":null,"uri":"INTERNAL/musics/张国荣《风再起时》LPCD45/14.想你.wav","trackType":"wav"} Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: CURRENT POSITION 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState stateService play Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::servicePushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"14.想你.wav","artist":null,"album":null,"uri":"INTERNAL/musics/张国荣《风再起时》LPCD45/14.想你.wav","trackType":"wav"} Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: CURRENT POSITION 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState stateService play Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState currentStatus play Jan 25 19:36:22 volumio-rpi volumio[972]: info: Received an update from plugin. extracting info from payload Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::servicePushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"14.想你.wav","artist":null,"album":null,"uri":"INTERNAL/musics/张国荣《风再起时》LPCD45/14.想你.wav","trackType":"wav"} Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: CURRENT POSITION 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState stateService play Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState currentStatus play Jan 25 19:36:22 volumio-rpi volumio[972]: info: Received an update from plugin. extracting info from payload Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: ------------------------------ 39ms Jan 25 19:36:22 volumio-rpi volumio[972]: info: ------------------------------ 65ms Jan 25 19:36:22 volumio-rpi volumio[972]: info: ------------------------------ 65ms Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 48 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 48 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 47 milliseconds Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::servicePushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"14.想你.wav","artist":null,"album":null,"uri":"INTERNAL/musics/张国荣《风再起时》LPCD45/14.想你.wav","trackType":"wav"} Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: CURRENT POSITION 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState stateService play Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState currentStatus play Jan 25 19:36:22 volumio-rpi volumio[972]: info: Received an update from plugin. extracting info from payload Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::servicePushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"14.想你.wav","artist":null,"album":null,"uri":"INTERNAL/musics/张国荣《风再起时》LPCD45/14.想你.wav","trackType":"wav"} Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: CURRENT POSITION 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState stateService play Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState currentStatus play Jan 25 19:36:22 volumio-rpi volumio[972]: info: Received an update from plugin. extracting info from payload Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: ControllerMpd::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::servicePushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"14.想你.wav","artist":null,"album":null,"uri":"INTERNAL/musics/张国荣《风再起时》LPCD45/14.想你.wav","trackType":"wav"} Jan 25 19:36:22 volumio-rpi volumio[972]: verbose: CURRENT POSITION 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState stateService play Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::syncState currentStatus play Jan 25 19:36:22 volumio-rpi volumio[972]: info: Received an update from plugin. extracting info from payload Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:22 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:22 volumio-rpi volumio[972]: info: ------------------------------ 126ms Jan 25 19:36:22 volumio-rpi volumio[972]: info: ------------------------------ 122ms Jan 25 19:36:22 volumio-rpi volumio[972]: info: ------------------------------ 120ms Jan 25 19:36:22 volumio-rpi volumio[972]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 25 19:36:30 volumio-rpi thd[596]: Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:30 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:30 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:30 volumio-rpi volumio[972]: info: Jan 25 19:36:30 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:30 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:30 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:30 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:30 volumio-rpi thd[596]: {"time":1769340990234,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:30 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:30 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:30 volumio-rpi volumio[972]: info: Jan 25 19:36:30 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:30 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:30 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:30 volumio-rpi thd[596]: [139B blob data] Jan 25 19:36:30 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:30 volumio-rpi thd[596]: {"time":1769340990316,"response":"volume Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:30 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:30 volumio-rpi thd[596]: [139B blob data] Jan 25 19:36:30 volumio-rpi volumio[972]: info: Jan 25 19:36:30 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:30 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:30 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:30 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:30 volumio-rpi thd[596]: {"time":1769340990404,"response":"volume Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:30 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:30 volumio-rpi volumio[972]: info: Jan 25 19:36:30 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:30 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:30 volumio-rpi thd[596]: [139B blob data] Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:30 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:30 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:30 volumio-rpi thd[596]: {"time":1769340990465,"response":"volume Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:30 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:30 volumio-rpi volumio[972]: info: Jan 25 19:36:30 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:30 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:30 volumio-rpi thd[596]: [139B blob data] Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:30 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:30 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:30 volumio-rpi thd[596]: {"time":1769340990521,"response":"volume Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:30 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:30 volumio-rpi volumio[972]: info: Jan 25 19:36:30 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:30 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:30 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:30 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:30 volumio-rpi thd[596]: {"time":1769340990582,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:30 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:30 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:30 volumio-rpi volumio[972]: info: Jan 25 19:36:30 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:30 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:30 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:30 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:30 volumio-rpi thd[596]: {"time":1769340990663,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:30 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:30 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:30 volumio-rpi volumio[972]: info: Jan 25 19:36:30 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:30 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:30 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:30 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:30 volumio-rpi thd[596]: {"time":1769340990737,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:30 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:30 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:30 volumio-rpi volumio[972]: info: Jan 25 19:36:30 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:30 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:30 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:30 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:30 volumio-rpi thd[596]: {"time":1769340990813,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:30 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:30 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:30 volumio-rpi volumio[972]: info: Jan 25 19:36:30 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:30 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:30 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:30 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:30 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:30 volumio-rpi thd[596]: {"time":1769340990921,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:30 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:30 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:30 volumio-rpi volumio[972]: info: Jan 25 19:36:30 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:30 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi thd[596]: [139B blob data] Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340990994,"response":"volume Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi thd[596]: [139B blob data] Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340991064,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:31 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340991123,"response":"volume Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi thd[596]: [139B blob data] Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340991167,"response":"volume Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi thd[596]: [139B blob data] Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340991229,"response":"volume Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi thd[596]: [139B blob data] Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340991291,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:31 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [139B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340991351,"response":"volume Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [139B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340991396,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340991451,"response":"volume Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340991501,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340991542,"response":"volume Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi thd[596]: [139B blob data] Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi thd[596]: [93B blob data] Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [125B blob data] Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340991602,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:31 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [139B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340991666,"response":"volume Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi thd[596]: [139B blob data] Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340991740,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:31 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340991805,"response":"volume Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi thd[596]: [139B blob data] Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: {"time":1769340991859,"response":"volume Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:31 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:31 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [129B blob data] Jan 25 19:36:31 volumio-rpi volumio[972]: info: Jan 25 19:36:31 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:31 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:31 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:31 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:31 volumio-rpi thd[596]: [129B blob data] Jan 25 19:36:33 volumio-rpi thd[596]: {"time":1769340991974,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Jan 25 19:36:33 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:33 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:33 volumio-rpi volumio[972]: info: Jan 25 19:36:33 volumio-rpi volumio[972]: ---------------------------- Client requests Volume - Jan 25 19:36:33 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume- Jan 25 19:36:33 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:33 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:33 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:33 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:33 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:33 volumio-rpi thd[596]: {"time":1769340993368,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Jan 25 19:36:33 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:33 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:33 volumio-rpi volumio[972]: info: Jan 25 19:36:33 volumio-rpi volumio[972]: ---------------------------- Client requests Volume - Jan 25 19:36:33 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume- Jan 25 19:36:33 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:33 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:33 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:33 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:33 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:33 volumio-rpi thd[596]: {"time":1769340993598,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Jan 25 19:36:33 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:33 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:33 volumio-rpi volumio[972]: info: Jan 25 19:36:33 volumio-rpi volumio[972]: ---------------------------- Client requests Volume - Jan 25 19:36:33 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume- Jan 25 19:36:33 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:33 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:33 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:33 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:33 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:35 volumio-rpi thd[596]: {"time":1769340993691,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Jan 25 19:36:35 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:35 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:35 volumio-rpi volumio[972]: info: Jan 25 19:36:35 volumio-rpi volumio[972]: ---------------------------- Client requests Volume - Jan 25 19:36:35 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume- Jan 25 19:36:35 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:35 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:35 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:35 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:35 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:35 volumio-rpi thd[596]: {"time":1769340995057,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Jan 25 19:36:35 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:35 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:35 volumio-rpi volumio[972]: info: Jan 25 19:36:35 volumio-rpi volumio[972]: ---------------------------- Client requests Volume - Jan 25 19:36:35 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume- Jan 25 19:36:35 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:35 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:35 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:35 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:35 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:35 volumio-rpi thd[596]: {"time":1769340995183,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Jan 25 19:36:35 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:35 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:35 volumio-rpi volumio[972]: info: Jan 25 19:36:35 volumio-rpi volumio[972]: ---------------------------- Client requests Volume - Jan 25 19:36:35 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume- Jan 25 19:36:35 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:35 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:35 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:35 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:35 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:35 volumio-rpi thd[596]: {"time":1769340995646,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Jan 25 19:36:35 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:35 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:35 volumio-rpi volumio[972]: info: Jan 25 19:36:35 volumio-rpi volumio[972]: ---------------------------- Client requests Volume - Jan 25 19:36:35 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume- Jan 25 19:36:35 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:35 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:35 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:35 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:35 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:36 volumio-rpi thd[596]: {"time":1769340995727,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Jan 25 19:36:36 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:36 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:36 volumio-rpi thd[596]: [140B blob data] Jan 25 19:36:36 volumio-rpi volumio[972]: info: Jan 25 19:36:36 volumio-rpi volumio[972]: ---------------------------- Client requests Volume - Jan 25 19:36:36 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume- Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:36 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:36 volumio-rpi thd[596]: [79B blob data] Jan 25 19:36:36 volumio-rpi thd[596]: {"time":1769340996092,"response":"volume Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:36 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:36 volumio-rpi volumio[972]: info: Jan 25 19:36:36 volumio-rpi volumio[972]: ---------------------------- Client requests Volume - Jan 25 19:36:36 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume- Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:36 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:36 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:36 volumio-rpi thd[596]: {"time":1769340996141,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:36 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:36 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:36 volumio-rpi volumio[972]: info: Jan 25 19:36:36 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:36 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:36 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:36 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:36 volumio-rpi thd[596]: {"time":1769340996596,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:36 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:36 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:36 volumio-rpi volumio[972]: info: Jan 25 19:36:36 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:36 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:36 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:36 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:36 volumio-rpi thd[596]: {"time":1769340996666,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:36 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:36 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:36 volumio-rpi volumio[972]: info: Jan 25 19:36:36 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:36 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:36 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:36 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:36 volumio-rpi thd[596]: {"time":1769340996769,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:36 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:36 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:36 volumio-rpi volumio[972]: info: Jan 25 19:36:36 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:36 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:36 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:36 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:36 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:37 volumio-rpi thd[596]: {"time":1769340996882,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:37 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:37 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:37 volumio-rpi volumio[972]: info: Jan 25 19:36:37 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:37 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:37 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:37 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:37 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:37 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:37 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:37 volumio-rpi thd[596]: {"time":1769340997049,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:37 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:37 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:37 volumio-rpi volumio[972]: info: Jan 25 19:36:37 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:37 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:37 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:37 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:37 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:37 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:37 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:37 volumio-rpi thd[596]: {"time":1769340997209,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Jan 25 19:36:37 volumio-rpi thd[596]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 25 19:36:37 volumio-rpi thd[596]: Dload Upload Total Spent Left Speed Jan 25 19:36:37 volumio-rpi volumio[972]: info: Jan 25 19:36:37 volumio-rpi volumio[972]: ---------------------------- Client requests Volume + Jan 25 19:36:37 volumio-rpi volumio[972]: info: VolumeController::SetAlsaVolume+ Jan 25 19:36:37 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:36:37 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:36:37 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:36:37 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:36:37 volumio-rpi thd[596]: [158B blob data] Jan 25 19:36:49 volumio-rpi volumio[972]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jan 25 19:36:49 volumio-rpi volumio[972]: info: Retrying Login Due to Network Error Jan 25 19:36:59 volumio-rpi volumio[972]: info: MyVolumio login type: Token Jan 25 19:37:29 volumio-rpi volumio[972]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jan 25 19:37:29 volumio-rpi volumio[972]: info: Retrying Login Due to Network Error Jan 25 19:37:39 volumio-rpi volumio[972]: info: MyVolumio login type: Token Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioNext Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::next Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::stop Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::stPlaybackTimer Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::updateTrackBlock Jan 25 19:37:48 volumio-rpi volumio[972]: info: CorePlayQueue::getTrackBlock Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::serviceStop Jan 25 19:37:48 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 13 Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreCommandRouter::serviceStop Jan 25 19:37:48 volumio-rpi volumio[972]: info: ControllerMpd::stop Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand stop Jan 25 19:37:48 volumio-rpi volumio[972]: info: Jan 25 19:37:48 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand stop took 36 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::play index undefined Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 19:37:48 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::startPlaybackTimer Jan 25 19:37:48 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/musics/张国荣《风再起时》LPCD45/02.拒绝再玩.wav Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand stop Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::updateTrackBlock Jan 25 19:37:48 volumio-rpi volumio[972]: info: CorePlayQueue::getTrackBlock Jan 25 19:37:48 volumio-rpi volumio[972]: info: Jan 25 19:37:48 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:37:48 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:37:48 volumio-rpi volumio[972]: info: Jan 25 19:37:48 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:37:48 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand status took 6 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand stop took 5 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand status took 3 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand status took 2 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand clear Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:37:48 volumio-rpi volumio[972]: info: Jan 25 19:37:48 volumio-rpi volumio[972]: ---------------------------- MPD announces system playlist update Jan 25 19:37:48 volumio-rpi volumio[972]: info: Ignoring MPD Status Update Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand clear took 3 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/musics/张国荣《风再起时》LPCD45/02.拒绝再玩.wav" Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:37:48 volumio-rpi volumio[972]: info: ControllerMpd::pushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreCommandRouter::servicePushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:48 volumio-rpi volumio[972]: 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":"14.想你.wav","artist":null,"album":null,"uri":"INTERNAL/musics/张国荣《风再起时》LPCD45/14.想你.wav","trackType":"wav"} Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: CURRENT POSITION 1 Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::syncState stateService stop Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: No code Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:37:48 volumio-rpi volumio[972]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 25 19:37:48 volumio-rpi volumio[972]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 25 19:37:48 volumio-rpi volumio[972]: info: ------------------------------ 40ms Jan 25 19:37:48 volumio-rpi volumio[972]: info: ------------------------------ 35ms Jan 25 19:37:48 volumio-rpi volumio[972]: info: ------------------------------ 34ms Jan 25 19:37:48 volumio-rpi volumio[972]: info: Jan 25 19:37:48 volumio-rpi volumio[972]: ---------------------------- MPD announces system playlist update Jan 25 19:37:48 volumio-rpi volumio[972]: info: Ignoring MPD Status Update Jan 25 19:37:48 volumio-rpi volumio[972]: info: Jan 25 19:37:48 volumio-rpi volumio[972]: ---------------------------- MPD announces system playlist update Jan 25 19:37:48 volumio-rpi volumio[972]: info: Ignoring MPD Status Update Jan 25 19:37:48 volumio-rpi volumio[972]: error: updateQueue error: null Jan 25 19:37:48 volumio-rpi volumio[972]: info: Jan 25 19:37:48 volumio-rpi volumio[972]: ---------------------------- MPD announces system playlist update Jan 25 19:37:48 volumio-rpi volumio[972]: info: Ignoring MPD Status Update Jan 25 19:37:48 volumio-rpi volumio[972]: info: ------------------------------ 35ms Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand add "INTERNAL/musics/张国荣《风再起时》LPCD45/02.拒绝再玩.wav" took 33 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: ------------------------------ 6ms Jan 25 19:37:48 volumio-rpi volumio[972]: info: ------------------------------ 4ms Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand play Jan 25 19:37:48 volumio-rpi volumio[972]: info: Jan 25 19:37:48 volumio-rpi volumio[972]: ---------------------------- MPD announces system playlist update Jan 25 19:37:48 volumio-rpi volumio[972]: info: Ignoring MPD Status Update Jan 25 19:37:48 volumio-rpi volumio[972]: info: Jan 25 19:37:48 volumio-rpi volumio[972]: ---------------------------- MPD announces system playlist update Jan 25 19:37:48 volumio-rpi volumio[972]: info: Ignoring MPD Status Update Jan 25 19:37:48 volumio-rpi volumio[972]: info: touch_display: Setting screensaver timeout to 60 seconds. Jan 25 19:37:48 volumio-rpi volumio[972]: info: Jan 25 19:37:48 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:37:48 volumio-rpi volumio[972]: info: ------------------------------ 16ms Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand play took 14 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:37:48 volumio-rpi volumio[972]: info: ------------------------------ 14ms Jan 25 19:37:48 volumio-rpi volumio[972]: info: ------------------------------ 12ms Jan 25 19:37:48 volumio-rpi volumio[972]: info: Jan 25 19:37:48 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:37:48 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:37:48 volumio-rpi volumio[972]: info: Jan 25 19:37:48 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:37:48 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:37:48 volumio-rpi volumio[972]: info: Jan 25 19:37:48 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand status took 18 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand status took 17 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:37:48 volumio-rpi volumio[972]: info: Jan 25 19:37:48 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:37:48 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:37:48 volumio-rpi volumio[972]: info: Jan 25 19:37:48 volumio-rpi volumio[972]: ---------------------------- MPD announces state update: player Jan 25 19:37:48 volumio-rpi volumio[972]: info: ControllerMpd::getState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand status took 10 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 10 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 8 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand status took 4 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: info: sendMpdCommand status took 3 milliseconds Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::parseState Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 19:37:48 volumio-rpi volumio[972]: info: ControllerMpd::pushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreCommandRouter::servicePushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":216,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.拒绝再玩.wav","artist":null,"album":null,"uri":"INTERNAL/musics/张国荣《风再起时》LPCD45/02.拒绝再玩.wav","trackType":"wav"} Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: CURRENT POSITION 1 Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::syncState stateService play Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jan 25 19:37:48 volumio-rpi volumio[972]: info: ControllerMpd::pushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreCommandRouter::servicePushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":216,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.拒绝再玩.wav","artist":null,"album":null,"uri":"INTERNAL/musics/张国荣《风再起时》LPCD45/02.拒绝再玩.wav","trackType":"wav"} Jan 25 19:37:48 volumio-rpi volumio[972]: verbose: CURRENT POSITION 1 Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::syncState stateService play Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::syncState currentStatus play Jan 25 19:37:48 volumio-rpi volumio[972]: info: Received an update from plugin. extracting info from payload Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:37:48 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:48 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: ControllerMpd::pushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreCommandRouter::servicePushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:49 volumio-rpi volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":216,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.拒绝再玩.wav","artist":null,"album":null,"uri":"INTERNAL/musics/张国荣《风再起时》LPCD45/02.拒绝再玩.wav","trackType":"wav"} Jan 25 19:37:49 volumio-rpi volumio[972]: verbose: CURRENT POSITION 1 Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::syncState stateService play Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::syncState currentStatus play Jan 25 19:37:49 volumio-rpi volumio[972]: info: Received an update from plugin. extracting info from payload Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: ------------------------------ 53ms Jan 25 19:37:49 volumio-rpi volumio[972]: info: ------------------------------ 77ms Jan 25 19:37:49 volumio-rpi volumio[972]: info: ------------------------------ 75ms Jan 25 19:37:49 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 46 milliseconds Jan 25 19:37:49 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 45 milliseconds Jan 25 19:37:49 volumio-rpi volumio[972]: info: sendMpdCommand playlistinfo took 45 milliseconds Jan 25 19:37:49 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:37:49 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:37:49 volumio-rpi volumio[972]: verbose: ControllerMpd::parseTrackInfo Jan 25 19:37:49 volumio-rpi volumio[972]: info: ControllerMpd::pushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreCommandRouter::servicePushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:49 volumio-rpi volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":216,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.拒绝再玩.wav","artist":null,"album":null,"uri":"INTERNAL/musics/张国荣《风再起时》LPCD45/02.拒绝再玩.wav","trackType":"wav"} Jan 25 19:37:49 volumio-rpi volumio[972]: verbose: CURRENT POSITION 1 Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::syncState stateService play Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::syncState currentStatus play Jan 25 19:37:49 volumio-rpi volumio[972]: info: Received an update from plugin. extracting info from payload Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: ControllerMpd::pushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreCommandRouter::servicePushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:49 volumio-rpi volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":216,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.拒绝再玩.wav","artist":null,"album":null,"uri":"INTERNAL/musics/张国荣《风再起时》LPCD45/02.拒绝再玩.wav","trackType":"wav"} Jan 25 19:37:49 volumio-rpi volumio[972]: verbose: CURRENT POSITION 1 Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::syncState stateService play Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::syncState currentStatus play Jan 25 19:37:49 volumio-rpi volumio[972]: info: Received an update from plugin. extracting info from payload Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: ControllerMpd::pushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreCommandRouter::servicePushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:49 volumio-rpi volumio[972]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":216,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.拒绝再玩.wav","artist":null,"album":null,"uri":"INTERNAL/musics/张国荣《风再起时》LPCD45/02.拒绝再玩.wav","trackType":"wav"} Jan 25 19:37:49 volumio-rpi volumio[972]: verbose: CURRENT POSITION 1 Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::syncState stateService play Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::syncState currentStatus play Jan 25 19:37:49 volumio-rpi volumio[972]: info: Received an update from plugin. extracting info from payload Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreStateMachine::pushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: CorePlayQueue::getTrack 1 Jan 25 19:37:49 volumio-rpi volumio[972]: info: CoreCommandRouter::volumioPushState Jan 25 19:37:49 volumio-rpi volumio[972]: info: ------------------------------ 123ms Jan 25 19:37:49 volumio-rpi volumio[972]: info: ------------------------------ 115ms Jan 25 19:37:49 volumio-rpi volumio[972]: info: ------------------------------ 113ms Jan 25 19:37:49 volumio-rpi volumio[972]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 25 19:37:49 volumio-rpi volumio[972]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 19:37:49 volumio-rpi volumio[972]: Error: connect ETIMEDOUT 128.242.240.149:443 Jan 25 19:37:49 volumio-rpi volumio[972]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jan 25 19:37:49 volumio-rpi volumio[972]: errno: -110, Jan 25 19:37:49 volumio-rpi volumio[972]: code: 'ETIMEDOUT', Jan 25 19:37:49 volumio-rpi volumio[972]: syscall: 'connect', Jan 25 19:37:49 volumio-rpi volumio[972]: address: '128.242.240.149', Jan 25 19:37:49 volumio-rpi volumio[972]: port: 443 Jan 25 19:37:49 volumio-rpi volumio[972]: } Jan 25 19:37:49 volumio-rpi volumio[972]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 19:37:50 volumio-rpi sudo[2978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-25 19:36 Jan 25 19:37:50 volumio-rpi sudo[2978]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"