-- Logs begin at Sat 2024-08-31 17:34:45 UTC, end at Sun 2024-09-01 09:59:43 UTC. --
Sep 01 09:58:00 volumio volumio[32603]: info: CoreCommandRouter::volumioGetState
Sep 01 09:58:00 volumio volumio[32603]: info: CorePlayQueue::getTrack 14
Sep 01 09:58:00 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 01 09:58:00 volumio volumio[32603]: info: Listing playlists
Sep 01 09:58:00 volumio volumio[32603]: info: CoreCommandRouter::volumioGetQueue
Sep 01 09:58:00 volumio volumio[32603]: info: CoreStateMachine::getQueue
Sep 01 09:58:00 volumio volumio[32603]: info: CorePlayQueue::getQueue
Sep 01 09:58:00 volumio volumio[32603]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 01 09:58:00 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 01 09:58:01 volumio volumio[32603]: info: VolumeController::SetAlsaVolume90
Sep 01 09:58:01 volumio volumio[32603]: info: CoreStateMachine::pushState
Sep 01 09:58:01 volumio volumio[32603]: info: CorePlayQueue::getTrack 14
Sep 01 09:58:01 volumio volumio[32603]: info: CoreCommandRouter::volumioPushState
Sep 01 09:58:01 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:58:02 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:58:02 volumio volumio[32603]: info: CorePlayQueue::getTrack 14
Sep 01 09:58:02 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:02 volumio volumio[32603]: info: Prefetching next song
Sep 01 09:58:02 volumio volumio[32603]: info: DOING PREFETCH IN MPD
Sep 01 09:58:02 volumio volumio[32603]: verbose: ControllerMpd::sendMpdCommand add "USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 2/01 Tears Of Joy.wav"
Sep 01 09:58:02 volumio volumio[32603]: info:
Sep 01 09:58:02 volumio volumio[32603]: ---------------------------- MPD announces system playlist update
Sep 01 09:58:02 volumio volumio[32603]: info: Ignoring MPD Status Update
Sep 01 09:58:02 volumio volumio[32603]: verbose: ControllerMpd::sendMpdCommand consume 1
Sep 01 09:58:02 volumio volumio[32603]: info: ------------------------------ 4ms
Sep 01 09:58:02 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 01 09:58:02 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 01 09:58:02 volumio volumio[32603]: info: Discovery: Getting this device information
Sep 01 09:58:02 volumio volumio[32603]: info: CoreCommandRouter::volumioGetState
Sep 01 09:58:02 volumio volumio[32603]: info: CorePlayQueue::getTrack 14
Sep 01 09:58:02 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses
Sep 01 09:58:02 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: system , getConf
Sep 01 09:58:02 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: system , getConf
Sep 01 09:58:04 volumio volumio[32603]: info: VolumeController::SetAlsaVolume100
Sep 01 09:58:04 volumio volumio[32603]: info: CoreStateMachine::pushState
Sep 01 09:58:04 volumio volumio[32603]: info: CorePlayQueue::getTrack 14
Sep 01 09:58:04 volumio volumio[32603]: info: CoreCommandRouter::volumioPushState
Sep 01 09:58:04 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:58:06 volumio volumio[32603]: info: CoreStateMachine::startPlaybackTimer
Sep 01 09:58:06 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:06 volumio volumio[32603]: info:
Sep 01 09:58:06 volumio volumio[32603]: ---------------------------- MPD announces system playlist update
Sep 01 09:58:06 volumio volumio[32603]: info: Ignoring MPD Status Update
Sep 01 09:58:06 volumio volumio[32603]: info:
Sep 01 09:58:06 volumio volumio[32603]: ---------------------------- MPD announces state update: player
Sep 01 09:58:06 volumio volumio[32603]: info: ControllerMpd::getState
Sep 01 09:58:06 volumio volumio[32603]: verbose: ControllerMpd::sendMpdCommand status
Sep 01 09:58:06 volumio volumio[32603]: info: ------------------------------ 3ms
Sep 01 09:58:06 volumio volumio[32603]: verbose: ControllerMpd::parseState
Sep 01 09:58:06 volumio volumio[32603]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 01 09:58:06 volumio volumio[32603]: verbose: ControllerMpd::parseTrackInfo
Sep 01 09:58:06 volumio volumio[32603]: info: ControllerMpd::pushState
Sep 01 09:58:06 volumio volumio[32603]: info: CoreCommandRouter::servicePushState
Sep 01 09:58:06 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:06 volumio volumio[32603]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":321,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tears Of Joy","artist":"Antonio Forcione","album":null,"uri":"USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 2/01 Tears Of Joy.wav","trackType":"wav"}
Sep 01 09:58:06 volumio volumio[32603]: verbose: CURRENT POSITION 0
Sep 01 09:58:06 volumio volumio[32603]: info: CoreStateMachine::syncState stateService play
Sep 01 09:58:06 volumio volumio[32603]: info: CoreStateMachine::syncState currentStatus play
Sep 01 09:58:06 volumio volumio[32603]: info: Received an update from plugin. extracting info from payload
Sep 01 09:58:06 volumio volumio[32603]: info: CoreStateMachine::pushState
Sep 01 09:58:06 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:06 volumio volumio[32603]: info: CoreCommandRouter::volumioPushState
Sep 01 09:58:06 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:58:06 volumio volumio[32603]: info: CoreStateMachine::pushState
Sep 01 09:58:06 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:06 volumio volumio[32603]: info: CoreCommandRouter::volumioPushState
Sep 01 09:58:06 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:58:06 volumio volumio[32603]: info: ------------------------------ 21ms
Sep 01 09:58:07 volumio volumio[32603]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Antonio%20Forcione/b2f2914c-06cd-4084-ba9a-0b465af2343e.jpg'
Sep 01 09:58:07 volumio volumio[32603]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Antonio%20Forcione/b2f2914c-06cd-4084-ba9a-0b465af2343e.jpg'
Sep 01 09:58:07 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:58:13 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:58:15 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Sep 01 09:58:15 volumio volumio[32603]: info: CURURI: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3
Sep 01 09:58:16 volumio volumio[32603]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 01 09:58:16 volumio volumio[32603]: info: CoreStateMachine::ClearQueue
Sep 01 09:58:16 volumio volumio[32603]: info: CoreStateMachine::stop
Sep 01 09:58:16 volumio volumio[32603]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 01 09:58:16 volumio volumio[32603]: UNSET VOLATILE
Sep 01 09:58:16 volumio volumio[32603]: info: CoreStateMachine::stPlaybackTimer
Sep 01 09:58:16 volumio volumio[32603]: info: CoreStateMachine::updateTrackBlock
Sep 01 09:58:16 volumio volumio[32603]: info: CorePlayQueue::getTrackBlock
Sep 01 09:58:16 volumio volumio[32603]: info: CoreStateMachine::pushState
Sep 01 09:58:16 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:16 volumio volumio[32603]: info: CoreCommandRouter::volumioPushState
Sep 01 09:58:16 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:58:16 volumio volumio[32603]: info: CoreStateMachine::serviceStop
Sep 01 09:58:16 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:16 volumio volumio[32603]: info: CoreCommandRouter::serviceStop
Sep 01 09:58:16 volumio volumio[32603]: info: ControllerMpd::stop
Sep 01 09:58:16 volumio volumio[32603]: verbose: ControllerMpd::sendMpdCommand stop
Sep 01 09:58:16 volumio volumio[32603]: info: CorePlayQueue::clearPlayQueue
Sep 01 09:58:16 volumio volumio[32603]: info: CorePlayQueue::saveQueue
Sep 01 09:58:16 volumio volumio[32603]: info: CoreCommandRouter::volumioPushState
Sep 01 09:58:16 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:58:16 volumio volumio[32603]: info: CoreCommandRouter::volumioPushQueue
Sep 01 09:58:16 volumio volumio[32603]: info: CoreStateMachine::addQueueItems
Sep 01 09:58:16 volumio volumio[32603]: info: CorePlayQueue::addQueueItems
Sep 01 09:58:16 volumio volumio[32603]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/01 And I Love Her.wav
Sep 01 09:58:16 volumio volumio[32603]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/01 And I Love Her.wav in service mpd
Sep 01 09:58:16 volumio volumio[32603]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/02 How it Feels.wav
Sep 01 09:58:16 volumio volumio[32603]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/02 How it Feels.wav in service mpd
Sep 01 09:58:16 volumio volumio[32603]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/03 Stormy Weather.wav
Sep 01 09:58:16 volumio volumio[32603]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/03 Stormy Weather.wav in service mpd
Sep 01 09:58:16 volumio volumio[32603]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/04 Moonlight on Spring River.wav
Sep 01 09:58:16 volumio volumio[32603]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/04 Moonlight on Spring River.wav in service mpd
Sep 01 09:58:16 volumio volumio[32603]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/05 These Days.wav
Sep 01 09:58:16 volumio volumio[32603]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/05 These Days.wav in service mpd
Sep 01 09:58:16 volumio volumio[32603]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/06 On a Long Lonely Night.wav
Sep 01 09:58:16 volumio volumio[32603]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/06 On a Long Lonely Night.wav in service mpd
Sep 01 09:58:16 volumio volumio[32603]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/07 My Treasure.wav
Sep 01 09:58:16 volumio volumio[32603]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/07 My Treasure.wav in service mpd
Sep 01 09:58:16 volumio volumio[32603]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/08 Leather.wav
Sep 01 09:58:16 volumio volumio[32603]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/08 Leather.wav in service mpd
Sep 01 09:58:16 volumio volumio[32603]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/09 Bop.wav
Sep 01 09:58:16 volumio volumio[32603]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/09 Bop.wav in service mpd
Sep 01 09:58:16 volumio volumio[32603]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/10 Too Darn Hot.wav
Sep 01 09:58:16 volumio volumio[32603]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/10 Too Darn Hot.wav in service mpd
Sep 01 09:58:16 volumio volumio[32603]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/12 In the Hall of the Mountain King.wav
Sep 01 09:58:16 volumio volumio[32603]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/12 In the Hall of the Mountain King.wav in service mpd
Sep 01 09:58:16 volumio volumio[32603]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/13 Far Beyond Driven.wav
Sep 01 09:58:16 volumio volumio[32603]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/13 Far Beyond Driven.wav in service mpd
Sep 01 09:58:16 volumio volumio[32603]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/14 The Black Cat Neighbourhood.wav
Sep 01 09:58:16 volumio volumio[32603]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/14 The Black Cat Neighbourhood.wav in service mpd
Sep 01 09:58:16 volumio volumio[32603]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/15 Med små skridt.wav
Sep 01 09:58:16 volumio volumio[32603]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/15 Med små skridt.wav in service mpd
Sep 01 09:58:16 volumio volumio[32603]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/16 Whisper (Remix).wav
Sep 01 09:58:16 volumio volumio[32603]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/16 Whisper (Remix).wav in service mpd
Sep 01 09:58:16 volumio volumio[32603]: info:
Sep 01 09:58:16 volumio volumio[32603]: ---------------------------- MPD announces state update: player
Sep 01 09:58:16 volumio volumio[32603]: info: ALBUMART /albumart?cacheid=492&web=Pat%20Metheny//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F01%20And%20I%20Love%20Her.wav&metadata=false
Sep 01 09:58:16 volumio volumio[32603]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/01 And I Love Her.wav
Sep 01 09:58:16 volumio volumio[32603]: info: ALBUMART /albumart?cacheid=492&web=Sophie%20Zelmani//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F02%20How%20it%20Feels.wav&metadata=false
Sep 01 09:58:16 volumio volumio[32603]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/02 How it Feels.wav
Sep 01 09:58:16 volumio volumio[32603]: info: ALBUMART /albumart?cacheid=492&web=Teitur//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F03%20Stormy%20Weather.wav&metadata=false
Sep 01 09:58:16 volumio volumio[32603]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/03 Stormy Weather.wav
Sep 01 09:58:16 volumio volumio[32603]: info: ALBUMART /albumart?cacheid=492&web=Zhao%20Cong//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F04%20Moonlight%20on%20Spring%20River.wav&metadata=false
Sep 01 09:58:16 volumio volumio[32603]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/04 Moonlight on Spring River.wav
Sep 01 09:58:16 volumio volumio[32603]: info: ALBUMART /albumart?cacheid=492&web=Ane%20Brun//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F05%20These%20Days.wav&metadata=false
Sep 01 09:58:16 volumio volumio[32603]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/05 These Days.wav
Sep 01 09:58:16 volumio volumio[32603]: info: ALBUMART /albumart?cacheid=492&web=Sko%2FTorp//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F06%20On%20a%20Long%20Lonely%20Night.wav&metadata=false
Sep 01 09:58:16 volumio volumio[32603]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/06 On a Long Lonely Night.wav
Sep 01 09:58:16 volumio volumio[32603]: info: ALBUMART /albumart?cacheid=492&web=Sinne%20Eeg//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F07%20My%20Treasure.wav&metadata=false
Sep 01 09:58:16 volumio volumio[32603]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/07 My Treasure.wav
Sep 01 09:58:16 volumio volumio[32603]: info: ALBUMART /albumart?cacheid=492&web=OP8//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F08%20Leather.wav&metadata=false
Sep 01 09:58:16 volumio volumio[32603]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/08 Leather.wav
Sep 01 09:58:16 volumio volumio[32603]: info: ALBUMART /albumart?cacheid=492&web=The%20Brandt%20Brauer%20Flick%20Ensemble//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F09%20Bop.wav&metadata=false
Sep 01 09:58:16 volumio volumio[32603]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/09 Bop.wav
Sep 01 09:58:16 volumio volumio[32603]: info: ALBUMART /albumart?cacheid=492&web=Jan%20Harbeck%20Quartet//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F10%20Too%20Darn%20Hot.wav&metadata=false
Sep 01 09:58:16 volumio volumio[32603]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/10 Too Darn Hot.wav
Sep 01 09:58:16 volumio volumio[32603]: info: ALBUMART /albumart?cacheid=492&web=Grieg//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F12%20In%20the%20Hall%20of%20the%20Mountain%20King.wav&metadata=false
Sep 01 09:58:16 volumio volumio[32603]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/12 In the Hall of the Mountain King.wav
Sep 01 09:58:16 volumio volumio[32603]: info: ALBUMART /albumart?cacheid=492&web=Tim%20Christensen//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F13%20Far%20Beyond%20Driven.wav&metadata=false
Sep 01 09:58:16 volumio volumio[32603]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/13 Far Beyond Driven.wav
Sep 01 09:58:16 volumio volumio[32603]: info: ALBUMART /albumart?cacheid=492&web=Fallulah//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F14%20The%20Black%20Cat%20Neighbourhood.wav&metadata=false
Sep 01 09:58:16 volumio volumio[32603]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/14 The Black Cat Neighbourhood.wav
Sep 01 09:58:16 volumio volumio[32603]: info: ALBUMART /albumart?cacheid=492&web=Mike%20Sheridan//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F15%20Med%20sm%C3%A5%20skridt.wav&metadata=false
Sep 01 09:58:16 volumio volumio[32603]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/15 Med små skridt.wav
Sep 01 09:58:16 volumio volumio[32603]: info: ALBUMART /albumart?cacheid=492&web=Deadmou5//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F16%20Whisper%20(Remix).wav&metadata=false
Sep 01 09:58:16 volumio volumio[32603]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/16 Whisper (Remix).wav
Sep 01 09:58:16 volumio volumio[32603]: info: ControllerMpd::getState
Sep 01 09:58:16 volumio volumio[32603]: verbose: ControllerMpd::sendMpdCommand status
Sep 01 09:58:16 volumio volumio[32603]: info: CorePlayQueue::saveQueue
Sep 01 09:58:16 volumio volumio[32603]: info: CoreCommandRouter::volumioPushQueue
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::updateTrackBlock
Sep 01 09:58:17 volumio volumio[32603]: info: CorePlayQueue::getTrackBlock
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::volumioPlay
Sep 01 09:58:17 volumio volumio[32603]: UNSET VOLATILE
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::play index 0
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::stop
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 01 09:58:17 volumio volumio[32603]: UNSET VOLATILE
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::play index undefined
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 01 09:58:17 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::startPlaybackTimer
Sep 01 09:58:17 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::clearAddPlayTracks USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/01 And I Love Her.wav
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::sendMpdCommand stop
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::parseState
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::sendMpdCommand clear
Sep 01 09:58:17 volumio volumio[32603]: info:
Sep 01 09:58:17 volumio volumio[32603]: ---------------------------- MPD announces system playlist update
Sep 01 09:58:17 volumio volumio[32603]: info: Ignoring MPD Status Update
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::parseTrackInfo
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::sendMpdCommand add "USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/01 And I Love Her.wav"
Sep 01 09:58:17 volumio volumio[32603]: info: ControllerMpd::pushState
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::servicePushState
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::pushState
Sep 01 09:58:17 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::volumioPushState
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:58:17 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:17 volumio volumio[32603]: 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":"Tears Of Joy","artist":"Antonio Forcione","album":null,"uri":"USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 2/01 Tears Of Joy.wav","trackType":"wav"}
Sep 01 09:58:17 volumio volumio[32603]: verbose: CURRENT POSITION 0
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::syncState stateService stop
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::syncState currentStatus stop
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::pushState
Sep 01 09:58:17 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::volumioPushState
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:58:17 volumio volumio[32603]: info: No code
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::pushState
Sep 01 09:58:17 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::volumioPushState
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:58:17 volumio volumio[32603]: info: ------------------------------ 64ms
Sep 01 09:58:17 volumio volumio[32603]: error: updateQueue error: null
Sep 01 09:58:17 volumio volumio[32603]: info:
Sep 01 09:58:17 volumio volumio[32603]: ---------------------------- MPD announces system playlist update
Sep 01 09:58:17 volumio volumio[32603]: info: Ignoring MPD Status Update
Sep 01 09:58:17 volumio volumio[32603]: info: ------------------------------ 27ms
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::sendMpdCommand play
Sep 01 09:58:17 volumio volumio[32603]: info: ------------------------------ 6ms
Sep 01 09:58:17 volumio volumio[32603]: info:
Sep 01 09:58:17 volumio volumio[32603]: ---------------------------- MPD announces state update: player
Sep 01 09:58:17 volumio volumio[32603]: info: ControllerMpd::getState
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::sendMpdCommand status
Sep 01 09:58:17 volumio volumio[32603]: info:
Sep 01 09:58:17 volumio volumio[32603]: ---------------------------- MPD announces state update: player
Sep 01 09:58:17 volumio volumio[32603]: info: ControllerMpd::getState
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::sendMpdCommand status
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::parseState
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::parseState
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::parseTrackInfo
Sep 01 09:58:17 volumio volumio[32603]: info: ControllerMpd::pushState
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::servicePushState
Sep 01 09:58:17 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:17 volumio volumio[32603]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"And I Love Her","artist":"Pat Metheny","album":null,"uri":"USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/01 And I Love Her.wav","trackType":"wav"}
Sep 01 09:58:17 volumio volumio[32603]: verbose: CURRENT POSITION 0
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::syncState stateService play
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::syncState currentStatus stop
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::pushState
Sep 01 09:58:17 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::volumioPushState
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:58:17 volumio volumio[32603]: info: ------------------------------ 43ms
Sep 01 09:58:17 volumio volumio[32603]: verbose: ControllerMpd::parseTrackInfo
Sep 01 09:58:17 volumio volumio[32603]: info: ControllerMpd::pushState
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::servicePushState
Sep 01 09:58:17 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:17 volumio volumio[32603]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"And I Love Her","artist":"Pat Metheny","album":null,"uri":"USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/01 And I Love Her.wav","trackType":"wav"}
Sep 01 09:58:17 volumio volumio[32603]: verbose: CURRENT POSITION 0
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::syncState stateService play
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::syncState currentStatus play
Sep 01 09:58:17 volumio volumio[32603]: info: Received an update from plugin. extracting info from payload
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::pushState
Sep 01 09:58:17 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::volumioPushState
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:58:17 volumio volumio[32603]: info: CoreStateMachine::pushState
Sep 01 09:58:17 volumio volumio[32603]: info: CorePlayQueue::getTrack 0
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::volumioPushState
Sep 01 09:58:17 volumio volumio[32603]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:58:17 volumio volumio[32603]: info: ------------------------------ 46ms
Sep 01 09:58:19 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:58:25 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:58:31 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:58:37 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:58:42 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:58:48 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:58:51 volumio volumio[32603]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 01 09:58:51 volumio volumio[32603]: { Error: connect ETIMEDOUT 202.53.137.209:80
Sep 01 09:58:51 volumio volumio[32603]: at Object._errnoException (util.js:1022:11)
Sep 01 09:58:51 volumio volumio[32603]: at _exceptionWithHostPort (util.js:1044:20)
Sep 01 09:58:51 volumio volumio[32603]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Sep 01 09:58:51 volumio volumio[32603]: code: 'ETIMEDOUT',
Sep 01 09:58:51 volumio volumio[32603]: errno: 'ETIMEDOUT',
Sep 01 09:58:51 volumio volumio[32603]: syscall: 'connect',
Sep 01 09:58:51 volumio volumio[32603]: address: '202.53.137.209',
Sep 01 09:58:51 volumio volumio[32603]: port: 80 }
Sep 01 09:58:51 volumio volumio[32603]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 01 09:58:52 volumio sudo[17740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-01 09:57
Sep 01 09:58:52 volumio sudo[17740]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 09:58:52 volumio sudo[17740]: pam_unix(sudo:session): session closed for user root
Sep 01 09:58:54 volumio volumio-remote-updater[607]: [2024-09-01 09:58:54] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 01 09:58:54 volumio volumio-remote-updater[607]: [2024-09-01 09:58:54] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 01 09:58:54 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Sep 01 09:58:54 volumio systemd[1]: Unit volumio.service entered failed state.
Sep 01 09:58:54 volumio systemd[1]: Starting dynamicswap service...
Sep 01 09:58:54 volumio systemd[1]: Started dynamicswap service.
Sep 01 09:58:54 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:58:54 volumio systemd[1]: volumio.service holdoff time over, scheduling restart.
Sep 01 09:58:54 volumio systemd[1]: Starting dynamicswap service...
Sep 01 09:58:54 volumio systemd[1]: Started dynamicswap service.
Sep 01 09:58:54 volumio systemd[1]: Stopping Volumio Backend Module...
Sep 01 09:58:54 volumio systemd[1]: Starting Volumio Backend Module...
Sep 01 09:58:54 volumio systemd[1]: Started Volumio Backend Module.
Sep 01 09:58:56 volumio volumio[17769]: info: -------------------------------------------
Sep 01 09:58:56 volumio volumio[17769]: info: ----- Volumio2 ----
Sep 01 09:58:56 volumio volumio[17769]: info: -------------------------------------------
Sep 01 09:58:56 volumio volumio[17769]: info: ----- System startup ----
Sep 01 09:58:56 volumio volumio[17769]: info: -------------------------------------------
Sep 01 09:58:57 volumio volumio[17769]: info: MYVOLUMIO Environment detected
Sep 01 09:58:57 volumio volumio[17769]: info: Plugin folders cleanup
Sep 01 09:58:57 volumio volumio[17769]: info: Scanning into folder /volumio/app/plugins/
Sep 01 09:58:57 volumio volumio[17769]: info: Scanning category audio_interface
Sep 01 09:58:57 volumio volumio[17769]: info: Scanning category miscellanea
Sep 01 09:58:57 volumio volumio[17769]: info: Scanning category music_service
Sep 01 09:58:57 volumio volumio[17769]: info: Scanning category plugins.json
Sep 01 09:58:57 volumio volumio[17769]: info: Scanning category system_controller
Sep 01 09:58:57 volumio volumio[17769]: info: Scanning category user_interface
Sep 01 09:58:57 volumio volumio[17769]: info: Scanning into folder /data/plugins/
Sep 01 09:58:57 volumio volumio[17769]: info: Plugin folders cleanup completed
Sep 01 09:58:57 volumio volumio[17769]: info: -------------------------------------------
Sep 01 09:58:57 volumio volumio[17769]: info: ----- Core plugins startup ----
Sep 01 09:58:57 volumio volumio[17769]: info: -------------------------------------------
Sep 01 09:58:57 volumio volumio[17769]: info: Loading plugins from folder /volumio/app/plugins/
Sep 01 09:58:57 volumio volumio[17769]: info: Adding plugin upnp to MyMusic Plugins
Sep 01 09:58:57 volumio volumio[17769]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 01 09:58:57 volumio volumio[17769]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 01 09:58:57 volumio volumio[17769]: info: Loading plugins from folder /data/plugins/
Sep 01 09:58:57 volumio volumio[17769]: info: Loading plugin "system"...
Sep 01 09:58:57 volumio volumio[17769]: info: Loading plugin "appearance"...
Sep 01 09:58:59 volumio volumio[17769]: info: Loading plugin "network"...
Sep 01 09:58:59 volumio volumio[17769]: info: Refreshing Cached IP Addresses
Sep 01 09:58:59 volumio sudo[17791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 01 09:58:59 volumio volumio[17769]: info: Loading plugin "services"...
Sep 01 09:58:59 volumio sudo[17791]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 09:58:59 volumio volumio[17769]: info: Loading plugin "alsa_controller"...
Sep 01 09:58:59 volumio sudo[17794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 01 09:58:59 volumio sudo[17791]: pam_unix(sudo:session): session closed for user root
Sep 01 09:58:59 volumio sudo[17794]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 09:58:59 volumio sudo[17794]: pam_unix(sudo:session): session closed for user root
Sep 01 09:58:59 volumio volumio[17769]: info: Loading plugin "wizard"...
Sep 01 09:58:59 volumio volumio[17769]: info: Loading plugin "volumio_command_line_client"...
Sep 01 09:58:59 volumio volumio[17769]: info: Loading plugin "upnp"...
Sep 01 09:58:59 volumio volumio[17769]: info: [1725184739234] Starting Upmpd Daemon
Sep 01 09:58:59 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 01 09:58:59 volumio volumio[17769]: info: Loading plugin "my_music"...
Sep 01 09:58:59 volumio volumio[17769]: info: Loading plugin "mpd"...
Sep 01 09:58:59 volumio volumio-remote-updater[607]: [2024-09-01 09:58:59] [connect] Successful connection
Sep 01 09:58:59 volumio volumio[17769]: info: Loading plugin "upnp_browser"...
Sep 01 09:59:00 volumio volumio[17769]: info: Loading plugin "networkfs"...
Sep 01 09:59:00 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:59:00 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 01 09:59:00 volumio volumio[17769]: info: Loading plugin "alarm-clock"...
Sep 01 09:59:00 volumio sudo[17817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=40497731,password=123456,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //LNASC5EB/公共空间 /mnt/NAS/公共空间
Sep 01 09:59:00 volumio sudo[17817]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 09:59:00 volumio volumio[17769]: info: Loading plugin "airplay_emulation"...
Sep 01 09:59:00 volumio volumio[17769]: info: Starting Shairport Sync
Sep 01 09:59:00 volumio volumio[17769]: info: Loading plugin "last_100"...
Sep 01 09:59:00 volumio volumio[17769]: info: Loading plugin "webradio"...
Sep 01 09:59:00 volumio volumio[17769]: info: Loading plugin "i2s_dacs"...
Sep 01 09:59:00 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 09:59:00 volumio volumio[17769]: info: Loading plugin "volumiodiscovery"...
Sep 01 09:59:00 volumio volumio[17769]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 01 09:59:00 volumio node[17769]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 01 09:59:00 volumio node[17769]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 01 09:59:00 volumio node[17769]: *** WARNING *** For more information see
Sep 01 09:59:00 volumio node[17769]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 01 09:59:00 volumio node[17769]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 01 09:59:00 volumio node[17769]: *** WARNING *** For more information see
Sep 01 09:59:00 volumio volumio[17769]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 01 09:59:00 volumio volumio[17769]: *** WARNING *** For more information see
Sep 01 09:59:00 volumio volumio[17769]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 01 09:59:00 volumio volumio[17769]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 01 09:59:00 volumio volumio[17769]: *** WARNING *** For more information see
Sep 01 09:59:00 volumio volumio[17769]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 01 09:59:00 volumio volumio[17769]: Discovery: StartAdv! undefined
Sep 01 09:59:00 volumio volumio[17769]: Discovery: Started advertising... Volumio - undefined
Sep 01 09:59:00 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 01 09:59:00 volumio volumio[17769]: info: Loading plugin "outputs"...
Sep 01 09:59:00 volumio volumio[17769]: info: Loading plugin "albumart"...
Sep 01 09:59:00 volumio volumio[17769]: info: Plugin example_plugin is not enabled
Sep 01 09:59:00 volumio volumio[17769]: info: Loading plugin "inputs"...
Sep 01 09:59:00 volumio sudo[17817]: pam_unix(sudo:session): session closed for user root
Sep 01 09:59:00 volumio volumio[17769]: info: Loading plugin "updater_comm"...
Sep 01 09:59:01 volumio volumio[17769]: info: Plugin mpdemulation is not enabled
Sep 01 09:59:01 volumio volumio[17769]: info: Loading plugin "rest_api"...
Sep 01 09:59:01 volumio volumio[17769]: info: Loading plugin "websocket"...
Sep 01 09:59:01 volumio volumio[17769]: info: ___________ START PLUGINS ___________
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 01 09:59:01 volumio volumio[17769]: info: [1725184741210] CoreMusicLibrary::Adding element Media Servers
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 01 09:59:01 volumio volumio[17769]: Forking 3 albumart workers
Sep 01 09:59:01 volumio volumio[17769]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 01 09:59:01 volumio volumio[17769]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 01 09:59:01 volumio volumio[17769]: info: [1725184741353] CoreMusicLibrary::Adding element Last_100
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 01 09:59:01 volumio volumio[17769]: info: [1725184741359] CoreMusicLibrary::Adding element Webradio
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 01 09:59:01 volumio volumio[17769]: info: -------------------------------------------
Sep 01 09:59:01 volumio volumio[17769]: info: ----- MyVolumio plugins startup ----
Sep 01 09:59:01 volumio volumio[17769]: info: -------------------------------------------
Sep 01 09:59:01 volumio volumio[17769]: info: [MyVolumio PluginManager] Fetching plans data....
Sep 01 09:59:01 volumio volumio[17769]: info: Loading i18n strings for locale zh
Sep 01 09:59:01 volumio volumio[17769]: Updating browse sources language
Sep 01 09:59:01 volumio volumio[17769]: Cannot find translation for sourceMedia Servers
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::initPlayerControls
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 01 09:59:01 volumio volumio[17769]: info: BOOT COMPLETED
Sep 01 09:59:01 volumio volumio[17769]: [Metrics] CommandRouter: 4s 896.71ms
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 09:59:01 volumio volumio[17769]: aplay: main:722: audio open error: Device or resource busy
Sep 01 09:59:01 volumio volumio[17769]: Cannot play startup sound
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::Close All Modals sent
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::Close All Modals sent
Sep 01 09:59:01 volumio volumio[17769]: Express server listening on port 3000
Sep 01 09:59:01 volumio volumio[17769]: [Metrics] WebUI: 5s 580.41ms
Sep 01 09:59:01 volumio volumio[17769]: Volumio Calling Home
Sep 01 09:59:01 volumio volumio[17769]: info: CoreStateMachine::resetVolumioState
Sep 01 09:59:01 volumio volumio[17769]: info: CoreStateMachine::getcurrentVolume
Sep 01 09:59:01 volumio volumio[17769]: info: CoreCommandRouter::volumioRetrievevolume
Sep 01 09:59:02 volumio volumio[17769]: info: Setting Device type: Raspberry PI
Sep 01 09:59:02 volumio volumio[17769]: info: Cannot mount NAS 公共空间 at system boot, trial number 1 ,retrying in 5 seconds
Sep 01 09:59:02 volumio volumio[17769]: info: MPD running with PID656
Sep 01 09:59:02 volumio volumio[17769]: ,establishing connection
Sep 01 09:59:02 volumio volumio[17769]: Starting albumart workers
Sep 01 09:59:02 volumio volumio[17769]: Starting albumart workers
Sep 01 09:59:02 volumio volumio-remote-updater[607]: [2024-09-01 09:59:02] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1725184739 101
Sep 01 09:59:02 volumio volumio[17769]: Starting albumart workers
Sep 01 09:59:02 volumio volumio[17769]: info: VolumeController:: Volume=100 Mute =false
Sep 01 09:59:02 volumio volumio[17769]: info: CoreStateMachine::pushState
Sep 01 09:59:02 volumio volumio[17769]: info: CorePlayQueue::getTrack 0
Sep 01 09:59:02 volumio volumio[17769]: info: CoreCommandRouter::volumioPushState
Sep 01 09:59:02 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:59:02 volumio volumio[17769]: info: CoreStateMachine::updateTrackBlock
Sep 01 09:59:02 volumio volumio[17769]: info: CorePlayQueue::getTrackBlock
Sep 01 09:59:02 volumio volumio[17769]: info: CoreCommandRouter::volumioRetrievevolume
Sep 01 09:59:02 volumio volumio[17769]: info: Reloading queue from file
Sep 01 09:59:02 volumio volumio[17769]: info: CoreCommandRouter::volumioGetState
Sep 01 09:59:02 volumio volumio[17769]: info: CorePlayQueue::getTrack 0
Sep 01 09:59:02 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Sep 01 09:59:02 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Sep 01 09:59:02 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Sep 01 09:59:02 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Sep 01 09:59:02 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Sep 01 09:59:02 volumio volumio[17769]: info: CoreStateMachine::setRepeat true single undefined
Sep 01 09:59:02 volumio volumio[17769]: info: CoreStateMachine::pushState
Sep 01 09:59:02 volumio volumio[17769]: info: CorePlayQueue::getTrack 0
Sep 01 09:59:02 volumio volumio[17769]: info: CoreCommandRouter::volumioPushState
Sep 01 09:59:02 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:59:02 volumio volumio[17769]: info: CoreStateMachine::setRandom false
Sep 01 09:59:02 volumio volumio[17769]: info: CoreStateMachine::pushState
Sep 01 09:59:02 volumio volumio[17769]: info: CorePlayQueue::getTrack 0
Sep 01 09:59:02 volumio volumio[17769]: info: CoreCommandRouter::volumioPushState
Sep 01 09:59:02 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:59:02 volumio volumio[17769]: info: Starting Shairport Sync
Sep 01 09:59:02 volumio volumio[17769]: info: Starting Shairport Sync
Sep 01 09:59:03 volumio volumio[17769]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Pat%20Metheny/8d08851c-0dff-42ca-aabf-710f8dfc12d0.jpg'
Sep 01 09:59:03 volumio sudo[17893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 01 09:59:03 volumio sudo[17896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 01 09:59:03 volumio volumio[17769]: info: CoreCommandRouter::volumioGetState
Sep 01 09:59:03 volumio volumio[17769]: info: CorePlayQueue::getTrack 0
Sep 01 09:59:03 volumio sudo[17893]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 09:59:03 volumio sudo[17896]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 09:59:03 volumio volumio[17769]: info: VolumeController:: Volume=100 Mute =false
Sep 01 09:59:03 volumio volumio[17769]: info: CoreStateMachine::pushState
Sep 01 09:59:03 volumio volumio[17769]: info: CorePlayQueue::getTrack 0
Sep 01 09:59:03 volumio volumio[17769]: info: CoreCommandRouter::volumioPushState
Sep 01 09:59:03 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:59:03 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 01 09:59:03 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Sep 01 09:59:03 volumio sudo[17893]: pam_unix(sudo:session): session closed for user root
Sep 01 09:59:03 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 01 09:59:03 volumio sudo[17896]: pam_unix(sudo:session): session closed for user root
Sep 01 09:59:03 volumio volumio[17769]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Pat%20Metheny/8d08851c-0dff-42ca-aabf-710f8dfc12d0.jpg'
Sep 01 09:59:03 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 01 09:59:03 volumio volumio[17769]: info: Listing playlists
Sep 01 09:59:03 volumio volumio[17769]: info: CoreCommandRouter::volumioGetQueue
Sep 01 09:59:03 volumio volumio[17769]: info: CoreStateMachine::getQueue
Sep 01 09:59:03 volumio volumio[17769]: info: CorePlayQueue::getQueue
Sep 01 09:59:03 volumio volumio[17769]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 01 09:59:03 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 01 09:59:03 volumio volumio[17769]: Discovery: adding fa89d542-baa4-47d4-b1da-73c4f9a9454e
Sep 01 09:59:03 volumio volumio[17769]: info: mDNS: Found device Volumio
Sep 01 09:59:03 volumio volumio[17769]: info: CoreCommandRouter::volumioGetState
Sep 01 09:59:03 volumio volumio[17769]: info: CorePlayQueue::getTrack 0
Sep 01 09:59:03 volumio volumio[17769]: info: Shairport-Sync Started
Sep 01 09:59:03 volumio volumio[17769]: Error adding Membership: Error: addMembership EINVAL
Sep 01 09:59:03 volumio volumio[17769]: info: Shairport-Sync Started
Sep 01 09:59:04 volumio volumio[17769]: info: CoreCommandRouter::volumioGetState
Sep 01 09:59:04 volumio volumio[17769]: info: CorePlayQueue::getTrack 0
Sep 01 09:59:05 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 09:59:05 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 09:59:06 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:59:06 volumio volumio[17769]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Pat%20Metheny/8d08851c-0dff-42ca-aabf-710f8dfc12d0.jpg'
Sep 01 09:59:07 volumio sudo[17939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=40497731,password=123456,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //LNASC5EB/公共空间 /mnt/NAS/公共空间
Sep 01 09:59:07 volumio sudo[17939]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 09:59:07 volumio sudo[17939]: pam_unix(sudo:session): session closed for user root
Sep 01 09:59:07 volumio volumio[17769]: info: Cannot mount NAS 公共空间 at system boot, trial number 2 ,retrying in 5 seconds
Sep 01 09:59:09 volumio sudo[17972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 01 09:59:09 volumio sudo[17972]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 09:59:09 volumio sudo[17974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 01 09:59:09 volumio sudo[17972]: pam_unix(sudo:session): session closed for user root
Sep 01 09:59:09 volumio sudo[17974]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 09:59:09 volumio sudo[17974]: pam_unix(sudo:session): session closed for user root
Sep 01 09:59:09 volumio sudo[17988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Sep 01 09:59:09 volumio sudo[17988]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 09:59:09 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Sep 01 09:59:09 volumio sudo[17988]: pam_unix(sudo:session): session closed for user root
Sep 01 09:59:09 volumio volumio[17769]: info: Upmpdcli Daemon Started
Sep 01 09:59:11 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:59:12 volumio volumio[17769]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=d5b49e2a9ca827b39b2da4972ee387bb" http://updates.volumio.org:7070/downloader-v1/track-device
Sep 01 09:59:12 volumio volumio[17769]: % Total % Received % Xferd Average Speed Time Time Time Current
Sep 01 09:59:12 volumio volumio[17769]: Dload Upload Total Spent Left Speed
Sep 01 09:59:12 volumio volumio[17769]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused
Sep 01 09:59:12 volumio volumio[17769]: retrying in 5 seconds, trial 0
Sep 01 09:59:12 volumio volumio[17769]: Volumio Calling Home
Sep 01 09:59:12 volumio sudo[18005]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=40497731,password=123456,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //LNASC5EB/公共空间 /mnt/NAS/公共空间
Sep 01 09:59:12 volumio sudo[18005]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 09:59:12 volumio sudo[18005]: pam_unix(sudo:session): session closed for user root
Sep 01 09:59:12 volumio volumio[17769]: info: Cannot mount NAS 公共空间 at system boot, trial number 3 ,retrying in 5 seconds
Sep 01 09:59:13 volumio volumio[17769]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::ClearQueue
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::stop
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 01 09:59:13 volumio volumio[17769]: UNSET VOLATILE
Sep 01 09:59:13 volumio volumio[17769]: info: CorePlayQueue::clearPlayQueue
Sep 01 09:59:13 volumio volumio[17769]: info: CorePlayQueue::saveQueue
Sep 01 09:59:13 volumio volumio[17769]: info: CoreCommandRouter::volumioPushState
Sep 01 09:59:13 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:59:13 volumio volumio[17769]: info: CoreCommandRouter::volumioPushQueue
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::addQueueItems
Sep 01 09:59:13 volumio volumio[17769]: info: CorePlayQueue::addQueueItems
Sep 01 09:59:13 volumio volumio[17769]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/01 And I Love Her.wav
Sep 01 09:59:13 volumio volumio[17769]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/01 And I Love Her.wav in service mpd
Sep 01 09:59:13 volumio volumio[17769]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/02 How it Feels.wav
Sep 01 09:59:13 volumio volumio[17769]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/02 How it Feels.wav in service mpd
Sep 01 09:59:13 volumio volumio[17769]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/03 Stormy Weather.wav
Sep 01 09:59:13 volumio volumio[17769]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/03 Stormy Weather.wav in service mpd
Sep 01 09:59:13 volumio volumio[17769]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/04 Moonlight on Spring River.wav
Sep 01 09:59:13 volumio volumio[17769]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/04 Moonlight on Spring River.wav in service mpd
Sep 01 09:59:13 volumio volumio[17769]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/05 These Days.wav
Sep 01 09:59:13 volumio volumio[17769]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/05 These Days.wav in service mpd
Sep 01 09:59:13 volumio volumio[17769]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/06 On a Long Lonely Night.wav
Sep 01 09:59:13 volumio volumio[17769]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/06 On a Long Lonely Night.wav in service mpd
Sep 01 09:59:13 volumio volumio[17769]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/07 My Treasure.wav
Sep 01 09:59:13 volumio volumio[17769]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/07 My Treasure.wav in service mpd
Sep 01 09:59:13 volumio volumio[17769]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/08 Leather.wav
Sep 01 09:59:13 volumio volumio[17769]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/08 Leather.wav in service mpd
Sep 01 09:59:13 volumio volumio[17769]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/09 Bop.wav
Sep 01 09:59:13 volumio volumio[17769]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/09 Bop.wav in service mpd
Sep 01 09:59:13 volumio volumio[17769]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/10 Too Darn Hot.wav
Sep 01 09:59:13 volumio volumio[17769]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/10 Too Darn Hot.wav in service mpd
Sep 01 09:59:13 volumio volumio[17769]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/12 In the Hall of the Mountain King.wav
Sep 01 09:59:13 volumio volumio[17769]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/12 In the Hall of the Mountain King.wav in service mpd
Sep 01 09:59:13 volumio volumio[17769]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/13 Far Beyond Driven.wav
Sep 01 09:59:13 volumio volumio[17769]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/13 Far Beyond Driven.wav in service mpd
Sep 01 09:59:13 volumio volumio[17769]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/14 The Black Cat Neighbourhood.wav
Sep 01 09:59:13 volumio volumio[17769]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/14 The Black Cat Neighbourhood.wav in service mpd
Sep 01 09:59:13 volumio volumio[17769]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/15 Med små skridt.wav
Sep 01 09:59:13 volumio volumio[17769]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/15 Med små skridt.wav in service mpd
Sep 01 09:59:13 volumio volumio[17769]: info: Adding Item to queue: music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/16 Whisper (Remix).wav
Sep 01 09:59:13 volumio volumio[17769]: info: Exploding uri music-library/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/16 Whisper (Remix).wav in service mpd
Sep 01 09:59:13 volumio volumio[17769]: info: ALBUMART /albumart?cacheid=492&web=Pat%20Metheny//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F01%20And%20I%20Love%20Her.wav&metadata=false
Sep 01 09:59:13 volumio volumio[17769]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/01 And I Love Her.wav
Sep 01 09:59:13 volumio volumio[17769]: info: ALBUMART /albumart?cacheid=492&web=Sophie%20Zelmani//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F02%20How%20it%20Feels.wav&metadata=false
Sep 01 09:59:13 volumio volumio[17769]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/02 How it Feels.wav
Sep 01 09:59:13 volumio volumio[17769]: info: ALBUMART /albumart?cacheid=492&web=Teitur//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F03%20Stormy%20Weather.wav&metadata=false
Sep 01 09:59:13 volumio volumio[17769]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/03 Stormy Weather.wav
Sep 01 09:59:13 volumio volumio[17769]: info: ALBUMART /albumart?cacheid=492&web=Zhao%20Cong//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F04%20Moonlight%20on%20Spring%20River.wav&metadata=false
Sep 01 09:59:13 volumio volumio[17769]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/04 Moonlight on Spring River.wav
Sep 01 09:59:13 volumio volumio[17769]: info: ALBUMART /albumart?cacheid=492&web=Ane%20Brun//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F05%20These%20Days.wav&metadata=false
Sep 01 09:59:13 volumio volumio[17769]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/05 These Days.wav
Sep 01 09:59:13 volumio volumio[17769]: info: ALBUMART /albumart?cacheid=492&web=Sko%2FTorp//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F06%20On%20a%20Long%20Lonely%20Night.wav&metadata=false
Sep 01 09:59:13 volumio volumio[17769]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/06 On a Long Lonely Night.wav
Sep 01 09:59:13 volumio volumio[17769]: info: ALBUMART /albumart?cacheid=492&web=Sinne%20Eeg//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F07%20My%20Treasure.wav&metadata=false
Sep 01 09:59:13 volumio volumio[17769]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/07 My Treasure.wav
Sep 01 09:59:13 volumio volumio[17769]: info: ALBUMART /albumart?cacheid=492&web=OP8//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F08%20Leather.wav&metadata=false
Sep 01 09:59:13 volumio volumio[17769]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/08 Leather.wav
Sep 01 09:59:13 volumio volumio[17769]: info: ALBUMART /albumart?cacheid=492&web=The%20Brandt%20Brauer%20Flick%20Ensemble//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F09%20Bop.wav&metadata=false
Sep 01 09:59:13 volumio volumio[17769]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/09 Bop.wav
Sep 01 09:59:13 volumio volumio[17769]: info: ALBUMART /albumart?cacheid=492&web=Jan%20Harbeck%20Quartet//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F10%20Too%20Darn%20Hot.wav&metadata=false
Sep 01 09:59:13 volumio volumio[17769]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/10 Too Darn Hot.wav
Sep 01 09:59:13 volumio volumio[17769]: info: ALBUMART /albumart?cacheid=492&web=Grieg//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F12%20In%20the%20Hall%20of%20the%20Mountain%20King.wav&metadata=false
Sep 01 09:59:13 volumio volumio[17769]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/12 In the Hall of the Mountain King.wav
Sep 01 09:59:13 volumio volumio[17769]: info: ALBUMART /albumart?cacheid=492&web=Tim%20Christensen//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F13%20Far%20Beyond%20Driven.wav&metadata=false
Sep 01 09:59:13 volumio volumio[17769]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/13 Far Beyond Driven.wav
Sep 01 09:59:13 volumio volumio[17769]: info: ALBUMART /albumart?cacheid=492&web=Fallulah//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F14%20The%20Black%20Cat%20Neighbourhood.wav&metadata=false
Sep 01 09:59:13 volumio volumio[17769]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/14 The Black Cat Neighbourhood.wav
Sep 01 09:59:13 volumio volumio[17769]: info: ALBUMART /albumart?cacheid=492&web=Mike%20Sheridan//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F15%20Med%20sm%C3%A5%20skridt.wav&metadata=false
Sep 01 09:59:13 volumio volumio[17769]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/15 Med små skridt.wav
Sep 01 09:59:13 volumio volumio[17769]: info: ALBUMART /albumart?cacheid=492&web=Deadmou5//extralarge&path=%2Fmnt%2FUSB%2F7EB6-34C8%2FDALI%20CD1~5%2FThe%20DALI%20CD%20Vol%203%2F16%20Whisper%20(Remix).wav&metadata=false
Sep 01 09:59:13 volumio volumio[17769]: info: URI /mnt/USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/16 Whisper (Remix).wav
Sep 01 09:59:13 volumio volumio[17769]: info: CorePlayQueue::saveQueue
Sep 01 09:59:13 volumio volumio[17769]: info: CoreCommandRouter::volumioPushQueue
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::updateTrackBlock
Sep 01 09:59:13 volumio volumio[17769]: info: CorePlayQueue::getTrackBlock
Sep 01 09:59:13 volumio volumio[17769]: info: CoreCommandRouter::volumioPlay
Sep 01 09:59:13 volumio volumio[17769]: UNSET VOLATILE
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::play index 1
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::stop
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 01 09:59:13 volumio volumio[17769]: UNSET VOLATILE
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::play index undefined
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 01 09:59:13 volumio volumio[17769]: info: CorePlayQueue::getTrack 1
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::startPlaybackTimer
Sep 01 09:59:13 volumio volumio[17769]: info: CorePlayQueue::getTrack 1
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::clearAddPlayTracks USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/02 How it Feels.wav
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::sendMpdCommand stop
Sep 01 09:59:13 volumio volumio[17769]: info:
Sep 01 09:59:13 volumio volumio[17769]: ---------------------------- MPD announces state update: player
Sep 01 09:59:13 volumio volumio[17769]: info: ControllerMpd::getState
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::sendMpdCommand status
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::sendMpdCommand clear
Sep 01 09:59:13 volumio volumio[17769]: info:
Sep 01 09:59:13 volumio volumio[17769]: ---------------------------- MPD announces system playlist update
Sep 01 09:59:13 volumio volumio[17769]: info: Ignoring MPD Status Update
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::parseState
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::sendMpdCommand add "USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/02 How it Feels.wav"
Sep 01 09:59:13 volumio volumio[17769]: error: updateQueue error: null
Sep 01 09:59:13 volumio volumio[17769]: info:
Sep 01 09:59:13 volumio volumio[17769]: ---------------------------- MPD announces system playlist update
Sep 01 09:59:13 volumio volumio[17769]: info: Ignoring MPD Status Update
Sep 01 09:59:13 volumio volumio[17769]: info: ------------------------------ 10ms
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::parseTrackInfo
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::sendMpdCommand play
Sep 01 09:59:13 volumio volumio[17769]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Sep 01 09:59:13 volumio volumio[17769]: info: ------------------------------ 29ms
Sep 01 09:59:13 volumio volumio[17769]: info: ------------------------------ 18ms
Sep 01 09:59:13 volumio volumio[17769]: info:
Sep 01 09:59:13 volumio volumio[17769]: ---------------------------- MPD announces state update: player
Sep 01 09:59:13 volumio volumio[17769]: info: ControllerMpd::getState
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::sendMpdCommand status
Sep 01 09:59:13 volumio volumio[17769]: info:
Sep 01 09:59:13 volumio volumio[17769]: ---------------------------- MPD announces state update: player
Sep 01 09:59:13 volumio volumio[17769]: info: ControllerMpd::getState
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::sendMpdCommand status
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::parseState
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::parseState
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::parseTrackInfo
Sep 01 09:59:13 volumio volumio[17769]: verbose: ControllerMpd::parseTrackInfo
Sep 01 09:59:13 volumio volumio[17769]: info: ControllerMpd::pushState
Sep 01 09:59:13 volumio volumio[17769]: info: CoreCommandRouter::servicePushState
Sep 01 09:59:13 volumio volumio[17769]: info: CorePlayQueue::getTrack 1
Sep 01 09:59:13 volumio volumio[17769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":236,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"How it Feels","artist":"Sophie Zelmani","album":null,"uri":"USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/02 How it Feels.wav","trackType":"wav"}
Sep 01 09:59:13 volumio volumio[17769]: verbose: CURRENT POSITION 1
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::syncState stateService play
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::syncState currentStatus stop
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::pushState
Sep 01 09:59:13 volumio volumio[17769]: info: CorePlayQueue::getTrack 1
Sep 01 09:59:13 volumio volumio[17769]: info: CoreCommandRouter::volumioPushState
Sep 01 09:59:13 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:59:13 volumio volumio[17769]: info: ControllerMpd::pushState
Sep 01 09:59:13 volumio volumio[17769]: info: CoreCommandRouter::servicePushState
Sep 01 09:59:13 volumio volumio[17769]: info: CorePlayQueue::getTrack 1
Sep 01 09:59:13 volumio volumio[17769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":236,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"How it Feels","artist":"Sophie Zelmani","album":null,"uri":"USB/7EB6-34C8/DALI CD1~5/The DALI CD Vol 3/02 How it Feels.wav","trackType":"wav"}
Sep 01 09:59:13 volumio volumio[17769]: verbose: CURRENT POSITION 1
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::syncState stateService play
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::syncState currentStatus play
Sep 01 09:59:13 volumio volumio[17769]: info: Received an update from plugin. extracting info from payload
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::pushState
Sep 01 09:59:13 volumio volumio[17769]: info: CorePlayQueue::getTrack 1
Sep 01 09:59:13 volumio volumio[17769]: info: CoreCommandRouter::volumioPushState
Sep 01 09:59:13 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:59:13 volumio volumio[17769]: info: CoreStateMachine::pushState
Sep 01 09:59:13 volumio volumio[17769]: info: CorePlayQueue::getTrack 1
Sep 01 09:59:13 volumio volumio[17769]: info: CoreCommandRouter::volumioPushState
Sep 01 09:59:13 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 09:59:13 volumio volumio[17769]: info: ------------------------------ 57ms
Sep 01 09:59:13 volumio volumio[17769]: info: ------------------------------ 56ms
Sep 01 09:59:17 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:59:18 volumio sudo[18030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=40497731,password=123456,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //LNASC5EB/公共空间 /mnt/NAS/公共空间
Sep 01 09:59:18 volumio sudo[18030]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 09:59:18 volumio sudo[18030]: pam_unix(sudo:session): session closed for user root
Sep 01 09:59:18 volumio volumio[17769]: info: Cannot mount NAS 公共空间 at system boot, trial number 4 ,retrying in 5 seconds
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Sep 01 09:59:19 volumio volumio[17769]: info: Adding plugin bluetooth to MyMusic Plugins
Sep 01 09:59:19 volumio volumio[17769]: info: Adding plugin cd_controller to MyMusic Plugins
Sep 01 09:59:19 volumio volumio[17769]: info: Adding plugin smart_inputs to MyMusic Plugins
Sep 01 09:59:19 volumio volumio[17769]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Sep 01 09:59:21 volumio volumio[17769]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Sep 01 09:59:22 volumio volumio[17769]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Sep 01 09:59:22 volumio volumio[17769]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Sep 01 09:59:22 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 09:59:22 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 09:59:22 volumio volumio[17769]: info: Starting MyVolumio Remote Streaming Endpoints
Sep 01 09:59:23 volumio volumio[17769]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Sep 01 09:59:23 volumio volumio[17769]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Sep 01 09:59:23 volumio volumio[17769]: info: Streaming services startup
Sep 01 09:59:23 volumio volumio[17769]: info: Starting Streaming Daemon
Sep 01 09:59:23 volumio volumio[17769]: info: MyVolumio not started
Sep 01 09:59:23 volumio volumio[17769]: info: Initializing device activation check
Sep 01 09:59:23 volumio sudo[18046]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Sep 01 09:59:23 volumio sudo[18046]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 09:59:23 volumio volumio[17769]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Sep 01 09:59:23 volumio systemd[1]: Stopping Volumio Streaming Daemon...
Sep 01 09:59:23 volumio systemd[1]: Starting Volumio Streaming Daemon...
Sep 01 09:59:23 volumio systemd[1]: Started Volumio Streaming Daemon.
Sep 01 09:59:23 volumio sudo[18046]: pam_unix(sudo:session): session closed for user root
Sep 01 09:59:23 volumio volumio-streaming-daemon[18052]: ############################
Sep 01 09:59:23 volumio volumio-streaming-daemon[18052]: # Volumio Streaming Daemon #
Sep 01 09:59:23 volumio volumio-streaming-daemon[18052]: # Running on port 7777 #
Sep 01 09:59:23 volumio volumio-streaming-daemon[18052]: ############################
Sep 01 09:59:23 volumio volumio-streaming-daemon[18052]: Environment: production
Sep 01 09:59:23 volumio volumio[17769]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=d5b49e2a9ca827b39b2da4972ee387bb" http://updates.volumio.org:7070/downloader-v1/track-device
Sep 01 09:59:23 volumio volumio[17769]: % Total % Received % Xferd Average Speed Time Time Time Current
Sep 01 09:59:23 volumio volumio[17769]: Dload Upload Total Spent Left Speed
Sep 01 09:59:23 volumio volumio[17769]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused
Sep 01 09:59:23 volumio volumio[17769]: retrying in 5 seconds, trial 1
Sep 01 09:59:23 volumio volumio[17769]: Volumio Calling Home
Sep 01 09:59:23 volumio sudo[18065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=40497731,password=123456,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //LNASC5EB/公共空间 /mnt/NAS/公共空间
Sep 01 09:59:23 volumio sudo[18065]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 09:59:23 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:59:23 volumio sudo[18065]: pam_unix(sudo:session): session closed for user root
Sep 01 09:59:23 volumio volumio[17769]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Sep 01 09:59:25 volumio volumio-streaming-daemon[18052]: Environment: production
Sep 01 09:59:25 volumio volumio[17769]: info: Fetching Streaming Services browse cache
Sep 01 09:59:26 volumio volumio[17769]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL
Sep 01 09:59:26 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 01 09:59:26 volumio volumio[17769]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ
Sep 01 09:59:26 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 01 09:59:29 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:59:31 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 01 09:59:31 volumio volumio[17769]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 09:59:33 volumio volumio[17769]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=d5b49e2a9ca827b39b2da4972ee387bb" http://updates.volumio.org:7070/downloader-v1/track-device
Sep 01 09:59:33 volumio volumio[17769]: % Total % Received % Xferd Average Speed Time Time Time Current
Sep 01 09:59:33 volumio volumio[17769]: Dload Upload Total Spent Left Speed
Sep 01 09:59:33 volumio volumio[17769]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused
Sep 01 09:59:33 volumio volumio[17769]: retrying in 5 seconds, trial 2
Sep 01 09:59:33 volumio volumio[17769]: Volumio Calling Home
Sep 01 09:59:35 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:59:41 volumio wpa_supplicant[1005]: wlan0: Failed to initiate sched scan
Sep 01 09:59:42 volumio volumio[17769]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 01 09:59:42 volumio volumio[17769]: { Error: connect ETIMEDOUT 108.160.165.141:80
Sep 01 09:59:42 volumio volumio[17769]: at Object._errnoException (util.js:1022:11)
Sep 01 09:59:42 volumio volumio[17769]: at _exceptionWithHostPort (util.js:1044:20)
Sep 01 09:59:42 volumio volumio[17769]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Sep 01 09:59:42 volumio volumio[17769]: code: 'ETIMEDOUT',
Sep 01 09:59:42 volumio volumio[17769]: errno: 'ETIMEDOUT',
Sep 01 09:59:42 volumio volumio[17769]: syscall: 'connect',
Sep 01 09:59:42 volumio volumio[17769]: address: '108.160.165.141',
Sep 01 09:59:42 volumio volumio[17769]: port: 80 }
Sep 01 09:59:42 volumio volumio[17769]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 01 09:59:43 volumio sudo[18127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-01 09:58
Sep 01 09:59:43 volumio sudo[18127]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="74e4cc9de715c64d553d35948d017f973a622b6d"
VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33"
VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Sep 24 22:42:43 CEST 2020"
VOLUMIO_VERSION="2.834"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="e41ef0f29aa50c1af109d3064a380c69"