-- Logs begin at Thu 2019-02-14 18:12:00 CST, end at Sat 2024-11-30 15:26:35 CST. -- Nov 30 15:25:00 volumio volumio[912]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 30 15:25:00 volumio volumio[912]: info: Updating MyVolumio device info Nov 30 15:25:00 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 30 15:25:01 volumio volumio[912]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 30 15:25:04 volumio volumio[912]: info: MYVOLUMIO: Adding device Nov 30 15:25:04 volumio volumio[912]: info: MYVOLUMIO: Evaluating Server Nov 30 15:25:10 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 30 15:25:10 volumio volumio[912]: info: Received Get System Info Nov 30 15:25:10 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 15:25:10 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 15:25:10 volumio volumio[912]: info: Discovery: Getting this device information Nov 30 15:25:10 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:10 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:10 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 15:25:11 volumio volumio[912]: info: Setting Geolocation for MyVolumio to eu2 Nov 30 15:25:11 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 30 15:25:12 volumio volumio[912]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 30 15:25:12 volumio volumio[912]: info: Updating MyVolumio device info Nov 30 15:25:12 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 30 15:25:13 volumio volumio[912]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 30 15:25:18 volumio sudo[3743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 30 15:25:18 volumio sudo[3743]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 15:25:18 volumio sudo[3743]: pam_unix(sudo:session): session closed for user root Nov 30 15:25:18 volumio sudo[3745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 30 15:25:18 volumio sudo[3745]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 15:25:18 volumio sudo[3745]: pam_unix(sudo:session): session closed for user root Nov 30 15:25:18 volumio volumio[912]: verbose: New Socket.io Connection to 192.168.10.140 from 192.168.10.238 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/99.0.4844.84 Safari/537.36 HBPC/12.1.4.300 Engine version: 3 Transport: polling Total Clients: 5 Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:18 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:18 volumio volumio[912]: info: Received Get System Info Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 15:25:18 volumio volumio[912]: info: Discovery: Getting this device information Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:18 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:18 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::volumioGetVisibleSources Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:18 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:18 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 30 15:25:18 volumio volumio[912]: info: Received Get System Info Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 15:25:18 volumio volumio[912]: info: Discovery: Getting this device information Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:18 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:18 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:18 volumio volumio[912]: info: Listing playlists Nov 30 15:25:18 volumio volumio[912]: info: Received Get System Info Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 15:25:18 volumio volumio[912]: info: Discovery: Getting this device information Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:18 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:18 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:18 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 30 15:25:18 volumio ntpd[778]: Soliciting pool server 113.207.49.85 Nov 30 15:25:19 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:19 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:20 volumio ntpd[778]: Soliciting pool server 92.246.24.228 Nov 30 15:25:22 volumio ntpd[778]: Soliciting pool server 198.18.0.38 Nov 30 15:25:22 volumio volumio[912]: info: CoreCommandRouter::volumioGetQueue Nov 30 15:25:22 volumio volumio[912]: info: CoreStateMachine::getQueue Nov 30 15:25:22 volumio volumio[912]: info: CorePlayQueue::getQueue Nov 30 15:25:26 volumio ntpd[778]: Soliciting pool server 162.159.200.123 Nov 30 15:25:28 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 30 15:25:28 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri Nov 30 15:25:28 volumio volumio[912]: Error Retrieving last played file: Error: /data/laststates.json: ENOENT: no such file or directory, open '/data/laststates.json' Nov 30 15:25:28 volumio volumio[912]: info: Preload queue cleared Nov 30 15:25:30 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:30 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:35 volumio ntpd[778]: Soliciting pool server 198.18.0.41 Nov 30 15:25:37 volumio ntpd[778]: Soliciting pool server 198.18.0.44 Nov 30 15:25:39 volumio volumio[912]: info: VolumeController::SetAlsaVolume100 Nov 30 15:25:39 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:25:39 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:39 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 15:25:39 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:25:39 volumio volumio[912]: info: Nov 30 15:25:39 volumio volumio[912]: ---------------------------- MPD announces state update: mixer Nov 30 15:25:39 volumio volumio[912]: info: ControllerMpd::getState Nov 30 15:25:39 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Nov 30 15:25:39 volumio volumio[912]: info: sendMpdCommand status took 3 milliseconds Nov 30 15:25:39 volumio volumio[912]: verbose: ControllerMpd::parseState Nov 30 15:25:39 volumio volumio[912]: info: ControllerMpd::pushState Nov 30 15:25:39 volumio volumio[912]: info: CoreCommandRouter::servicePushState Nov 30 15:25:39 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:25:39 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:39 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:25:39 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:39 volumio volumio[912]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 30 15:25:39 volumio volumio[912]: verbose: CURRENT POSITION 0 Nov 30 15:25:39 volumio volumio[912]: info: CoreStateMachine::syncState stateService stop Nov 30 15:25:39 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus stop Nov 30 15:25:39 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:25:39 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:39 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:25:39 volumio volumio[912]: info: No code Nov 30 15:25:39 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:25:39 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:39 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:25:39 volumio volumio[912]: info: ------------------------------ 45ms Nov 30 15:25:40 volumio volumio[912]: info: VolumeController::SetAlsaVolume86 Nov 30 15:25:40 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:25:40 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:40 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 15:25:40 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:25:40 volumio volumio[912]: info: Nov 30 15:25:40 volumio volumio[912]: ---------------------------- MPD announces state update: mixer Nov 30 15:25:40 volumio volumio[912]: info: ControllerMpd::getState Nov 30 15:25:40 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Nov 30 15:25:40 volumio volumio[912]: info: sendMpdCommand status took 2 milliseconds Nov 30 15:25:40 volumio volumio[912]: verbose: ControllerMpd::parseState Nov 30 15:25:40 volumio volumio[912]: info: ControllerMpd::pushState Nov 30 15:25:40 volumio volumio[912]: info: CoreCommandRouter::servicePushState Nov 30 15:25:40 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:25:40 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:40 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:25:40 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:40 volumio volumio[912]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 30 15:25:40 volumio volumio[912]: verbose: CURRENT POSITION 0 Nov 30 15:25:40 volumio volumio[912]: info: CoreStateMachine::syncState stateService stop Nov 30 15:25:40 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus stop Nov 30 15:25:40 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:25:40 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:40 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:25:40 volumio volumio[912]: info: No code Nov 30 15:25:40 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:25:40 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:40 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:25:40 volumio volumio[912]: info: ------------------------------ 39ms Nov 30 15:25:40 volumio volumio[912]: info: VolumeController::SetAlsaVolume84 Nov 30 15:25:40 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:25:40 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:40 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 15:25:40 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:25:40 volumio volumio[912]: info: Nov 30 15:25:40 volumio volumio[912]: ---------------------------- MPD announces state update: mixer Nov 30 15:25:40 volumio volumio[912]: info: ControllerMpd::getState Nov 30 15:25:40 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Nov 30 15:25:40 volumio volumio[912]: info: sendMpdCommand status took 1 milliseconds Nov 30 15:25:40 volumio volumio[912]: verbose: ControllerMpd::parseState Nov 30 15:25:40 volumio volumio[912]: info: ControllerMpd::pushState Nov 30 15:25:40 volumio volumio[912]: info: CoreCommandRouter::servicePushState Nov 30 15:25:40 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:25:40 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:40 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:25:40 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:40 volumio volumio[912]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 30 15:25:40 volumio volumio[912]: verbose: CURRENT POSITION 0 Nov 30 15:25:40 volumio volumio[912]: info: CoreStateMachine::syncState stateService stop Nov 30 15:25:40 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus stop Nov 30 15:25:40 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:25:40 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:40 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:25:40 volumio volumio[912]: info: No code Nov 30 15:25:40 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:25:40 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:40 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:25:40 volumio volumio[912]: info: ------------------------------ 36ms Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 30 15:25:48 volumio volumio[912]: verbose: New Socket.io Connection to 192.168.10.140 from 192.168.10.238 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/99.0.4844.84 Safari/537.36 HBPC/12.1.4.300 Engine version: 3 Transport: polling Total Clients: 5 Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:48 volumio volumio[912]: info: Received Get System Info Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 15:25:48 volumio volumio[912]: info: Discovery: Getting this device information Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetVisibleSources Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 30 15:25:48 volumio volumio[912]: info: Received Get System Info Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 15:25:48 volumio volumio[912]: info: Discovery: Getting this device information Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:48 volumio volumio[912]: info: Listing playlists Nov 30 15:25:48 volumio volumio[912]: info: Received Get System Info Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 15:25:48 volumio volumio[912]: info: Discovery: Getting this device information Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetQueue Nov 30 15:25:48 volumio volumio[912]: info: CoreStateMachine::getQueue Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getQueue Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetVisibleSources Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 30 15:25:48 volumio volumio[912]: info: Received Get System Info Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 15:25:48 volumio volumio[912]: info: Discovery: Getting this device information Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:48 volumio volumio[912]: info: Listing playlists Nov 30 15:25:48 volumio volumio[912]: info: Received Get System Info Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 15:25:48 volumio volumio[912]: info: Discovery: Getting this device information Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:48 volumio volumio[912]: info: CoreCommandRouter::volumioGetQueue Nov 30 15:25:48 volumio volumio[912]: info: CoreStateMachine::getQueue Nov 30 15:25:48 volumio volumio[912]: info: CorePlayQueue::getQueue Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::volumioGetVisibleSources Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:49 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:49 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 30 15:25:49 volumio volumio[912]: info: Received Get System Info Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 15:25:49 volumio volumio[912]: info: Discovery: Getting this device information Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:49 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:49 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:49 volumio volumio[912]: info: Listing playlists Nov 30 15:25:49 volumio volumio[912]: info: Received Get System Info Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 15:25:49 volumio volumio[912]: info: Discovery: Getting this device information Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:49 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:25:49 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::volumioGetQueue Nov 30 15:25:49 volumio volumio[912]: info: CoreStateMachine::getQueue Nov 30 15:25:49 volumio volumio[912]: info: CorePlayQueue::getQueue Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 30 15:25:49 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 30 15:25:56 volumio dnsmasq-dhcp[899]: no address range available for DHCP request via wlan0 Nov 30 15:26:00 volumio dnsmasq-dhcp[899]: no address range available for DHCP request via wlan0 Nov 30 15:26:01 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:26:01 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:26:06 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:26:06 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:26:08 volumio volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 15:26:08 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 30 15:26:08 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 30 15:26:08 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 30 15:26:08 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 15:26:08 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 15:26:08 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 15:26:08 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 15:26:08 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 15:26:08 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 15:26:08 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 15:26:08 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 30 15:26:08 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 30 15:26:24 volumio volumio[912]: info: CoreCommandRouter::volumioGetState Nov 30 15:26:24 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:26:25 volumio ntpd[778]: Soliciting pool server 193.182.111.12 Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 15:26:26 volumio volumio[912]: info: Retrieving Cloud Streaming UI Nov 30 15:26:26 volumio volumio[912]: info: Getting Tidal Cloud Configuration Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 15:26:26 volumio volumio[912]: info: Getting Qobuz Cloud Configuration Nov 30 15:26:26 volumio volumio[912]: info: Asking plugin for UI Config Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 15:26:26 volumio volumio[912]: info: Getting Spotify Cloud Configuration Nov 30 15:26:26 volumio volumio[912]: info: Asking plugin for UI Config Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 15:26:26 volumio volumio[912]: info: Saving Spotify Acccount Nov 30 15:26:26 volumio volumio[912]: info: Got Tidal Cloud Configuration Nov 30 15:26:26 volumio volumio[912]: info: Got it Nov 30 15:26:26 volumio volumio[912]: info: Got it Nov 30 15:26:26 volumio volumio[912]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 15:26:26 volumio volumio[912]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::volumioGetBrowseSources Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::volumioGetBrowseSources Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::volumioGetBrowseSources Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 30 15:26:26 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 30 15:26:27 volumio ntpd[778]: Soliciting pool server 116.203.151.74 Nov 30 15:26:28 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Nov 30 15:26:28 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand update Nov 30 15:26:28 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Nov 30 15:26:28 volumio volumio[912]: info: Nov 30 15:26:28 volumio volumio[912]: ---------------------------- MPD announces state update: update Nov 30 15:26:28 volumio volumio[912]: info: sendMpdCommand update took 4 milliseconds Nov 30 15:26:28 volumio volumio[912]: info: ControllerMpd::getState Nov 30 15:26:28 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Nov 30 15:26:28 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Nov 30 15:26:28 volumio volumio[912]: info: Nov 30 15:26:28 volumio volumio[912]: ---------------------------- MPD announces state update: update Nov 30 15:26:28 volumio volumio[912]: info: ControllerMpd::getState Nov 30 15:26:28 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Nov 30 15:26:28 volumio volumio[912]: info: sendMpdCommand status took 5 milliseconds Nov 30 15:26:28 volumio volumio[912]: info: sendMpdCommand status took 4 milliseconds Nov 30 15:26:28 volumio volumio[912]: verbose: ControllerMpd::parseState Nov 30 15:26:28 volumio volumio[912]: info: Command Router : Notfying DB Updatefalse Nov 30 15:26:28 volumio volumio[912]: info: CoreCommandRouter::Close All Modals sent Nov 30 15:26:28 volumio volumio[912]: verbose: ControllerMpd::parseState Nov 30 15:26:28 volumio volumio[912]: info: ControllerMpd::pushState Nov 30 15:26:28 volumio volumio[912]: info: CoreCommandRouter::servicePushState Nov 30 15:26:28 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:26:28 volumio volumio[912]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 30 15:26:28 volumio volumio[912]: verbose: CURRENT POSITION 0 Nov 30 15:26:28 volumio volumio[912]: info: CoreStateMachine::syncState stateService stop Nov 30 15:26:28 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus stop Nov 30 15:26:28 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:26:28 volumio volumio[912]: info: No code Nov 30 15:26:28 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:26:28 volumio volumio[912]: info: ------------------------------ 83ms Nov 30 15:26:28 volumio volumio[912]: info: sendMpdCommand status took 82 milliseconds Nov 30 15:26:28 volumio volumio[912]: info: sendMpdCommand status took 82 milliseconds Nov 30 15:26:28 volumio volumio[912]: verbose: ControllerMpd::parseState Nov 30 15:26:28 volumio volumio[912]: info: Command Router : Notfying DB Updatefalse Nov 30 15:26:28 volumio volumio[912]: info: CoreCommandRouter::Close All Modals sent Nov 30 15:26:28 volumio volumio[912]: verbose: ControllerMpd::parseState Nov 30 15:26:28 volumio volumio[912]: info: ControllerMpd::pushState Nov 30 15:26:28 volumio volumio[912]: info: CoreCommandRouter::servicePushState Nov 30 15:26:28 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:26:28 volumio volumio[912]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 30 15:26:28 volumio volumio[912]: verbose: CURRENT POSITION 0 Nov 30 15:26:28 volumio volumio[912]: info: CoreStateMachine::syncState stateService stop Nov 30 15:26:28 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus stop Nov 30 15:26:28 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:26:28 volumio volumio[912]: info: No code Nov 30 15:26:28 volumio volumio[912]: info: CoreStateMachine::pushState Nov 30 15:26:28 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Nov 30 15:26:28 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Nov 30 15:26:28 volumio volumio[912]: info: ------------------------------ 140ms Nov 30 15:26:29 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 30 15:26:29 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 30 15:26:30 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 30 15:26:31 volumio volumio[912]: info: Error browsing device CQQJ for shares : Error: Command failed: echo volumio | smbclient -L CQQJ.local. Nov 30 15:26:31 volumio volumio[912]: Unable to initialize messaging context Nov 30 15:26:34 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 30 15:26:34 volumio volumio[912]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 30 15:26:34 volumio volumio[912]: Error: dns service error: unknown Nov 30 15:26:34 volumio volumio[912]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Nov 30 15:26:34 volumio volumio[912]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Nov 30 15:26:34 volumio volumio[912]: errorCode: -65537 Nov 30 15:26:34 volumio volumio[912]: } Nov 30 15:26:34 volumio volumio[912]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 30 15:26:35 volumio sudo[4001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-30 15:25 Nov 30 15:26:35 volumio sudo[4001]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"