-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Sat 2025-04-19 00:22:17 CST. -- Apr 19 00:21:09 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 19 00:21:09 volumio volumio[8005]: info: CURURI: music-library Apr 19 00:21:09 volumio volumio[8005]: info: Preload queue cleared Apr 19 00:21:19 volumio volumio[8005]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 19 00:21:19 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 19 00:21:19 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 19 00:21:19 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 19 00:21:19 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Apr 19 00:21:19 volumio volumio[8005]: info: Received Get System Version Apr 19 00:21:19 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 19 00:21:19 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Apr 19 00:21:35 volumio volumio[8005]: info: CALLMETHOD: miscellanea appearance setVolumio3UI [object Object] Apr 19 00:21:35 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: appearance , setVolumio3UI Apr 19 00:21:35 volumio volumio[8005]: info: Setting active UI to: {"uiPrettyName":"Manifest","uiName":"manifest","uiPath":"/volumio/http/www4"} Apr 19 00:21:35 volumio sudo[8492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/active_volumio_ui Apr 19 00:21:35 volumio sudo[8492]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 00:21:35 volumio sudo[8492]: pam_unix(sudo:session): session closed for user root Apr 19 00:21:36 volumio volumio[8005]: info: CoreCommandRouter::Reload Ui Apr 19 00:21:37 volumio sudo[8495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 19 00:21:37 volumio sudo[8495]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 00:21:37 volumio sudo[8495]: pam_unix(sudo:session): session closed for user root Apr 19 00:21:37 volumio sudo[8498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 19 00:21:37 volumio sudo[8498]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 00:21:37 volumio sudo[8498]: pam_unix(sudo:session): session closed for user root Apr 19 00:21:37 volumio volumio[8005]: verbose: New Socket.io Connection to 10.0.0.40 from 10.0.0.39 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.0.0 Safari/537.36 Edg/135.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Apr 19 00:21:37 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::volumioGetVisibleSources Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::volumioGetState Apr 19 00:21:38 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 19 00:21:38 volumio volumio[8005]: info: Received Get System Info Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 19 00:21:38 volumio volumio[8005]: info: Discovery: Getting this device information Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::volumioGetState Apr 19 00:21:38 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::volumioGetState Apr 19 00:21:38 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:38 volumio volumio[8005]: info: Listing playlists Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Apr 19 00:21:38 volumio volumio[8005]: info: Received Get System Version Apr 19 00:21:38 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 19 00:21:39 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 19 00:21:39 volumio volumio[8005]: info: Received Get System Info Apr 19 00:21:39 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 19 00:21:39 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 19 00:21:39 volumio volumio[8005]: info: Discovery: Getting this device information Apr 19 00:21:39 volumio volumio[8005]: info: CoreCommandRouter::volumioGetState Apr 19 00:21:39 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:39 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 19 00:21:39 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 19 00:21:41 volumio volumio[8005]: info: CoreCommandRouter::volumioGetState Apr 19 00:21:41 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:42 volumio volumio[8005]: info: CoreCommandRouter::volumioPause Apr 19 00:21:42 volumio volumio[8005]: info: CoreStateMachine::pause Apr 19 00:21:42 volumio volumio[8005]: info: CoreStateMachine::stPlaybackTimer Apr 19 00:21:42 volumio volumio[8005]: info: CoreStateMachine::servicePause Apr 19 00:21:42 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:42 volumio volumio[8005]: info: CoreCommandRouter::servicePause Apr 19 00:21:42 volumio volumio[8005]: info: ControllerMpd::pause Apr 19 00:21:42 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand pause Apr 19 00:21:42 volumio volumio[8005]: info: sendMpdCommand pause took 1 milliseconds Apr 19 00:21:42 volumio volumio[8005]: info: Apr 19 00:21:42 volumio volumio[8005]: ---------------------------- MPD announces state update: player Apr 19 00:21:42 volumio volumio[8005]: info: ControllerMpd::getState Apr 19 00:21:42 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand status Apr 19 00:21:42 volumio volumio[8005]: info: Apr 19 00:21:42 volumio volumio[8005]: ---------------------------- MPD announces state update: player Apr 19 00:21:42 volumio volumio[8005]: info: ControllerMpd::getState Apr 19 00:21:42 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand status Apr 19 00:21:42 volumio volumio[8005]: info: Apr 19 00:21:42 volumio volumio[8005]: ---------------------------- MPD announces state update: player Apr 19 00:21:42 volumio volumio[8005]: info: ControllerMpd::getState Apr 19 00:21:42 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand status Apr 19 00:21:42 volumio volumio[8005]: info: sendMpdCommand status took 3 milliseconds Apr 19 00:21:42 volumio volumio[8005]: info: sendMpdCommand status took 2 milliseconds Apr 19 00:21:42 volumio volumio[8005]: verbose: ControllerMpd::parseState Apr 19 00:21:42 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 00:21:42 volumio volumio[8005]: verbose: ControllerMpd::parseState Apr 19 00:21:42 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 00:21:42 volumio volumio[8005]: info: sendMpdCommand status took 3 milliseconds Apr 19 00:21:42 volumio volumio[8005]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 19 00:21:42 volumio volumio[8005]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 19 00:21:42 volumio volumio[8005]: verbose: ControllerMpd::parseState Apr 19 00:21:42 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 00:21:42 volumio volumio[8005]: verbose: ControllerMpd::parseTrackInfo Apr 19 00:21:42 volumio volumio[8005]: verbose: ControllerMpd::parseTrackInfo Apr 19 00:21:42 volumio volumio[8005]: info: ControllerMpd::pushState Apr 19 00:21:42 volumio volumio[8005]: info: CoreCommandRouter::servicePushState Apr 19 00:21:42 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:42 volumio volumio[8005]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":44592,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1154 Kbps","isStreaming":false,"title":"宁夏","artist":"梁静茹","album":null,"uri":"NAS/music/2014《sn好歌》6CD合集/女人篇:CD1/01 梁静茹 - 宁夏.flac","trackType":"flac"} Apr 19 00:21:42 volumio volumio[8005]: verbose: CURRENT POSITION 0 Apr 19 00:21:42 volumio volumio[8005]: info: CoreStateMachine::syncState stateService pause Apr 19 00:21:42 volumio volumio[8005]: info: CoreStateMachine::syncState currentStatus pause Apr 19 00:21:42 volumio volumio[8005]: info: CoreStateMachine::pushState Apr 19 00:21:42 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:42 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 00:21:42 volumio volumio[8005]: info: CoreCommandRouter::volumioPushState Apr 19 00:21:42 volumio volumio[8005]: info: CoreStateMachine::stPlaybackTimer Apr 19 00:21:42 volumio volumio[8005]: info: ControllerMpd::pushState Apr 19 00:21:42 volumio volumio[8005]: info: CoreCommandRouter::servicePushState Apr 19 00:21:42 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:42 volumio volumio[8005]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":44592,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1154 Kbps","isStreaming":false,"title":"宁夏","artist":"梁静茹","album":null,"uri":"NAS/music/2014《sn好歌》6CD合集/女人篇:CD1/01 梁静茹 - 宁夏.flac","trackType":"flac"} Apr 19 00:21:42 volumio volumio[8005]: verbose: CURRENT POSITION 0 Apr 19 00:21:42 volumio volumio[8005]: info: CoreStateMachine::syncState stateService pause Apr 19 00:21:42 volumio volumio[8005]: info: CoreStateMachine::syncState currentStatus pause Apr 19 00:21:42 volumio volumio[8005]: info: CoreStateMachine::pushState Apr 19 00:21:42 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:42 volumio volumio[8005]: info: CoreCommandRouter::volumioPushState Apr 19 00:21:42 volumio volumio[8005]: info: CoreStateMachine::stPlaybackTimer Apr 19 00:21:42 volumio volumio[8005]: info: ------------------------------ 20ms Apr 19 00:21:42 volumio volumio[8005]: info: ------------------------------ 18ms Apr 19 00:21:42 volumio volumio[8005]: info: sendMpdCommand playlistinfo took 20 milliseconds Apr 19 00:21:42 volumio volumio[8005]: verbose: ControllerMpd::parseTrackInfo Apr 19 00:21:42 volumio volumio[8005]: info: ControllerMpd::pushState Apr 19 00:21:42 volumio volumio[8005]: info: CoreCommandRouter::servicePushState Apr 19 00:21:42 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:42 volumio volumio[8005]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":44592,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1154 Kbps","isStreaming":false,"title":"宁夏","artist":"梁静茹","album":null,"uri":"NAS/music/2014《sn好歌》6CD合集/女人篇:CD1/01 梁静茹 - 宁夏.flac","trackType":"flac"} Apr 19 00:21:42 volumio volumio[8005]: verbose: CURRENT POSITION 0 Apr 19 00:21:42 volumio volumio[8005]: info: CoreStateMachine::syncState stateService pause Apr 19 00:21:42 volumio volumio[8005]: info: CoreStateMachine::syncState currentStatus pause Apr 19 00:21:42 volumio volumio[8005]: info: CoreStateMachine::pushState Apr 19 00:21:42 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:42 volumio volumio[8005]: info: CoreCommandRouter::volumioPushState Apr 19 00:21:42 volumio volumio[8005]: info: CoreStateMachine::stPlaybackTimer Apr 19 00:21:42 volumio volumio[8005]: info: ------------------------------ 32ms Apr 19 00:21:43 volumio volumio[8005]: info: CoreCommandRouter::volumioPlay Apr 19 00:21:43 volumio volumio[8005]: info: CoreStateMachine::play index undefined Apr 19 00:21:43 volumio volumio[8005]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 00:21:43 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:43 volumio volumio[8005]: info: CoreStateMachine::startPlaybackTimer Apr 19 00:21:43 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:43 volumio volumio[8005]: info: ControllerMpd::resume Apr 19 00:21:43 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand play Apr 19 00:21:43 volumio volumio[8005]: info: Apr 19 00:21:43 volumio volumio[8005]: ---------------------------- MPD announces state update: player Apr 19 00:21:43 volumio volumio[8005]: info: sendMpdCommand play took 5 milliseconds Apr 19 00:21:43 volumio volumio[8005]: info: ControllerMpd::getState Apr 19 00:21:43 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand status Apr 19 00:21:43 volumio volumio[8005]: info: sendMpdCommand status took 1 milliseconds Apr 19 00:21:43 volumio volumio[8005]: verbose: ControllerMpd::parseState Apr 19 00:21:43 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 00:21:43 volumio volumio[8005]: info: Apr 19 00:21:43 volumio volumio[8005]: ---------------------------- MPD announces state update: player Apr 19 00:21:43 volumio volumio[8005]: info: ControllerMpd::getState Apr 19 00:21:43 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand status Apr 19 00:21:43 volumio volumio[8005]: info: Apr 19 00:21:43 volumio volumio[8005]: ---------------------------- MPD announces state update: player Apr 19 00:21:43 volumio volumio[8005]: info: ControllerMpd::getState Apr 19 00:21:43 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand status Apr 19 00:21:43 volumio volumio[8005]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 19 00:21:43 volumio volumio[8005]: info: sendMpdCommand status took 3 milliseconds Apr 19 00:21:43 volumio volumio[8005]: info: sendMpdCommand status took 2 milliseconds Apr 19 00:21:43 volumio volumio[8005]: verbose: ControllerMpd::parseTrackInfo Apr 19 00:21:43 volumio volumio[8005]: verbose: ControllerMpd::parseState Apr 19 00:21:43 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 00:21:43 volumio volumio[8005]: verbose: ControllerMpd::parseState Apr 19 00:21:43 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 00:21:43 volumio volumio[8005]: info: ControllerMpd::pushState Apr 19 00:21:43 volumio volumio[8005]: info: CoreCommandRouter::servicePushState Apr 19 00:21:43 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:43 volumio volumio[8005]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45576,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"909 Kbps","isStreaming":false,"title":"宁夏","artist":"梁静茹","album":null,"uri":"NAS/music/2014《sn好歌》6CD合集/女人篇:CD1/01 梁静茹 - 宁夏.flac","trackType":"flac"} Apr 19 00:21:43 volumio volumio[8005]: verbose: CURRENT POSITION 0 Apr 19 00:21:43 volumio volumio[8005]: info: CoreStateMachine::syncState stateService play Apr 19 00:21:43 volumio volumio[8005]: info: CoreStateMachine::syncState currentStatus pause Apr 19 00:21:43 volumio volumio[8005]: info: CoreStateMachine::pushState Apr 19 00:21:43 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:43 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 00:21:43 volumio volumio[8005]: info: CoreCommandRouter::volumioPushState Apr 19 00:21:43 volumio volumio[8005]: info: ------------------------------ 15ms Apr 19 00:21:43 volumio volumio[8005]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 19 00:21:43 volumio volumio[8005]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 19 00:21:43 volumio volumio[8005]: verbose: ControllerMpd::parseTrackInfo Apr 19 00:21:43 volumio volumio[8005]: verbose: ControllerMpd::parseTrackInfo Apr 19 00:21:43 volumio volumio[8005]: info: ControllerMpd::pushState Apr 19 00:21:43 volumio volumio[8005]: info: CoreCommandRouter::servicePushState Apr 19 00:21:43 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:43 volumio volumio[8005]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45576,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"909 Kbps","isStreaming":false,"title":"宁夏","artist":"梁静茹","album":null,"uri":"NAS/music/2014《sn好歌》6CD合集/女人篇:CD1/01 梁静茹 - 宁夏.flac","trackType":"flac"} Apr 19 00:21:43 volumio volumio[8005]: verbose: CURRENT POSITION 0 Apr 19 00:21:43 volumio volumio[8005]: info: CoreStateMachine::syncState stateService play Apr 19 00:21:43 volumio volumio[8005]: info: CoreStateMachine::syncState currentStatus play Apr 19 00:21:43 volumio volumio[8005]: info: Received an update from plugin. extracting info from payload Apr 19 00:21:43 volumio volumio[8005]: info: CoreStateMachine::pushState Apr 19 00:21:43 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:43 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 00:21:43 volumio volumio[8005]: info: CoreCommandRouter::volumioPushState Apr 19 00:21:43 volumio volumio[8005]: info: CoreStateMachine::pushState Apr 19 00:21:43 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:43 volumio volumio[8005]: info: CoreCommandRouter::volumioPushState Apr 19 00:21:43 volumio volumio[8005]: info: ControllerMpd::pushState Apr 19 00:21:43 volumio volumio[8005]: info: CoreCommandRouter::servicePushState Apr 19 00:21:43 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:43 volumio volumio[8005]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45576,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"909 Kbps","isStreaming":false,"title":"宁夏","artist":"梁静茹","album":null,"uri":"NAS/music/2014《sn好歌》6CD合集/女人篇:CD1/01 梁静茹 - 宁夏.flac","trackType":"flac"} Apr 19 00:21:43 volumio volumio[8005]: verbose: CURRENT POSITION 0 Apr 19 00:21:43 volumio volumio[8005]: info: CoreStateMachine::syncState stateService play Apr 19 00:21:43 volumio volumio[8005]: info: CoreStateMachine::syncState currentStatus play Apr 19 00:21:43 volumio volumio[8005]: info: Received an update from plugin. extracting info from payload Apr 19 00:21:43 volumio volumio[8005]: info: CoreStateMachine::pushState Apr 19 00:21:43 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:43 volumio volumio[8005]: info: CoreCommandRouter::volumioPushState Apr 19 00:21:43 volumio volumio[8005]: info: CoreStateMachine::pushState Apr 19 00:21:43 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:21:43 volumio volumio[8005]: info: CoreCommandRouter::volumioPushState Apr 19 00:21:43 volumio volumio[8005]: info: ------------------------------ 34ms Apr 19 00:21:43 volumio volumio[8005]: info: ------------------------------ 32ms Apr 19 00:21:47 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 19 00:21:50 volumio volumio[8005]: info: CoreCommandRouter::Close All Modals sent Apr 19 00:21:50 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted Apr 19 00:21:57 volumio volumio[8005]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 19 00:21:57 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 19 00:21:57 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 00:21:57 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 19 00:21:58 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 00:21:58 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 00:21:58 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 00:21:58 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 00:21:58 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 00:21:58 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 00:21:58 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 00:21:58 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 19 00:21:58 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 19 00:22:03 volumio volumio[8005]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Apr 19 00:22:03 volumio volumio[8005]: info: Preparing to save Alsa Options, stopping services first Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::volumioGetState Apr 19 00:22:03 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::volumioPause Apr 19 00:22:03 volumio volumio[8005]: info: CoreStateMachine::pause Apr 19 00:22:03 volumio volumio[8005]: info: CoreStateMachine::stPlaybackTimer Apr 19 00:22:03 volumio volumio[8005]: info: CoreStateMachine::servicePause Apr 19 00:22:03 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::servicePause Apr 19 00:22:03 volumio volumio[8005]: info: ControllerMpd::pause Apr 19 00:22:03 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand pause Apr 19 00:22:03 volumio volumio[8005]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"HDMI Out"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 19 00:22:03 volumio volumio[8005]: info: Enabling PI HDMI Output Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 19 00:22:03 volumio volumio[8005]: info: Found match in Cards Database: setting mixer PCM for card HDMI Out Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 19 00:22:03 volumio volumio[8005]: info: Updating Volume Controller Parameters: Device: 0 Name: HDMI Out Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 19 00:22:03 volumio volumio[8005]: info: Disabling external Volume Control Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 19 00:22:03 volumio volumio[8005]: info: Preparing to generate the ALSA configuration file Apr 19 00:22:03 volumio volumio[8005]: info: Apr 19 00:22:03 volumio volumio[8005]: ---------------------------- MPD announces state update: player Apr 19 00:22:03 volumio volumio[8005]: info: sendMpdCommand pause took 163 milliseconds Apr 19 00:22:03 volumio volumio[8005]: info: ControllerMpd::getState Apr 19 00:22:03 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand status Apr 19 00:22:03 volumio volumio[8005]: info: Apr 19 00:22:03 volumio volumio[8005]: ---------------------------- MPD announces state update: player Apr 19 00:22:03 volumio volumio[8005]: info: ControllerMpd::getState Apr 19 00:22:03 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand status Apr 19 00:22:03 volumio volumio[8005]: info: Apr 19 00:22:03 volumio volumio[8005]: ---------------------------- MPD announces state update: player Apr 19 00:22:03 volumio volumio[8005]: info: ControllerMpd::getState Apr 19 00:22:03 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand status Apr 19 00:22:03 volumio volumio[8005]: info: Raspberry PI HDMI Output Enabled Apr 19 00:22:03 volumio volumio[8005]: info: sendMpdCommand status took 20 milliseconds Apr 19 00:22:03 volumio volumio[8005]: info: sendMpdCommand status took 18 milliseconds Apr 19 00:22:03 volumio volumio[8005]: info: sendMpdCommand status took 18 milliseconds Apr 19 00:22:03 volumio volumio[8005]: verbose: ControllerMpd::parseState Apr 19 00:22:03 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 00:22:03 volumio volumio[8005]: verbose: ControllerMpd::parseState Apr 19 00:22:03 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 00:22:03 volumio volumio[8005]: verbose: ControllerMpd::parseState Apr 19 00:22:03 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 19 00:22:03 volumio sudo[8564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl store Apr 19 00:22:03 volumio sudo[8564]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 00:22:03 volumio volumio[8005]: info: sendMpdCommand playlistinfo took 20 milliseconds Apr 19 00:22:03 volumio volumio[8005]: info: sendMpdCommand playlistinfo took 21 milliseconds Apr 19 00:22:03 volumio volumio[8005]: info: sendMpdCommand playlistinfo took 21 milliseconds Apr 19 00:22:03 volumio volumio[8005]: verbose: ControllerMpd::parseTrackInfo Apr 19 00:22:03 volumio volumio[8005]: verbose: ControllerMpd::parseTrackInfo Apr 19 00:22:03 volumio volumio[8005]: verbose: ControllerMpd::parseTrackInfo Apr 19 00:22:03 volumio volumio[8005]: info: ControllerMpd::pushState Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::servicePushState Apr 19 00:22:03 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:03 volumio volumio[8005]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":65962,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1281 Kbps","isStreaming":false,"title":"宁夏","artist":"梁静茹","album":null,"uri":"NAS/music/2014《sn好歌》6CD合集/女人篇:CD1/01 梁静茹 - 宁夏.flac","trackType":"flac"} Apr 19 00:22:03 volumio volumio[8005]: verbose: CURRENT POSITION 0 Apr 19 00:22:03 volumio volumio[8005]: info: CoreStateMachine::syncState stateService pause Apr 19 00:22:03 volumio volumio[8005]: info: CoreStateMachine::syncState currentStatus pause Apr 19 00:22:03 volumio volumio[8005]: info: CoreStateMachine::pushState Apr 19 00:22:03 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::volumioPushState Apr 19 00:22:03 volumio volumio[8005]: info: CoreStateMachine::stPlaybackTimer Apr 19 00:22:03 volumio volumio[8005]: info: ControllerMpd::pushState Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::servicePushState Apr 19 00:22:03 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:03 volumio volumio[8005]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":65962,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1281 Kbps","isStreaming":false,"title":"宁夏","artist":"梁静茹","album":null,"uri":"NAS/music/2014《sn好歌》6CD合集/女人篇:CD1/01 梁静茹 - 宁夏.flac","trackType":"flac"} Apr 19 00:22:03 volumio volumio[8005]: verbose: CURRENT POSITION 0 Apr 19 00:22:03 volumio volumio[8005]: info: CoreStateMachine::syncState stateService pause Apr 19 00:22:03 volumio volumio[8005]: info: CoreStateMachine::syncState currentStatus pause Apr 19 00:22:03 volumio volumio[8005]: info: CoreStateMachine::pushState Apr 19 00:22:03 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::volumioPushState Apr 19 00:22:03 volumio volumio[8005]: info: CoreStateMachine::stPlaybackTimer Apr 19 00:22:03 volumio volumio[8005]: info: ControllerMpd::pushState Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::servicePushState Apr 19 00:22:03 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:03 volumio volumio[8005]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":65962,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1281 Kbps","isStreaming":false,"title":"宁夏","artist":"梁静茹","album":null,"uri":"NAS/music/2014《sn好歌》6CD合集/女人篇:CD1/01 梁静茹 - 宁夏.flac","trackType":"flac"} Apr 19 00:22:03 volumio volumio[8005]: verbose: CURRENT POSITION 0 Apr 19 00:22:03 volumio volumio[8005]: info: CoreStateMachine::syncState stateService pause Apr 19 00:22:03 volumio volumio[8005]: info: CoreStateMachine::syncState currentStatus pause Apr 19 00:22:03 volumio volumio[8005]: info: CoreStateMachine::pushState Apr 19 00:22:03 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:03 volumio volumio[8005]: info: CoreCommandRouter::volumioPushState Apr 19 00:22:03 volumio volumio[8005]: info: CoreStateMachine::stPlaybackTimer Apr 19 00:22:03 volumio sudo[8564]: pam_unix(sudo:session): session closed for user root Apr 19 00:22:03 volumio volumio[8005]: info: ------------------------------ 74ms Apr 19 00:22:03 volumio volumio[8005]: info: ------------------------------ 69ms Apr 19 00:22:03 volumio volumio[8005]: info: ------------------------------ 69ms Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 19 00:22:04 volumio volumio[8005]: info: Alsa Settings successfully stored Apr 19 00:22:04 volumio volumio[8005]: info: VolumeController:: Volume=86 Mute =false Apr 19 00:22:04 volumio volumio[8005]: info: CoreStateMachine::pushState Apr 19 00:22:04 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::volumioPushState Apr 19 00:22:04 volumio volumio[8005]: info: Asound.conf file written Apr 19 00:22:04 volumio sudo[8574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 19 00:22:04 volumio sudo[8574]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 00:22:04 volumio sudo[8574]: pam_unix(sudo:session): session closed for user root Apr 19 00:22:04 volumio volumio[8005]: info: Output device has changed, restarting MPD Apr 19 00:22:04 volumio sudo[8579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 19 00:22:04 volumio sudo[8579]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 00:22:04 volumio volumio[8005]: info: Output device has changed, restarting Shairport Sync Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 00:22:04 volumio sudo[8579]: pam_unix(sudo:session): session closed for user root Apr 19 00:22:04 volumio sudo[8582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 19 00:22:04 volumio sudo[8582]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 00:22:04 volumio volumio[8005]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 19 00:22:04 volumio systemd[1]: Stopping Music Player Daemon... Apr 19 00:22:04 volumio volumio[8005]: info: Output device has changed, restarting MPD Apr 19 00:22:04 volumio systemd[1]: mpd.service: Succeeded. Apr 19 00:22:04 volumio systemd[1]: Stopped Music Player Daemon. Apr 19 00:22:04 volumio sudo[8588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 19 00:22:04 volumio sudo[8588]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 00:22:04 volumio systemd[1]: Starting Music Player Daemon... Apr 19 00:22:04 volumio volumio[8005]: info: Output device has changed, restarting Shairport Sync Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 00:22:04 volumio volumio[8005]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 19 00:22:04 volumio volumio[8005]: info: MPD Permissions set Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 00:22:04 volumio sudo[8588]: pam_unix(sudo:session): session closed for user root Apr 19 00:22:04 volumio sudo[8592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 19 00:22:04 volumio sudo[8592]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 00:22:04 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 00:22:04 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 19 00:22:04 volumio systemd[1]: mpd.service: Succeeded. Apr 19 00:22:04 volumio volumio[8005]: info: Starting Shairport Sync Apr 19 00:22:04 volumio systemd[1]: Stopped Music Player Daemon. Apr 19 00:22:04 volumio systemd[1]: Starting Music Player Daemon... Apr 19 00:22:04 volumio volumio[8005]: info: Starting Shairport Sync Apr 19 00:22:04 volumio sudo[8607]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 19 00:22:04 volumio sudo[8607]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 00:22:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 19 00:22:04 volumio sudo[8610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 19 00:22:04 volumio sudo[8610]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 00:22:04 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 19 00:22:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 19 00:22:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 19 00:22:04 volumio sudo[8605]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 19 00:22:04 volumio sudo[8607]: pam_unix(sudo:session): session closed for user root Apr 19 00:22:04 volumio sudo[8605]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 00:22:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 19 00:22:04 volumio volumio[8005]: info: Shairport-Sync Started Apr 19 00:22:04 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 19 00:22:04 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 19 00:22:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 19 00:22:04 volumio sudo[8605]: pam_unix(sudo:session): session closed for user root Apr 19 00:22:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 19 00:22:04 volumio sudo[8610]: pam_unix(sudo:session): session closed for user root Apr 19 00:22:04 volumio volumio[8005]: info: Shairport-Sync Started Apr 19 00:22:05 volumio mpd[8623]: Apr 19 00:22 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 19 00:22:05 volumio systemd[1]: Started Music Player Daemon. Apr 19 00:22:05 volumio sudo[8592]: pam_unix(sudo:session): session closed for user root Apr 19 00:22:05 volumio sudo[8582]: pam_unix(sudo:session): session closed for user root Apr 19 00:22:05 volumio volumio[8005]: error: MPD error: The expression evaluated to a falsy value: Apr 19 00:22:05 volumio volumio[8005]: assert.ok(self.idling) Apr 19 00:22:05 volumio volumio[8005]: error: The expression evaluated to a falsy value: Apr 19 00:22:05 volumio volumio[8005]: assert.ok(self.idling) Apr 19 00:22:05 volumio volumio[8005]: error: updateQueue error: null Apr 19 00:22:05 volumio volumio[8005]: info: CoreCommandRouter::volumioGetState Apr 19 00:22:05 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:07 volumio volumio[8005]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 19 00:22:07 volumio volumio[8005]: info: CoreStateMachine::getcurrentVolume Apr 19 00:22:07 volumio volumio[8005]: info: CoreCommandRouter::volumioRetrievevolume Apr 19 00:22:07 volumio volumio[8005]: info: VolumeController:: Volume=86 Mute =false Apr 19 00:22:07 volumio volumio[8005]: info: CoreStateMachine::pushState Apr 19 00:22:07 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:07 volumio volumio[8005]: info: CoreCommandRouter::volumioPushState Apr 19 00:22:07 volumio volumio[8005]: info: CoreStateMachine::updateTrackBlock Apr 19 00:22:07 volumio volumio[8005]: info: CorePlayQueue::getTrackBlock Apr 19 00:22:07 volumio volumio[8005]: info: CoreCommandRouter::volumioRetrievevolume Apr 19 00:22:08 volumio volumio[8005]: info: VolumeController:: Volume=86 Mute =false Apr 19 00:22:08 volumio volumio[8005]: info: CoreStateMachine::pushState Apr 19 00:22:08 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:08 volumio volumio[8005]: info: CoreCommandRouter::volumioPushState Apr 19 00:22:08 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 19 00:22:08 volumio volumio-remote-updater[2572]: No test mode Apr 19 00:22:08 volumio volumio-remote-updater[2572]: No alpha test mode Apr 19 00:22:08 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 19 00:22:09 volumio volumio[8005]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 19 00:22:09 volumio volumio[8005]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 19 00:22:14 volumio volumio[8005]: info: CoreCommandRouter::volumioPlay Apr 19 00:22:14 volumio volumio[8005]: info: CoreStateMachine::play index undefined Apr 19 00:22:14 volumio volumio[8005]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 00:22:14 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:14 volumio volumio[8005]: info: CoreStateMachine::startPlaybackTimer Apr 19 00:22:14 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:14 volumio volumio[8005]: info: ControllerMpd::resume Apr 19 00:22:14 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand play Apr 19 00:22:14 volumio volumio[8005]: info: sendMpdCommand play took 1 milliseconds Apr 19 00:22:17 volumio volumio[8005]: info: CoreCommandRouter::volumioPlay Apr 19 00:22:17 volumio volumio[8005]: info: CoreStateMachine::play index undefined Apr 19 00:22:17 volumio volumio[8005]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 00:22:17 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:17 volumio volumio[8005]: info: CoreStateMachine::startPlaybackTimer Apr 19 00:22:17 volumio volumio[8005]: info: CorePlayQueue::getTrack 0 Apr 19 00:22:17 volumio volumio[8005]: info: ControllerMpd::resume Apr 19 00:22:17 volumio volumio[8005]: verbose: ControllerMpd::sendMpdCommand play Apr 19 00:22:17 volumio volumio[8005]: info: sendMpdCommand play took 1 milliseconds Apr 19 00:22:17 volumio volumio[8005]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 19 00:22:17 volumio volumio[8005]: Error: connect ETIMEDOUT 128.121.243.77:80 Apr 19 00:22:17 volumio volumio[8005]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Apr 19 00:22:17 volumio volumio[8005]: errno: -110, Apr 19 00:22:17 volumio volumio[8005]: code: 'ETIMEDOUT', Apr 19 00:22:17 volumio volumio[8005]: syscall: 'connect', Apr 19 00:22:17 volumio volumio[8005]: address: '128.121.243.77', Apr 19 00:22:17 volumio volumio[8005]: port: 80 Apr 19 00:22:17 volumio volumio[8005]: } Apr 19 00:22:17 volumio volumio[8005]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 19 00:22:17 volumio sudo[8666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-19 00:21 Apr 19 00:22:17 volumio sudo[8666]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"