-- Logs begin at Tue 2025-01-14 14:29:10 UTC, end at Tue 2025-01-14 14:35:56 UTC. -- Jan 14 14:34:02 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:34:06 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:34:07 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jan 14 14:34:07 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand rescan Jan 14 14:34:07 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jan 14 14:34:07 volumio volumio[870]: info: Jan 14 14:34:07 volumio volumio[870]: ---------------------------- MPD announces state update: update Jan 14 14:34:07 volumio volumio[870]: info: sendMpdCommand rescan took 3 milliseconds Jan 14 14:34:07 volumio volumio[870]: info: ControllerMpd::getState Jan 14 14:34:07 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jan 14 14:34:07 volumio volumio[870]: info: sendMpdCommand status took 1 milliseconds Jan 14 14:34:07 volumio volumio[870]: info: sendMpdCommand status took 0 milliseconds Jan 14 14:34:07 volumio volumio[870]: verbose: ControllerMpd::parseState Jan 14 14:34:07 volumio volumio[870]: info: Command Router : Notfying DB Updatetrue Jan 14 14:34:07 volumio volumio[870]: verbose: ControllerMpd::parseState Jan 14 14:34:07 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 14 14:34:07 volumio volumio[870]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 14 14:34:07 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jan 14 14:34:07 volumio volumio[870]: info: ControllerMpd::pushState Jan 14 14:34:07 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jan 14 14:34:07 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:34:07 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":19733,"duration":219,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1766 Kbps","isStreaming":false,"title":"陪我轻轻唱","artist":"彭佳慧","album":"我想念我自己","uri":"USB/新加卷/SONY 华语/[Sony] - 彭佳慧 - 我想念我自己 - 24-48/01.陪我轻轻唱.flac","trackType":"flac"} Jan 14 14:34:07 volumio volumio[870]: verbose: CURRENT POSITION 0 Jan 14 14:34:07 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jan 14 14:34:07 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jan 14 14:34:07 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jan 14 14:34:07 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:34:07 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:34:07 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:34:07 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:34:07 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:34:07 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:34:07 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:34:07 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:34:07 volumio volumio[870]: info: ------------------------------ 21ms Jan 14 14:34:10 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:34:11 volumio volumio[870]: info: CoreCommandRouter::Close All Modals sent Jan 14 14:34:14 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jan 14 14:34:15 volumio smbd[2164]: [2025/01/14 14:34:15.862448, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 14:34:15 volumio smbd[2164]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 14:34:15 volumio smbd[2164]: [2025/01/14 14:34:15.863042, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 14:34:15 volumio smbd[2164]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 14:34:15 volumio smbd[2164]: [2025/01/14 14:34:15.863091, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 14:34:15 volumio smbd[2164]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 14:34:15 volumio smbd[2164]: [2025/01/14 14:34:15.866372, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 14:34:15 volumio smbd[2164]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 14:34:17 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:34:18 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:34:22 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:34:25 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 14 14:34:25 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 14 14:34:25 volumio volumio[870]: info: Discovery: Getting this device information Jan 14 14:34:25 volumio volumio[870]: info: CoreCommandRouter::volumioGetState Jan 14 14:34:25 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:34:25 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jan 14 14:34:25 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 14 14:34:25 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 14 14:34:26 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:34:30 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:34:34 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:34:37 volumio nmbd[908]: [2025/01/14 14:34:37.375714, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jan 14 14:34:37 volumio nmbd[908]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.109 for name WORKGROUP<1d>. Jan 14 14:34:37 volumio nmbd[908]: This response was from IP 192.168.0.108, reporting an IP address of 192.168.0.108. Jan 14 14:34:38 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:34:42 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:34:44 volumio volumio[870]: info: MPD Database updated - AlbumList cache refreshed Jan 14 14:34:44 volumio volumio[870]: info: Jan 14 14:34:44 volumio volumio[870]: ---------------------------- MPD announces state update: database Jan 14 14:34:44 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jan 14 14:34:44 volumio volumio[870]: info: Jan 14 14:34:44 volumio volumio[870]: ---------------------------- MPD announces state update: update Jan 14 14:34:44 volumio volumio[870]: info: ControllerMpd::getState Jan 14 14:34:44 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jan 14 14:34:44 volumio volumio[870]: info: ControllerMpd::getState Jan 14 14:34:44 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jan 14 14:34:44 volumio volumio[870]: info: sendMpdCommand status took 156 milliseconds Jan 14 14:34:44 volumio volumio[870]: info: sendMpdCommand status took 156 milliseconds Jan 14 14:34:44 volumio volumio[870]: info: sendMpdCommand status took 156 milliseconds Jan 14 14:34:44 volumio volumio[870]: verbose: ControllerMpd::parseState Jan 14 14:34:44 volumio volumio[870]: info: Command Router : Notfying DB Updatefalse Jan 14 14:34:44 volumio volumio[870]: info: CoreCommandRouter::Close All Modals sent Jan 14 14:34:44 volumio volumio[870]: verbose: ControllerMpd::parseState Jan 14 14:34:44 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 14 14:34:44 volumio volumio[870]: verbose: ControllerMpd::parseState Jan 14 14:34:44 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 14 14:34:44 volumio volumio[870]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 14 14:34:44 volumio volumio[870]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 14 14:34:44 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jan 14 14:34:44 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jan 14 14:34:44 volumio volumio[870]: info: ControllerMpd::pushState Jan 14 14:34:44 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jan 14 14:34:44 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:34:44 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":56607,"duration":219,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1589 Kbps","isStreaming":false,"title":"陪我轻轻唱","artist":"彭佳慧","album":"我想念我自己","uri":"USB/新加卷/SONY 华语/[Sony] - 彭佳慧 - 我想念我自己 - 24-48/01.陪我轻轻唱.flac","trackType":"flac"} Jan 14 14:34:44 volumio volumio[870]: verbose: CURRENT POSITION 0 Jan 14 14:34:44 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jan 14 14:34:44 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jan 14 14:34:44 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jan 14 14:34:44 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:34:44 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:34:44 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:34:44 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:34:44 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:34:44 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:34:44 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:34:44 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:34:44 volumio volumio[870]: info: ControllerMpd::pushState Jan 14 14:34:44 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jan 14 14:34:44 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:34:44 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":56607,"duration":219,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1589 Kbps","isStreaming":false,"title":"陪我轻轻唱","artist":"彭佳慧","album":"我想念我自己","uri":"USB/新加卷/SONY 华语/[Sony] - 彭佳慧 - 我想念我自己 - 24-48/01.陪我轻轻唱.flac","trackType":"flac"} Jan 14 14:34:44 volumio volumio[870]: verbose: CURRENT POSITION 0 Jan 14 14:34:44 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jan 14 14:34:44 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jan 14 14:34:44 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jan 14 14:34:44 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:34:44 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:34:44 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:34:44 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:34:44 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:34:44 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:34:44 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:34:44 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:34:44 volumio volumio[870]: info: ------------------------------ 178ms Jan 14 14:34:44 volumio volumio[870]: info: ------------------------------ 178ms Jan 14 14:34:46 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:34:47 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jan 14 14:34:47 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand rescan Jan 14 14:34:47 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jan 14 14:34:47 volumio volumio[870]: info: Jan 14 14:34:47 volumio volumio[870]: ---------------------------- MPD announces state update: update Jan 14 14:34:47 volumio volumio[870]: info: sendMpdCommand rescan took 1 milliseconds Jan 14 14:34:47 volumio volumio[870]: info: ControllerMpd::getState Jan 14 14:34:47 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jan 14 14:34:47 volumio volumio[870]: info: sendMpdCommand status took 1 milliseconds Jan 14 14:34:47 volumio volumio[870]: info: sendMpdCommand status took 1 milliseconds Jan 14 14:34:47 volumio volumio[870]: verbose: ControllerMpd::parseState Jan 14 14:34:47 volumio volumio[870]: info: Command Router : Notfying DB Updatetrue Jan 14 14:34:47 volumio volumio[870]: info: CoreCommandRouter::Close All Modals sent Jan 14 14:34:47 volumio volumio[870]: verbose: ControllerMpd::parseState Jan 14 14:34:47 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 14 14:34:47 volumio volumio[870]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 14 14:34:47 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jan 14 14:34:47 volumio volumio[870]: info: ControllerMpd::pushState Jan 14 14:34:47 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jan 14 14:34:47 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:34:47 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":59605,"duration":219,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1936 Kbps","isStreaming":false,"title":"陪我轻轻唱","artist":"彭佳慧","album":"我想念我自己","uri":"USB/新加卷/SONY 华语/[Sony] - 彭佳慧 - 我想念我自己 - 24-48/01.陪我轻轻唱.flac","trackType":"flac"} Jan 14 14:34:47 volumio volumio[870]: verbose: CURRENT POSITION 0 Jan 14 14:34:47 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jan 14 14:34:47 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jan 14 14:34:47 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jan 14 14:34:47 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:34:47 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:34:47 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:34:47 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:34:47 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:34:47 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:34:47 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:34:47 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:34:47 volumio volumio[870]: info: ------------------------------ 19ms Jan 14 14:34:48 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jan 14 14:34:48 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand update Jan 14 14:34:48 volumio volumio[870]: info: sendMpdCommand update took 1 milliseconds Jan 14 14:34:50 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:34:54 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:34:55 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 14 14:34:55 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 14 14:34:55 volumio volumio[870]: info: Discovery: Getting this device information Jan 14 14:34:55 volumio volumio[870]: info: CoreCommandRouter::volumioGetState Jan 14 14:34:55 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:34:55 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jan 14 14:34:55 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 14 14:34:55 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 14 14:34:58 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:34:59 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jan 14 14:35:00 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 14 14:35:02 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:35:05 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jan 14 14:35:06 volumio smbd[2280]: [2025/01/14 14:35:06.922579, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 14:35:06 volumio smbd[2280]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 14:35:06 volumio smbd[2280]: [2025/01/14 14:35:06.923198, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 14:35:06 volumio smbd[2280]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 14:35:06 volumio smbd[2280]: [2025/01/14 14:35:06.923246, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 14:35:06 volumio smbd[2280]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 14:35:06 volumio smbd[2280]: [2025/01/14 14:35:06.925299, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 14:35:06 volumio smbd[2280]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 14:35:08 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:35:10 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:35:14 volumio volumio[870]: info: MPD Database updated - AlbumList cache refreshed Jan 14 14:35:14 volumio volumio[870]: info: Jan 14 14:35:14 volumio volumio[870]: ---------------------------- MPD announces state update: database Jan 14 14:35:14 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jan 14 14:35:14 volumio volumio[870]: info: Jan 14 14:35:14 volumio volumio[870]: ---------------------------- MPD announces state update: update Jan 14 14:35:14 volumio volumio[870]: info: ControllerMpd::getState Jan 14 14:35:14 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jan 14 14:35:14 volumio volumio[870]: info: ControllerMpd::getState Jan 14 14:35:14 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jan 14 14:35:14 volumio volumio[870]: info: sendMpdCommand status took 90 milliseconds Jan 14 14:35:14 volumio volumio[870]: info: sendMpdCommand status took 95 milliseconds Jan 14 14:35:14 volumio volumio[870]: info: sendMpdCommand status took 95 milliseconds Jan 14 14:35:14 volumio volumio[870]: verbose: ControllerMpd::parseState Jan 14 14:35:14 volumio volumio[870]: info: Command Router : Notfying DB Updatetrue Jan 14 14:35:14 volumio volumio[870]: info: CoreCommandRouter::Close All Modals sent Jan 14 14:35:14 volumio volumio[870]: verbose: ControllerMpd::parseState Jan 14 14:35:14 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 14 14:35:14 volumio volumio[870]: verbose: ControllerMpd::parseState Jan 14 14:35:14 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 14 14:35:14 volumio volumio[870]: info: sendMpdCommand playlistinfo took 52 milliseconds Jan 14 14:35:14 volumio volumio[870]: info: sendMpdCommand playlistinfo took 52 milliseconds Jan 14 14:35:14 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jan 14 14:35:14 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jan 14 14:35:14 volumio volumio[870]: info: ControllerMpd::pushState Jan 14 14:35:14 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jan 14 14:35:14 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:35:14 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":86485,"duration":219,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1821 Kbps","isStreaming":false,"title":"陪我轻轻唱","artist":"彭佳慧","album":"我想念我自己","uri":"USB/新加卷/SONY 华语/[Sony] - 彭佳慧 - 我想念我自己 - 24-48/01.陪我轻轻唱.flac","trackType":"flac"} Jan 14 14:35:14 volumio volumio[870]: verbose: CURRENT POSITION 0 Jan 14 14:35:14 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jan 14 14:35:14 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jan 14 14:35:14 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jan 14 14:35:14 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:35:14 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:35:14 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:35:14 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:35:14 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:35:14 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:35:14 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:35:14 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:35:14 volumio volumio[870]: info: ControllerMpd::pushState Jan 14 14:35:14 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jan 14 14:35:14 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:35:14 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":86485,"duration":219,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1821 Kbps","isStreaming":false,"title":"陪我轻轻唱","artist":"彭佳慧","album":"我想念我自己","uri":"USB/新加卷/SONY 华语/[Sony] - 彭佳慧 - 我想念我自己 - 24-48/01.陪我轻轻唱.flac","trackType":"flac"} Jan 14 14:35:14 volumio volumio[870]: verbose: CURRENT POSITION 0 Jan 14 14:35:14 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jan 14 14:35:14 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jan 14 14:35:14 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jan 14 14:35:14 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:35:14 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:35:14 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:35:14 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:35:14 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:35:14 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:35:14 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:35:14 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:35:14 volumio volumio[870]: info: ------------------------------ 164ms Jan 14 14:35:14 volumio volumio[870]: info: ------------------------------ 164ms Jan 14 14:35:14 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:35:15 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jan 14 14:35:15 volumio volumio[870]: info: Jan 14 14:35:15 volumio volumio[870]: ---------------------------- MPD announces state update: update Jan 14 14:35:15 volumio volumio[870]: info: ControllerMpd::getState Jan 14 14:35:15 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jan 14 14:35:15 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jan 14 14:35:15 volumio volumio[870]: info: Jan 14 14:35:15 volumio volumio[870]: ---------------------------- MPD announces state update: update Jan 14 14:35:15 volumio volumio[870]: info: ControllerMpd::getState Jan 14 14:35:15 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jan 14 14:35:15 volumio volumio[870]: info: sendMpdCommand status took 1 milliseconds Jan 14 14:35:15 volumio volumio[870]: info: sendMpdCommand status took 1 milliseconds Jan 14 14:35:15 volumio volumio[870]: verbose: ControllerMpd::parseState Jan 14 14:35:15 volumio volumio[870]: info: Command Router : Notfying DB Updatefalse Jan 14 14:35:15 volumio volumio[870]: info: CoreCommandRouter::Close All Modals sent Jan 14 14:35:15 volumio volumio[870]: verbose: ControllerMpd::parseState Jan 14 14:35:15 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 14 14:35:15 volumio volumio[870]: info: sendMpdCommand status took 8 milliseconds Jan 14 14:35:15 volumio volumio[870]: info: sendMpdCommand status took 7 milliseconds Jan 14 14:35:15 volumio volumio[870]: verbose: ControllerMpd::parseState Jan 14 14:35:15 volumio volumio[870]: info: Command Router : Notfying DB Updatefalse Jan 14 14:35:15 volumio volumio[870]: info: CoreCommandRouter::Close All Modals sent Jan 14 14:35:15 volumio volumio[870]: verbose: ControllerMpd::parseState Jan 14 14:35:15 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 14 14:35:15 volumio volumio[870]: info: sendMpdCommand playlistinfo took 8 milliseconds Jan 14 14:35:15 volumio volumio[870]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 14 14:35:15 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jan 14 14:35:15 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jan 14 14:35:15 volumio volumio[870]: info: ControllerMpd::pushState Jan 14 14:35:15 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jan 14 14:35:15 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:35:15 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":86986,"duration":219,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1634 Kbps","isStreaming":false,"title":"陪我轻轻唱","artist":"彭佳慧","album":"我想念我自己","uri":"USB/新加卷/SONY 华语/[Sony] - 彭佳慧 - 我想念我自己 - 24-48/01.陪我轻轻唱.flac","trackType":"flac"} Jan 14 14:35:15 volumio volumio[870]: verbose: CURRENT POSITION 0 Jan 14 14:35:15 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jan 14 14:35:15 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jan 14 14:35:15 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jan 14 14:35:15 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:35:15 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:35:15 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:35:15 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:35:15 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:35:15 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:35:15 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:35:15 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:35:15 volumio volumio[870]: info: ControllerMpd::pushState Jan 14 14:35:15 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jan 14 14:35:15 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:35:15 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":87104,"duration":219,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2022 Kbps","isStreaming":false,"title":"陪我轻轻唱","artist":"彭佳慧","album":"我想念我自己","uri":"USB/新加卷/SONY 华语/[Sony] - 彭佳慧 - 我想念我自己 - 24-48/01.陪我轻轻唱.flac","trackType":"flac"} Jan 14 14:35:15 volumio volumio[870]: verbose: CURRENT POSITION 0 Jan 14 14:35:15 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jan 14 14:35:15 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jan 14 14:35:15 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jan 14 14:35:15 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:35:15 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:35:15 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:35:15 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:35:15 volumio volumio[870]: info: CoreStateMachine::pushState Jan 14 14:35:15 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:35:15 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jan 14 14:35:15 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 14:35:15 volumio volumio[870]: info: ------------------------------ 21ms Jan 14 14:35:15 volumio volumio[870]: info: ------------------------------ 21ms Jan 14 14:35:18 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:35:22 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:35:25 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 14 14:35:25 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 14 14:35:25 volumio volumio[870]: info: Discovery: Getting this device information Jan 14 14:35:25 volumio volumio[870]: info: CoreCommandRouter::volumioGetState Jan 14 14:35:25 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:35:25 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jan 14 14:35:25 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 14 14:35:25 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 14 14:35:26 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:35:30 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:35:34 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:35:38 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:35:42 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:35:46 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:35:48 volumio volumio[870]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BD%AD%E4%BD%B3%E6%85%A7/%E6%88%91%E6%83%B3%E5%BF%B5%E6%88%91%E8%87%AA%E5%B7%B1/09e6b9cf-386e-4172-8fe6-d2aac6fc77f6.jpg' Jan 14 14:35:50 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:35:54 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 14:35:55 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 14 14:35:55 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 14 14:35:55 volumio volumio[870]: info: Discovery: Getting this device information Jan 14 14:35:55 volumio volumio[870]: info: CoreCommandRouter::volumioGetState Jan 14 14:35:55 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jan 14 14:35:55 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jan 14 14:35:55 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 14 14:35:55 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 14 14:35:56 volumio volumio[870]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 14 14:35:56 volumio volumio[870]: { Error: connect ETIMEDOUT 157.240.12.5:443 Jan 14 14:35:56 volumio volumio[870]: at Object._errnoException (util.js:1022:11) Jan 14 14:35:56 volumio volumio[870]: at _exceptionWithHostPort (util.js:1044:20) Jan 14 14:35:56 volumio volumio[870]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jan 14 14:35:56 volumio volumio[870]: code: 'ETIMEDOUT', Jan 14 14:35:56 volumio volumio[870]: errno: 'ETIMEDOUT', Jan 14 14:35:56 volumio volumio[870]: syscall: 'connect', Jan 14 14:35:56 volumio volumio[870]: address: '157.240.12.5', Jan 14 14:35:56 volumio volumio[870]: port: 443 } Jan 14 14:35:56 volumio volumio[870]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 14 14:35:56 volumio sudo[2419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-14 14:34 Jan 14 14:35:56 volumio sudo[2419]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="537e3f50b5a8aa9bdf42f94adc80b348609b5c47" VOLUMIO_BE_VERSION="d7e6c614214d5dc616fddcbcfefc47e1990da7b1" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Sep 8 12:33:16 CEST 2021" VOLUMIO_VERSION="2.909" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="6e5c976a6d85b8b7d7e4e3388d208cd8"