-- Logs begin at Mon 2025-06-23 10:38:35 CST, end at Mon 2025-06-23 11:05:07 CST. --
Jun 23 11:04:14 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 23 11:04:14 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 23 11:04:14 volumio volumio[4867]: info: Discovery: Getting this device information
Jun 23 11:04:14 volumio volumio[4867]: info: CoreCommandRouter::volumioGetState
Jun 23 11:04:14 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:14 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 23 11:04:16 volumio volumio[4867]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Jun 23 11:04:16 volumio volumio[4867]: info: Retrying Login Due to Network Error
Jun 23 11:04:26 volumio volumio[4867]: info: MyVolumio login type: Token
Jun 23 11:04:26 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 23 11:04:26 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 23 11:04:26 volumio volumio[4867]: info: Discovery: Getting this device information
Jun 23 11:04:26 volumio volumio[4867]: info: CoreCommandRouter::volumioGetState
Jun 23 11:04:26 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:26 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 23 11:04:26 volumio volumio[4867]: verbose: New Socket.io Connection to 192.168.1.8:3000 from 192.168.1.101 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5
Jun 23 11:04:26 volumio volumio[4867]: info: CoreCommandRouter::volumioGetState
Jun 23 11:04:26 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:26 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jun 23 11:04:26 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jun 23 11:04:28 volumio volumio[4867]: info: CoreCommandRouter::volumioGetState
Jun 23 11:04:28 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:28 volumio sudo[5670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 23 11:04:28 volumio sudo[5670]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 23 11:04:28 volumio sudo[5670]: pam_unix(sudo:session): session closed for user root
Jun 23 11:04:28 volumio sudo[5673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 23 11:04:28 volumio sudo[5673]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 23 11:04:28 volumio sudo[5673]: pam_unix(sudo:session): session closed for user root
Jun 23 11:04:28 volumio volumio[4867]: verbose: New Socket.io Connection to 192.168.1.8 from 192.168.1.101 UA: Mozilla/5.0 (Linux; Android 14; V2403A Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.135 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Jun 23 11:04:28 volumio sudo[5678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 23 11:04:28 volumio sudo[5678]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 23 11:04:28 volumio sudo[5678]: pam_unix(sudo:session): session closed for user root
Jun 23 11:04:28 volumio sudo[5681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 23 11:04:28 volumio sudo[5681]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 23 11:04:28 volumio sudo[5681]: pam_unix(sudo:session): session closed for user root
Jun 23 11:04:28 volumio volumio[4867]: verbose: New Socket.io Connection to 192.168.1.8 from 192.168.1.101 UA: Mozilla/5.0 (Linux; Android 14; V2403A Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.135 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Jun 23 11:04:28 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 23 11:04:28 volumio volumio[4867]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 23 11:04:28 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 23 11:04:28 volumio volumio[4867]: info: CoreCommandRouter::volumioGetState
Jun 23 11:04:28 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:28 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 23 11:04:28 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 23 11:04:28 volumio volumio[4867]: info: Received Get System Info
Jun 23 11:04:28 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 23 11:04:28 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 23 11:04:28 volumio volumio[4867]: info: Discovery: Getting this device information
Jun 23 11:04:28 volumio volumio[4867]: info: CoreCommandRouter::volumioGetState
Jun 23 11:04:28 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:28 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 23 11:04:28 volumio volumio[4867]: info: CoreCommandRouter::volumioGetState
Jun 23 11:04:28 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:28 volumio volumio[4867]: info: Listing playlists
Jun 23 11:04:28 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jun 23 11:04:28 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 23 11:04:29 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jun 23 11:04:30 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jun 23 11:04:30 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 23 11:04:30 volumio volumio[4867]: info: Received Get System Info
Jun 23 11:04:30 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 23 11:04:30 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 23 11:04:30 volumio volumio[4867]: info: Discovery: Getting this device information
Jun 23 11:04:30 volumio volumio[4867]: info: CoreCommandRouter::volumioGetState
Jun 23 11:04:30 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:30 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 23 11:04:31 volumio volumio[4867]: info: CoreCommandRouter::volumioGetQueue
Jun 23 11:04:31 volumio volumio[4867]: info: CoreStateMachine::getQueue
Jun 23 11:04:31 volumio volumio[4867]: info: CorePlayQueue::getQueue
Jun 23 11:04:31 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 23 11:04:31 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 23 11:04:31 volumio volumio[4867]: info: Discovery: Getting this device information
Jun 23 11:04:31 volumio volumio[4867]: info: CoreCommandRouter::volumioGetState
Jun 23 11:04:31 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:31 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 23 11:04:33 volumio volumio[4867]: info: Preload queue cleared
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::ClearQueue
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::stop
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::clearPlayQueue
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::saveQueue
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::volumioPushQueue
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::addQueueItems
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::addQueueItems
Jun 23 11:04:33 volumio volumio[4867]: info: Preload queue cleared
Jun 23 11:04:33 volumio volumio[4867]: info: Adding Item to queue: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Using cached record of: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::volumioPushQueue
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::saveQueue
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::updateTrackBlock
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrackBlock
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::volumioPlay
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::play index 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::addQueueItems
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::addQueueItems
Jun 23 11:04:33 volumio volumio[4867]: info: Preload queue cleared
Jun 23 11:04:33 volumio volumio[4867]: info: Adding Item to queue: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/02.Moonchild.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Using cached record of: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/02.Moonchild.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Adding Item to queue: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/03.星心.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Using cached record of: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/03.星心.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Adding Item to queue: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/04.一點點.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Using cached record of: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/04.一點點.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Adding Item to queue: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/05.路上.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Using cached record of: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/05.路上.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Adding Item to queue: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/06.半晴天.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Using cached record of: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/06.半晴天.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Adding Item to queue: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/07.活該.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Using cached record of: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/07.活該.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Adding Item to queue: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/08.In the Morning.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Using cached record of: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/08.In the Morning.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Adding Item to queue: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/09.微塵.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Using cached record of: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/09.微塵.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Adding Item to queue: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/10.千言萬語.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Using cached record of: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/10.千言萬語.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Adding Item to queue: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/11.Lonely is the Night (feat. A-Lin).flac
Jun 23 11:04:33 volumio volumio[4867]: info: Using cached record of: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/11.Lonely is the Night (feat. A-Lin).flac
Jun 23 11:04:33 volumio volumio[4867]: info: Adding Item to queue: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/12.陪你.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Using cached record of: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/12.陪你.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Adding Item to queue: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/13.讓愛再繼續.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Using cached record of: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/13.讓愛再繼續.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Adding Item to queue: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/14.全世界會唱的歌.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Using cached record of: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/14.全世界會唱的歌.flac
Jun 23 11:04:33 volumio volumio[4867]: info: Adding Item to queue: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/15.Do I Do I (reprise).flac
Jun 23 11:04:33 volumio volumio[4867]: info: Using cached record of: music-library/NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/15.Do I Do I (reprise).flac
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::stop
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::volumioPushQueue
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::saveQueue
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::play index undefined
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::updateTrackBlock
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrackBlock
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::startPlaybackTimer
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand stop
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand stop took 3 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand clear
Jun 23 11:04:33 volumio volumio[4867]: info:
Jun 23 11:04:33 volumio volumio[4867]: ---------------------------- MPD announces system playlist update
Jun 23 11:04:33 volumio volumio[4867]: info: Ignoring MPD Status Update
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand clear took 1 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac"
Jun 23 11:04:33 volumio volumio[4867]: info:
Jun 23 11:04:33 volumio volumio[4867]: ---------------------------- MPD announces system playlist update
Jun 23 11:04:33 volumio volumio[4867]: info: Ignoring MPD Status Update
Jun 23 11:04:33 volumio volumio[4867]: info:
Jun 23 11:04:33 volumio volumio[4867]: ---------------------------- MPD announces system playlist update
Jun 23 11:04:33 volumio volumio[4867]: info: Ignoring MPD Status Update
Jun 23 11:04:33 volumio volumio[4867]: error: updateQueue error: null
Jun 23 11:04:33 volumio volumio[4867]: info:
Jun 23 11:04:33 volumio volumio[4867]: ---------------------------- MPD announces system playlist update
Jun 23 11:04:33 volumio volumio[4867]: info: Ignoring MPD Status Update
Jun 23 11:04:33 volumio volumio[4867]: info: ------------------------------ 3ms
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand add "NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac" took 2 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: info: ------------------------------ 2ms
Jun 23 11:04:33 volumio volumio[4867]: info: ------------------------------ 1ms
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand play
Jun 23 11:04:33 volumio volumio[4867]: info:
Jun 23 11:04:33 volumio volumio[4867]: ---------------------------- MPD announces system playlist update
Jun 23 11:04:33 volumio volumio[4867]: info: Ignoring MPD Status Update
Jun 23 11:04:33 volumio volumio[4867]: info:
Jun 23 11:04:33 volumio volumio[4867]: ---------------------------- MPD announces system playlist update
Jun 23 11:04:33 volumio volumio[4867]: info: Ignoring MPD Status Update
Jun 23 11:04:33 volumio volumio[4867]: info: ------------------------------ 2ms
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand play took 1 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: info: ------------------------------ 1ms
Jun 23 11:04:33 volumio volumio[4867]: info: ------------------------------ 1ms
Jun 23 11:04:33 volumio volumio[4867]: info:
Jun 23 11:04:33 volumio volumio[4867]: ---------------------------- MPD announces state update: player
Jun 23 11:04:33 volumio volumio[4867]: info: ControllerMpd::getState
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 11:04:33 volumio volumio[4867]: info:
Jun 23 11:04:33 volumio volumio[4867]: ---------------------------- MPD announces state update: player
Jun 23 11:04:33 volumio volumio[4867]: info: ControllerMpd::getState
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 11:04:33 volumio volumio[4867]: info:
Jun 23 11:04:33 volumio volumio[4867]: ---------------------------- MPD announces state update: player
Jun 23 11:04:33 volumio volumio[4867]: info: ControllerMpd::getState
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 11:04:33 volumio volumio[4867]: info:
Jun 23 11:04:33 volumio volumio[4867]: ---------------------------- MPD announces state update: player
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand status took 1 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: info: ControllerMpd::getState
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::parseState
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand status took 3 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand status took 3 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand status took 1 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::parseState
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::parseState
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::parseState
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::parseTrackInfo
Jun 23 11:04:33 volumio volumio[4867]: info: ControllerMpd::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::servicePushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":317,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Stupid Pop Song","artist":"陶喆","album":"STUPID POP SONGS","uri":"NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac","trackType":"flac"}
Jun 23 11:04:33 volumio volumio[4867]: verbose: CURRENT POSITION 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::syncState stateService play
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::syncState currentStatus stop
Jun 23 11:04:33 volumio volumio[4867]: info: ------------------------------ 8ms
Jun 23 11:04:33 volumio volumio[4867]: info:
Jun 23 11:04:33 volumio volumio[4867]: ---------------------------- MPD announces state update: player
Jun 23 11:04:33 volumio volumio[4867]: info: ControllerMpd::getState
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 11:04:33 volumio volumio[4867]: info:
Jun 23 11:04:33 volumio volumio[4867]: ---------------------------- MPD announces state update: player
Jun 23 11:04:33 volumio volumio[4867]: info: ControllerMpd::getState
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand status took 2 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand status took 1 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::parseTrackInfo
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::parseTrackInfo
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::parseTrackInfo
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::parseState
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::parseState
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 11:04:33 volumio volumio[4867]: info: ControllerMpd::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::servicePushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":317,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Stupid Pop Song","artist":"陶喆","album":"STUPID POP SONGS","uri":"NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac","trackType":"flac"}
Jun 23 11:04:33 volumio volumio[4867]: verbose: CURRENT POSITION 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::syncState stateService play
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::syncState currentStatus play
Jun 23 11:04:33 volumio volumio[4867]: info: Received an update from plugin. extracting info from payload
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:04:33 volumio volumio[4867]: info: ControllerMpd::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::servicePushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":317,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Stupid Pop Song","artist":"陶喆","album":"STUPID POP SONGS","uri":"NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac","trackType":"flac"}
Jun 23 11:04:33 volumio volumio[4867]: verbose: CURRENT POSITION 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::syncState stateService play
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::syncState currentStatus play
Jun 23 11:04:33 volumio volumio[4867]: info: Received an update from plugin. extracting info from payload
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:04:33 volumio volumio[4867]: info: ControllerMpd::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::servicePushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":317,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Stupid Pop Song","artist":"陶喆","album":"STUPID POP SONGS","uri":"NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac","trackType":"flac"}
Jun 23 11:04:33 volumio volumio[4867]: verbose: CURRENT POSITION 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::syncState stateService play
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::syncState currentStatus play
Jun 23 11:04:33 volumio volumio[4867]: info: Received an update from plugin. extracting info from payload
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:04:33 volumio volumio[4867]: info: ------------------------------ 38ms
Jun 23 11:04:33 volumio volumio[4867]: info: ------------------------------ 38ms
Jun 23 11:04:33 volumio volumio[4867]: info: ------------------------------ 37ms
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand playlistinfo took 29 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: info: sendMpdCommand playlistinfo took 29 milliseconds
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::parseTrackInfo
Jun 23 11:04:33 volumio volumio[4867]: verbose: ControllerMpd::parseTrackInfo
Jun 23 11:04:33 volumio volumio[4867]: info: ControllerMpd::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::servicePushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":317,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1444 Kbps","isStreaming":false,"title":"Stupid Pop Song","artist":"陶喆","album":"STUPID POP SONGS","uri":"NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac","trackType":"flac"}
Jun 23 11:04:33 volumio volumio[4867]: verbose: CURRENT POSITION 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::syncState stateService play
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::syncState currentStatus play
Jun 23 11:04:33 volumio volumio[4867]: info: Received an update from plugin. extracting info from payload
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:04:33 volumio volumio[4867]: info: ControllerMpd::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::servicePushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":317,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1444 Kbps","isStreaming":false,"title":"Stupid Pop Song","artist":"陶喆","album":"STUPID POP SONGS","uri":"NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac","trackType":"flac"}
Jun 23 11:04:33 volumio volumio[4867]: verbose: CURRENT POSITION 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::syncState stateService play
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::syncState currentStatus play
Jun 23 11:04:33 volumio volumio[4867]: info: Received an update from plugin. extracting info from payload
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:04:33 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:04:33 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:33 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:04:33 volumio volumio[4867]: info: ------------------------------ 43ms
Jun 23 11:04:33 volumio volumio[4867]: info: ------------------------------ 43ms
Jun 23 11:04:36 volumio volumio[4867]: info: VolumeController::SetAlsaVolume47
Jun 23 11:04:36 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:04:36 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:36 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 23 11:04:36 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:04:37 volumio volumio[4867]: info: VolumeController::SetAlsaVolume48
Jun 23 11:04:37 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:04:37 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:37 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 23 11:04:37 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:04:38 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jun 23 11:04:47 volumio volumio[4867]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 23 11:04:47 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Jun 23 11:04:47 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 23 11:04:47 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jun 23 11:04:47 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 23 11:04:47 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 23 11:04:47 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 23 11:04:47 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 23 11:04:47 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 23 11:04:47 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 23 11:04:47 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 23 11:04:47 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Jun 23 11:04:47 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::volumioGetState
Jun 23 11:04:55 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:55 volumio sudo[5770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 23 11:04:55 volumio sudo[5770]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 23 11:04:55 volumio sudo[5770]: pam_unix(sudo:session): session closed for user root
Jun 23 11:04:55 volumio sudo[5773]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 23 11:04:55 volumio sudo[5773]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 23 11:04:55 volumio sudo[5773]: pam_unix(sudo:session): session closed for user root
Jun 23 11:04:55 volumio volumio[4867]: verbose: New Socket.io Connection to 192.168.1.8 from 192.168.1.101 UA: Mozilla/5.0 (Linux; Android 14; V2403A Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.135 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Jun 23 11:04:55 volumio sudo[5778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 23 11:04:55 volumio sudo[5778]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 23 11:04:55 volumio sudo[5778]: pam_unix(sudo:session): session closed for user root
Jun 23 11:04:55 volumio sudo[5781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 23 11:04:55 volumio sudo[5781]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 23 11:04:55 volumio sudo[5781]: pam_unix(sudo:session): session closed for user root
Jun 23 11:04:55 volumio volumio[4867]: verbose: New Socket.io Connection to 192.168.1.8 from 192.168.1.101 UA: Mozilla/5.0 (Linux; Android 14; V2403A Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.135 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::volumioGetState
Jun 23 11:04:55 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::volumioGetQueue
Jun 23 11:04:55 volumio volumio[4867]: info: CoreStateMachine::getQueue
Jun 23 11:04:55 volumio volumio[4867]: info: CorePlayQueue::getQueue
Jun 23 11:04:55 volumio volumio[4867]: info: Listing playlists
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 23 11:04:55 volumio volumio[4867]: info: Received Get System Info
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 23 11:04:55 volumio volumio[4867]: info: Discovery: Getting this device information
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::volumioGetState
Jun 23 11:04:55 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::volumioGetState
Jun 23 11:04:55 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 23 11:04:55 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jun 23 11:04:56 volumio volumio[4867]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Jun 23 11:04:56 volumio volumio[4867]: info: Retrying Login Due to Network Error
Jun 23 11:04:56 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 23 11:04:56 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 23 11:04:56 volumio volumio[4867]: info: Discovery: Getting this device information
Jun 23 11:04:56 volumio volumio[4867]: info: CoreCommandRouter::volumioGetState
Jun 23 11:04:56 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:56 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 23 11:04:57 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jun 23 11:04:57 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 23 11:04:57 volumio volumio[4867]: info: Received Get System Info
Jun 23 11:04:57 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 23 11:04:57 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 23 11:04:57 volumio volumio[4867]: info: Discovery: Getting this device information
Jun 23 11:04:57 volumio volumio[4867]: info: CoreCommandRouter::volumioGetState
Jun 23 11:04:57 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:57 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 23 11:04:59 volumio volumio[4867]: info: CoreCommandRouter::volumioPause
Jun 23 11:04:59 volumio volumio[4867]: info: CoreStateMachine::pause
Jun 23 11:04:59 volumio volumio[4867]: info: CoreStateMachine::stPlaybackTimer
Jun 23 11:04:59 volumio volumio[4867]: info: CoreStateMachine::servicePause
Jun 23 11:04:59 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:59 volumio volumio[4867]: info: CoreCommandRouter::servicePause
Jun 23 11:04:59 volumio volumio[4867]: info: ControllerMpd::pause
Jun 23 11:04:59 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand pause
Jun 23 11:04:59 volumio volumio[4867]: info:
Jun 23 11:04:59 volumio volumio[4867]: ---------------------------- MPD announces state update: player
Jun 23 11:04:59 volumio volumio[4867]: info: sendMpdCommand pause took 1 milliseconds
Jun 23 11:04:59 volumio volumio[4867]: info: ControllerMpd::getState
Jun 23 11:04:59 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 11:04:59 volumio volumio[4867]: info: sendMpdCommand status took 1 milliseconds
Jun 23 11:04:59 volumio volumio[4867]: verbose: ControllerMpd::parseState
Jun 23 11:04:59 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 11:04:59 volumio volumio[4867]: info:
Jun 23 11:04:59 volumio volumio[4867]: ---------------------------- MPD announces state update: player
Jun 23 11:04:59 volumio volumio[4867]: info: ControllerMpd::getState
Jun 23 11:04:59 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 11:04:59 volumio volumio[4867]: info:
Jun 23 11:04:59 volumio volumio[4867]: ---------------------------- MPD announces state update: player
Jun 23 11:04:59 volumio volumio[4867]: info: ControllerMpd::getState
Jun 23 11:04:59 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 11:04:59 volumio volumio[4867]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jun 23 11:04:59 volumio volumio[4867]: info: sendMpdCommand status took 1 milliseconds
Jun 23 11:04:59 volumio volumio[4867]: info: sendMpdCommand status took 1 milliseconds
Jun 23 11:04:59 volumio volumio[4867]: verbose: ControllerMpd::parseTrackInfo
Jun 23 11:04:59 volumio volumio[4867]: verbose: ControllerMpd::parseState
Jun 23 11:04:59 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 11:04:59 volumio volumio[4867]: verbose: ControllerMpd::parseState
Jun 23 11:04:59 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 11:04:59 volumio volumio[4867]: info: ControllerMpd::pushState
Jun 23 11:04:59 volumio volumio[4867]: info: CoreCommandRouter::servicePushState
Jun 23 11:04:59 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:59 volumio volumio[4867]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":24357,"duration":317,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1777 Kbps","isStreaming":false,"title":"Stupid Pop Song","artist":"陶喆","album":"STUPID POP SONGS","uri":"NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac","trackType":"flac"}
Jun 23 11:04:59 volumio volumio[4867]: verbose: CURRENT POSITION 0
Jun 23 11:04:59 volumio volumio[4867]: info: CoreStateMachine::syncState stateService pause
Jun 23 11:04:59 volumio volumio[4867]: info: CoreStateMachine::syncState currentStatus pause
Jun 23 11:04:59 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:04:59 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:59 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 23 11:04:59 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:04:59 volumio volumio[4867]: info: CoreStateMachine::stPlaybackTimer
Jun 23 11:04:59 volumio volumio[4867]: info: ------------------------------ 6ms
Jun 23 11:04:59 volumio volumio[4867]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jun 23 11:04:59 volumio volumio[4867]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jun 23 11:04:59 volumio volumio[4867]: verbose: ControllerMpd::parseTrackInfo
Jun 23 11:04:59 volumio volumio[4867]: verbose: ControllerMpd::parseTrackInfo
Jun 23 11:04:59 volumio volumio[4867]: info: ControllerMpd::pushState
Jun 23 11:04:59 volumio volumio[4867]: info: CoreCommandRouter::servicePushState
Jun 23 11:04:59 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:59 volumio volumio[4867]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":24357,"duration":317,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1777 Kbps","isStreaming":false,"title":"Stupid Pop Song","artist":"陶喆","album":"STUPID POP SONGS","uri":"NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac","trackType":"flac"}
Jun 23 11:04:59 volumio volumio[4867]: verbose: CURRENT POSITION 0
Jun 23 11:04:59 volumio volumio[4867]: info: CoreStateMachine::syncState stateService pause
Jun 23 11:04:59 volumio volumio[4867]: info: CoreStateMachine::syncState currentStatus pause
Jun 23 11:04:59 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:04:59 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:59 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:04:59 volumio volumio[4867]: info: CoreStateMachine::stPlaybackTimer
Jun 23 11:04:59 volumio volumio[4867]: info: ControllerMpd::pushState
Jun 23 11:04:59 volumio volumio[4867]: info: CoreCommandRouter::servicePushState
Jun 23 11:04:59 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:59 volumio volumio[4867]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":24357,"duration":317,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1777 Kbps","isStreaming":false,"title":"Stupid Pop Song","artist":"陶喆","album":"STUPID POP SONGS","uri":"NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac","trackType":"flac"}
Jun 23 11:04:59 volumio volumio[4867]: verbose: CURRENT POSITION 0
Jun 23 11:04:59 volumio volumio[4867]: info: CoreStateMachine::syncState stateService pause
Jun 23 11:04:59 volumio volumio[4867]: info: CoreStateMachine::syncState currentStatus pause
Jun 23 11:04:59 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:04:59 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:04:59 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:04:59 volumio volumio[4867]: info: CoreStateMachine::stPlaybackTimer
Jun 23 11:04:59 volumio volumio[4867]: info: ------------------------------ 11ms
Jun 23 11:04:59 volumio volumio[4867]: info: ------------------------------ 11ms
Jun 23 11:05:00 volumio volumio[4867]: info: CoreCommandRouter::volumioPlay
Jun 23 11:05:00 volumio volumio[4867]: info: CoreStateMachine::play index undefined
Jun 23 11:05:00 volumio volumio[4867]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 23 11:05:00 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:05:00 volumio volumio[4867]: info: CoreStateMachine::startPlaybackTimer
Jun 23 11:05:00 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:05:00 volumio volumio[4867]: info: ControllerMpd::resume
Jun 23 11:05:00 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand play
Jun 23 11:05:00 volumio volumio[4867]: info:
Jun 23 11:05:00 volumio volumio[4867]: ---------------------------- MPD announces state update: player
Jun 23 11:05:00 volumio volumio[4867]: info: sendMpdCommand play took 2 milliseconds
Jun 23 11:05:00 volumio volumio[4867]: info: ControllerMpd::getState
Jun 23 11:05:00 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 11:05:00 volumio volumio[4867]: info:
Jun 23 11:05:00 volumio volumio[4867]: ---------------------------- MPD announces state update: player
Jun 23 11:05:00 volumio volumio[4867]: info: ControllerMpd::getState
Jun 23 11:05:00 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 11:05:00 volumio volumio[4867]: info:
Jun 23 11:05:00 volumio volumio[4867]: ---------------------------- MPD announces state update: player
Jun 23 11:05:00 volumio volumio[4867]: info: ControllerMpd::getState
Jun 23 11:05:00 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand status
Jun 23 11:05:00 volumio volumio[4867]: info: sendMpdCommand status took 1 milliseconds
Jun 23 11:05:00 volumio volumio[4867]: info: sendMpdCommand status took 0 milliseconds
Jun 23 11:05:00 volumio volumio[4867]: info: sendMpdCommand status took 0 milliseconds
Jun 23 11:05:00 volumio volumio[4867]: verbose: ControllerMpd::parseState
Jun 23 11:05:00 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 11:05:00 volumio volumio[4867]: verbose: ControllerMpd::parseState
Jun 23 11:05:00 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 11:05:00 volumio volumio[4867]: verbose: ControllerMpd::parseState
Jun 23 11:05:00 volumio volumio[4867]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 23 11:05:00 volumio volumio[4867]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jun 23 11:05:00 volumio volumio[4867]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jun 23 11:05:00 volumio volumio[4867]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jun 23 11:05:00 volumio volumio[4867]: verbose: ControllerMpd::parseTrackInfo
Jun 23 11:05:00 volumio volumio[4867]: verbose: ControllerMpd::parseTrackInfo
Jun 23 11:05:00 volumio volumio[4867]: verbose: ControllerMpd::parseTrackInfo
Jun 23 11:05:00 volumio volumio[4867]: info: ControllerMpd::pushState
Jun 23 11:05:00 volumio volumio[4867]: info: CoreCommandRouter::servicePushState
Jun 23 11:05:00 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:05:00 volumio volumio[4867]: verbose: STATE SERVICE {"status":"play","position":0,"seek":25350,"duration":317,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1337 Kbps","isStreaming":false,"title":"Stupid Pop Song","artist":"陶喆","album":"STUPID POP SONGS","uri":"NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac","trackType":"flac"}
Jun 23 11:05:00 volumio volumio[4867]: verbose: CURRENT POSITION 0
Jun 23 11:05:00 volumio volumio[4867]: info: CoreStateMachine::syncState stateService play
Jun 23 11:05:00 volumio volumio[4867]: info: CoreStateMachine::syncState currentStatus pause
Jun 23 11:05:00 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:05:00 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:05:00 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 23 11:05:00 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:05:00 volumio volumio[4867]: info: ControllerMpd::pushState
Jun 23 11:05:00 volumio volumio[4867]: info: CoreCommandRouter::servicePushState
Jun 23 11:05:00 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:05:00 volumio volumio[4867]: verbose: STATE SERVICE {"status":"play","position":0,"seek":25350,"duration":317,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1337 Kbps","isStreaming":false,"title":"Stupid Pop Song","artist":"陶喆","album":"STUPID POP SONGS","uri":"NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac","trackType":"flac"}
Jun 23 11:05:00 volumio volumio[4867]: verbose: CURRENT POSITION 0
Jun 23 11:05:00 volumio volumio[4867]: info: CoreStateMachine::syncState stateService play
Jun 23 11:05:00 volumio volumio[4867]: info: CoreStateMachine::syncState currentStatus play
Jun 23 11:05:00 volumio volumio[4867]: info: Received an update from plugin. extracting info from payload
Jun 23 11:05:00 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:05:00 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:05:00 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 23 11:05:00 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:05:00 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:05:00 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:05:00 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:05:00 volumio volumio[4867]: info: ControllerMpd::pushState
Jun 23 11:05:00 volumio volumio[4867]: info: CoreCommandRouter::servicePushState
Jun 23 11:05:00 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:05:00 volumio volumio[4867]: verbose: STATE SERVICE {"status":"play","position":0,"seek":25350,"duration":317,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1337 Kbps","isStreaming":false,"title":"Stupid Pop Song","artist":"陶喆","album":"STUPID POP SONGS","uri":"NAS/NAS/Mandopop/TW/陶喆/2025.4.15 STUPID POP SONGS/01.Stupid Pop Song.flac","trackType":"flac"}
Jun 23 11:05:00 volumio volumio[4867]: verbose: CURRENT POSITION 0
Jun 23 11:05:00 volumio volumio[4867]: info: CoreStateMachine::syncState stateService play
Jun 23 11:05:00 volumio volumio[4867]: info: CoreStateMachine::syncState currentStatus play
Jun 23 11:05:00 volumio volumio[4867]: info: Received an update from plugin. extracting info from payload
Jun 23 11:05:00 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:05:00 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:05:00 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:05:00 volumio volumio[4867]: info: CoreStateMachine::pushState
Jun 23 11:05:00 volumio volumio[4867]: info: CorePlayQueue::getTrack 0
Jun 23 11:05:00 volumio volumio[4867]: info: CoreCommandRouter::volumioPushState
Jun 23 11:05:00 volumio volumio[4867]: info: ------------------------------ 14ms
Jun 23 11:05:00 volumio volumio[4867]: info: ------------------------------ 13ms
Jun 23 11:05:00 volumio volumio[4867]: info: ------------------------------ 13ms
Jun 23 11:05:05 volumio volumio[4867]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jun 23 11:05:06 volumio volumio[4867]: info: MyVolumio login type: Token
Jun 23 11:05:07 volumio volumio[4867]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 23 11:05:07 volumio volumio[4867]: Error: connect ETIMEDOUT 202.160.130.52:80
Jun 23 11:05:07 volumio volumio[4867]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Jun 23 11:05:07 volumio volumio[4867]: errno: -110,
Jun 23 11:05:07 volumio volumio[4867]: code: 'ETIMEDOUT',
Jun 23 11:05:07 volumio volumio[4867]: syscall: 'connect',
Jun 23 11:05:07 volumio volumio[4867]: address: '202.160.130.52',
Jun 23 11:05:07 volumio volumio[4867]: port: 80
Jun 23 11:05:07 volumio volumio[4867]: }
Jun 23 11:05:07 volumio volumio[4867]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 23 11:05:07 volumio sudo[5809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-23 11:04
Jun 23 11:05:07 volumio sudo[5809]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:26:48 PM CEST"
VOLUMIO_VERSION="3.816"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="a63f40325536655a08b14de2b295ce76"