-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Tue 2024-08-20 17:52:57 CEST. -- Aug 20 17:51:00 volumio volumio-remote-updater[654]: [2024-08-20 17:51:00] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Aug 20 17:51:05 volumio volumio-remote-updater[654]: [2024-08-20 17:51:05] [connect] Successful connection Aug 20 17:51:15 volumio volumio[987]: info: Checking if install.sh is present Aug 20 17:51:15 volumio volumio[987]: info: Executing install.sh Aug 20 17:51:15 volumio volumio[987]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Aug 20 17:51:15 volumio volumio[987]: verbose: New Socket.io Connection to 192.168.0.53 from 192.168.0.57 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Aug 20 17:51:15 volumio volumio[987]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 20 17:51:15 volumio volumio[987]: verbose: New Socket.io Connection to 192.168.0.53 from 192.168.0.57 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Aug 20 17:51:15 volumio sudo[3001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/volroon/install.sh Aug 20 17:51:15 volumio sudo[3001]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 17:51:15 volumio volumio[987]: verbose: New Socket.io Connection to volumio from 192.168.0.57 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Aug 20 17:51:15 volumio volumio[987]: verbose: New Socket.io Connection to 192.168.0.53 from 192.168.0.57 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 20 17:51:15 volumio volumio[987]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Aug 20 17:51:15 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Aug 20 17:51:15 volumio volumio[987]: info: Listing playlists Aug 20 17:51:15 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:51:15 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:51:15 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:51:15 volumio volumio[987]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 17:51:15 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 17:51:15 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:16 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:16 volumio volumio[987]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Aug 20 17:51:16 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Aug 20 17:51:16 volumio volumio[987]: info: Listing playlists Aug 20 17:51:16 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:51:16 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:51:16 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:51:16 volumio volumio[987]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 17:51:16 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 17:51:16 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:16 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:16 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:16 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:16 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:51:16 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:51:16 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:51:16 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Aug 20 17:51:16 volumio volumio[987]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Aug 20 17:51:16 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Aug 20 17:51:16 volumio volumio[987]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Aug 20 17:51:16 volumio volumio[987]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Aug 20 17:51:16 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Aug 20 17:51:16 volumio volumio[987]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Aug 20 17:51:16 volumio volumio[987]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 20 17:51:16 volumio volumio[987]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Aug 20 17:51:16 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Aug 20 17:51:16 volumio volumio[987]: info: Listing playlists Aug 20 17:51:16 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:51:16 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:51:16 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:51:16 volumio volumio[987]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 17:51:16 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 17:51:16 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:16 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:17 volumio volumio[987]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Aug 20 17:51:17 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Aug 20 17:51:17 volumio volumio[987]: info: Listing playlists Aug 20 17:51:17 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:51:17 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:51:17 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:51:17 volumio volumio[987]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 17:51:17 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 17:51:17 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:17 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:17 volumio volumio[987]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Aug 20 17:51:17 volumio volumio[987]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Aug 20 17:51:17 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:17 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:17 volumio volumio-remote-updater[654]: [2024-08-20 17:51:17] [connect] Successful connection Aug 20 17:51:17 volumio volumio-remote-updater[654]: [2024-08-20 17:51:17] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1724169077 101 Aug 20 17:51:17 volumio volumio[987]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 12 Aug 20 17:51:18 volumio volumio[987]: verbose: New Socket.io Connection to 192.168.0.53 from 192.168.0.57 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: Listing playlists Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: Listing playlists Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: Listing playlists Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: Listing playlists Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: Listing playlists Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: Received Get System Info Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 17:51:18 volumio volumio[987]: info: Discovery: Getting this device information Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 20 17:51:18 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 20 17:51:23 volumio volumio[987]: info: Downloading RoonBridge_linuxarmv7hf.tar.bz2 to /tmp/tmp.9C94ccnMVe/RoonBridge_linuxarmv7hf.tar.bz2 Aug 20 17:51:25 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 20 17:51:27 volumio volumio[987]: info: Unpacking RoonBridge_linuxarmv7hf.tar.bz2... Aug 20 17:51:30 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:30 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:36 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 20 17:51:36 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 20 17:51:41 volumio volumio[987]: info: Moving Files into plugin directory. Aug 20 17:51:42 volumio volumio[987]: info: Creating service file. Aug 20 17:51:42 volumio sudo[3001]: pam_unix(sudo:session): session closed for user root Aug 20 17:51:42 volumio volumio[987]: info: Exit Status: 0 Aug 20 17:51:42 volumio volumio[987]: Plugin install end detected on script Aug 20 17:51:42 volumio volumio[987]: info: Install script completed Aug 20 17:51:42 volumio volumio[987]: info: Adding reference to registry Aug 20 17:51:42 volumio volumio[987]: info: Done installing plugin. Aug 20 17:51:42 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 20 17:51:42 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 20 17:51:42 volumio volumio[987]: info: Folder /tmp/plugins removed Aug 20 17:51:42 volumio volumio[987]: info: Folder /tmp/downloaded_plugin.zip removed Aug 20 17:51:42 volumio volumio[987]: info: Folder /data/temp removed Aug 20 17:51:43 volumio volumio[987]: info: Enabling plugin volroon Aug 20 17:51:43 volumio volumio[987]: info: Loading plugin "volroon"... Aug 20 17:51:43 volumio volumio[987]: info: Preparing to generate the ALSA configuration file Aug 20 17:51:43 volumio volumio[987]: info: Asound.conf file unchanged, so no further update is needed Aug 20 17:51:43 volumio volumio[987]: info: Output device has changed, restarting MPD Aug 20 17:51:43 volumio sudo[3236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 20 17:51:43 volumio sudo[3236]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 17:51:43 volumio volumio[987]: info: Output device has changed, restarting Shairport Sync Aug 20 17:51:43 volumio sudo[3236]: pam_unix(sudo:session): session closed for user root Aug 20 17:51:43 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 17:51:43 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 17:51:43 volumio sudo[3239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 20 17:51:43 volumio sudo[3239]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 17:51:43 volumio systemd[1]: Stopping Music Player Daemon... Aug 20 17:51:43 volumio volumio[987]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 20 17:51:43 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAplayInfo Aug 20 17:51:43 volumio systemd[1]: mpd.service: Succeeded. Aug 20 17:51:43 volumio systemd[1]: Stopped Music Player Daemon. Aug 20 17:51:43 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 17:51:43 volumio volumio[987]: info: volroon::Output device has changed Aug 20 17:51:43 volumio volumio[987]: info: PLUGIN START: volroon Aug 20 17:51:43 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAplayInfo Aug 20 17:51:43 volumio systemd[1]: Starting Music Player Daemon... Aug 20 17:51:43 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 17:51:43 volumio sudo[3255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Aug 20 17:51:43 volumio sudo[3255]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 17:51:43 volumio sudo[3246]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 20 17:51:43 volumio sudo[3246]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 17:51:43 volumio volumio[987]: info: volroon::Roon API Services Started Aug 20 17:51:43 volumio volumio[987]: info: Done. Aug 20 17:51:43 volumio sudo[3246]: pam_unix(sudo:session): session closed for user root Aug 20 17:51:43 volumio volumio[987]: info: MPD Permissions set Aug 20 17:51:43 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 17:51:43 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 17:51:43 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 17:51:43 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 17:51:43 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 17:51:43 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 17:51:43 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 17:51:43 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 17:51:44 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 17:51:44 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 17:51:44 volumio sudo[3255]: pam_unix(sudo:session): session closed for user root Aug 20 17:51:44 volumio volumio[987]: info: ::Roon Bridge has successfully started Aug 20 17:51:44 volumio volumio[987]: info: Starting Shairport Sync Aug 20 17:51:44 volumio sudo[3267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 20 17:51:44 volumio sudo[3267]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 17:51:44 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 20 17:51:44 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 20 17:51:44 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 20 17:51:44 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 20 17:51:44 volumio sudo[3267]: pam_unix(sudo:session): session closed for user root Aug 20 17:51:44 volumio volumio[987]: info: Shairport-Sync Started Aug 20 17:51:44 volumio mpd[3259]: Aug 20 17:51 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 20 17:51:44 volumio systemd[1]: Started Music Player Daemon. Aug 20 17:51:44 volumio sudo[3239]: pam_unix(sudo:session): session closed for user root Aug 20 17:51:44 volumio volumio[987]: error: updateQueue error: null Aug 20 17:51:49 volumio volumio[987]: info: volroon::Roon Core Paired: 192.168.0.212:9330 with ID of: a94f59f2-53b4-4d8f-a3d4-e93b123a8876 Aug 20 17:51:49 volumio volumio[987]: info: volroon::getState Aug 20 17:51:49 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:49 volumio volumio[987]: info: CoreCommandRouter::volumioClearQueue Aug 20 17:51:49 volumio volumio[987]: info: CoreStateMachine::ClearQueue Aug 20 17:51:49 volumio volumio[987]: info: CoreStateMachine::stop Aug 20 17:51:49 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 17:51:49 volumio volumio[987]: info: CorePlayQueue::clearPlayQueue Aug 20 17:51:49 volumio volumio[987]: info: CorePlayQueue::saveQueue Aug 20 17:51:49 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Aug 20 17:51:49 volumio volumio[987]: info: CoreCommandRouter::volumioPushQueue Aug 20 17:51:49 volumio volumio[987]: info: CoreCommandRouter::volumioStop Aug 20 17:51:49 volumio volumio[987]: info: CoreStateMachine::stop Aug 20 17:51:49 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 17:51:49 volumio volumio[987]: verbose: volroon::State snapshot: {"status":"play","service":"volroon","title":"Brand New Dance","artist":"Eminem","album":"The Death of Slim Shady (Coup De Grâce)","albumart":"http://192.168.0.212:9330/api/image/79927aeb8fccd22266f70d903f161ce0","uri":"","trackType":"roon","seek":8000,"duration":206,"samplerate":"","bitdepth":"","bitrate":"","channels":2,"stream":false,"random":false,"repeat":false,"repeatSingle":false,"disableUiControls":false} Aug 20 17:51:49 volumio volumio[987]: info: volroon::pushState Aug 20 17:51:49 volumio volumio[987]: info: CoreCommandRouter::servicePushState Aug 20 17:51:49 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:49 volumio volumio[987]: verbose: STATE SERVICE {"status":"play","service":"volroon","title":"Brand New Dance","artist":"Eminem","album":"The Death of Slim Shady (Coup De Grâce)","albumart":"http://192.168.0.212:9330/api/image/79927aeb8fccd22266f70d903f161ce0","uri":"","trackType":"roon","seek":8000,"duration":206,"samplerate":"","bitdepth":"","bitrate":"","channels":2,"stream":false,"random":false,"repeat":false,"repeatSingle":false,"disableUiControls":false} Aug 20 17:51:49 volumio volumio[987]: verbose: CURRENT POSITION 0 Aug 20 17:51:49 volumio volumio[987]: info: CoreStateMachine::syncState stateService play Aug 20 17:51:49 volumio volumio[987]: info: CoreStateMachine::syncState currentStatus stop Aug 20 17:51:49 volumio volumio[987]: info: CoreStateMachine::resetVolumioState Aug 20 17:51:49 volumio volumio[987]: info: CoreStateMachine::getcurrentVolume Aug 20 17:51:49 volumio volumio[987]: info: CoreCommandRouter::volumioRetrievevolume Aug 20 17:51:49 volumio volumio[987]: verbose: volroon::State snapshot: {"status":"play","service":"volroon","title":"Brand New Dance","artist":"Eminem","album":"The Death of Slim Shady (Coup De Grâce)","albumart":"http://192.168.0.212:9330/api/image/79927aeb8fccd22266f70d903f161ce0","uri":"","trackType":"roon","seek":9000,"duration":206,"samplerate":"","bitdepth":"","bitrate":"","channels":2,"stream":false,"random":false,"repeat":false,"repeatSingle":false,"disableUiControls":false} Aug 20 17:51:49 volumio volumio[987]: info: volroon::pushState Aug 20 17:51:49 volumio volumio[987]: info: CoreCommandRouter::servicePushState Aug 20 17:51:49 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:49 volumio volumio[987]: verbose: STATE SERVICE {"status":"play","service":"volroon","title":"Brand New Dance","artist":"Eminem","album":"The Death of Slim Shady (Coup De Grâce)","albumart":"http://192.168.0.212:9330/api/image/79927aeb8fccd22266f70d903f161ce0","uri":"","trackType":"roon","seek":9000,"duration":206,"samplerate":"","bitdepth":"","bitrate":"","channels":2,"stream":false,"random":false,"repeat":false,"repeatSingle":false,"disableUiControls":false} Aug 20 17:51:49 volumio volumio[987]: verbose: CURRENT POSITION 0 Aug 20 17:51:49 volumio volumio[987]: info: CoreStateMachine::syncState stateService play Aug 20 17:51:49 volumio volumio[987]: info: CoreStateMachine::syncState currentStatus stop Aug 20 17:51:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:51:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:51:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Aug 20 17:51:49 volumio volumio[987]: info: VolumeController:: Volume=100 Mute =true Aug 20 17:51:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:51:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:51:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Aug 20 17:51:49 volumio volumio[987]: info: CoreStateMachine::pushState Aug 20 17:51:49 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:49 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 17:51:49 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Aug 20 17:51:49 volumio volumio[987]: info: CoreStateMachine::updateTrackBlock Aug 20 17:51:49 volumio volumio[987]: info: CorePlayQueue::getTrackBlock Aug 20 17:51:49 volumio volumio[987]: info: CoreCommandRouter::volumioRetrievevolume Aug 20 17:51:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:51:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:51:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Aug 20 17:51:49 volumio volumio[987]: info: VolumeController:: Volume=100 Mute =true Aug 20 17:51:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:51:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:51:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Aug 20 17:51:49 volumio volumio[987]: info: CoreStateMachine::pushState Aug 20 17:51:49 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Aug 20 17:51:49 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Aug 20 17:51:50 volumio volumio[987]: info: volroon::Setting volatile state to volroon Aug 20 17:51:50 volumio volumio[987]: info: volroon::pushState Aug 20 17:51:50 volumio volumio[987]: info: CoreCommandRouter::servicePushState Aug 20 17:51:50 volumio volumio[987]: info: CoreStateMachine::pushState Aug 20 17:51:50 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 17:51:50 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Aug 20 17:51:50 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 17:51:50 volumio volumio[987]: info: [now-playing] Fetch metadata (DefaultMetadataProvider): {"type":"song","name":"Brand New Dance","artist":"Eminem","album":"The Death of Slim Shady (Coup De Grâce)","duration":"206","uri":"","service":""} Aug 20 17:51:50 volumio volumio[987]: info: [now-playing] LRCLIB getLyrics(): song: "Brand New Dance" album: "The Death of Slim Shady (Coup De Grâce)" artist: "Eminem" duration: "206" Aug 20 17:51:50 volumio volumio[987]: info: [now-playing] LRCLIB getLyrics() API URL: https://lrclib.net/api/get?track_name=Brand+New+Dance&artist_name=Eminem&album_name=The+Death+of+Slim+Shady+%28Coup+De+Gr%C3%A2ce%29&duration=206 Aug 20 17:51:51 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:51 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:51:51 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:51:51 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:51:51 volumio volumio[987]: info: volroon::pushState Aug 20 17:51:51 volumio volumio[987]: info: CoreCommandRouter::servicePushState Aug 20 17:51:51 volumio volumio[987]: info: CoreStateMachine::pushState Aug 20 17:51:51 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 17:51:51 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Aug 20 17:51:52 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:52 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:51:52 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:51:52 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:51:53 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:53 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:51:53 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:51:53 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:51:54 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:54 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:51:54 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:51:54 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:51:55 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:55 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:51:55 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:51:55 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:51:56 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:56 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:51:56 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:51:56 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:51:57 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:57 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:51:57 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:51:57 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:51:58 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:58 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:51:58 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:51:58 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:51:59 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:51:59 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:51:59 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:51:59 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:52:00 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:52:00 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:52:00 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:52:00 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:52:01 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:52:01 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:52:01 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:52:01 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:52:02 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:52:02 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:52:02 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:52:02 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:52:03 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:52:03 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:52:03 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:52:03 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:52:03 volumio volumio[987]: verbose: volroon::State snapshot: {"status":"pause","service":"volroon","title":"Brand New Dance","artist":"Eminem","album":"The Death of Slim Shady (Coup De Grâce)","albumart":"http://192.168.0.212:9330/api/image/79927aeb8fccd22266f70d903f161ce0","uri":"","trackType":"roon","seek":23000,"duration":206,"samplerate":"","bitdepth":"","bitrate":"","channels":2,"stream":false,"random":false,"repeat":false,"repeatSingle":false,"disableUiControls":false,"codec":"","repeatMode":"all"} Aug 20 17:52:03 volumio volumio[987]: info: volroon::pushState Aug 20 17:52:03 volumio volumio[987]: info: CoreCommandRouter::servicePushState Aug 20 17:52:03 volumio volumio[987]: info: CoreStateMachine::pushState Aug 20 17:52:03 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 17:52:03 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Aug 20 17:52:04 volumio volumio[987]: info: touch_display: Setting screensaver timeout to 120 seconds. Aug 20 17:52:08 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:52:29 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 17:52:29 volumio volumio[987]: info: Loaded the previous config. Aug 20 17:52:29 volumio volumio[987]: info: ## populating UI... Aug 20 17:52:29 volumio volumio[987]: info: 1/1 settings loaded Aug 20 17:52:29 volumio volumio[987]: info: Populated config screen. Aug 20 17:52:32 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:52:36 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:52:36 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:52:36 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:52:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:52:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:52:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Aug 20 17:52:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:52:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:52:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:52:37 volumio volumio[987]: verbose: volroon::State snapshot: {"status":"pause","service":"volroon","title":"Brand New Dance","artist":"Eminem","album":"The Death of Slim Shady (Coup De Grâce)","albumart":"http://192.168.0.212:9330/api/image/79927aeb8fccd22266f70d903f161ce0","uri":"","trackType":"roon","seek":23000,"duration":206,"samplerate":"","bitdepth":"","bitrate":"","channels":2,"stream":false,"random":false,"repeat":false,"repeatSingle":false,"disableUiControls":false,"codec":"","repeatMode":"all"} Aug 20 17:52:37 volumio volumio[987]: info: volroon::pushState Aug 20 17:52:37 volumio volumio[987]: info: CoreCommandRouter::servicePushState Aug 20 17:52:37 volumio volumio[987]: info: CoreStateMachine::pushState Aug 20 17:52:37 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Aug 20 17:52:47 volumio volumio[987]: info: CoreCommandRouter::volumioVolatilePlay Aug 20 17:52:47 volumio volumio[987]: info: CoreStateMachine::volatilePlay Aug 20 17:52:47 volumio volumio[987]: info: volroon::play command successfully sent to Roon. Aug 20 17:52:47 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:52:47 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:52:47 volumio volumio[987]: verbose: volroon::State snapshot: {"status":"play","service":"volroon","title":"Brand New Dance","artist":"Eminem","album":"The Death of Slim Shady (Coup De Grâce)","albumart":"http://192.168.0.212:9330/api/image/79927aeb8fccd22266f70d903f161ce0","uri":"","trackType":"roon","seek":23000,"duration":206,"samplerate":"","bitdepth":"","bitrate":"","channels":2,"stream":false,"random":false,"repeat":false,"repeatSingle":false,"disableUiControls":false,"codec":"","repeatMode":"all"} Aug 20 17:52:47 volumio volumio[987]: info: volroon::pushState Aug 20 17:52:47 volumio volumio[987]: info: CoreCommandRouter::servicePushState Aug 20 17:52:47 volumio volumio[987]: info: CoreStateMachine::pushState Aug 20 17:52:47 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 17:52:47 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Aug 20 17:52:48 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:52:48 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:52:48 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:52:48 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:52:49 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:52:49 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:52:49 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:52:49 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:52:50 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Aug 20 17:52:50 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Aug 20 17:52:50 volumio volumio[987]: info: CoreStateMachine::getQueue Aug 20 17:52:50 volumio volumio[987]: info: CorePlayQueue::getQueue Aug 20 17:52:51 volumio volumio[987]: info: CoreCommandRouter::volumioPause Aug 20 17:52:51 volumio volumio[987]: info: CoreStateMachine::pause Aug 20 17:52:51 volumio volumio[987]: info: CoreStateMachine::stPlaybackTimer Aug 20 17:52:51 volumio volumio[987]: info: CoreStateMachine::servicePause Aug 20 17:52:51 volumio volumio[987]: info: CoreCommandRouter::servicePause Aug 20 17:52:51 volumio volumio[987]: info: volroon::pause command successfully sent to Roon. Aug 20 17:52:51 volumio volumio[987]: verbose: volroon::State snapshot: {"status":"pause","service":"volroon","title":"Brand New Dance","artist":"Eminem","album":"The Death of Slim Shady (Coup De Grâce)","albumart":"http://192.168.0.212:9330/api/image/79927aeb8fccd22266f70d903f161ce0","uri":"","trackType":"roon","seek":24000,"duration":206,"samplerate":"","bitdepth":"","bitrate":"","channels":2,"stream":false,"random":false,"repeat":false,"repeatSingle":false,"disableUiControls":false,"codec":"","repeatMode":"all"} Aug 20 17:52:51 volumio volumio[987]: info: volroon::pushState Aug 20 17:52:51 volumio volumio[987]: info: CoreCommandRouter::servicePushState Aug 20 17:52:51 volumio volumio[987]: info: CoreStateMachine::pushState Aug 20 17:52:51 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 17:52:51 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Aug 20 17:52:51 volumio volumio[987]: info: touch_display: Setting screensaver timeout to 120 seconds. Aug 20 17:52:56 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 17:52:56 volumio volumio[987]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Aug 20 17:52:56 volumio volumio[987]: info: PLUGIN onReboot : networkfs Aug 20 17:52:56 volumio volumio[987]: info: PLUGIN onReboot : audiophonicsonoff Aug 20 17:52:56 volumio volumio[987]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 20 17:52:56 volumio volumio[987]: TypeError: Cannot read property 'writeSync' of undefined Aug 20 17:52:56 volumio volumio[987]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Aug 20 17:52:56 volumio volumio[987]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Aug 20 17:52:56 volumio volumio[987]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Aug 20 17:52:56 volumio volumio[987]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Aug 20 17:52:56 volumio volumio[987]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Aug 20 17:52:56 volumio volumio[987]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Aug 20 17:52:56 volumio volumio[987]: at CoreCommandRouter.reboot (/volumio/app/index.js:1331:22) Aug 20 17:52:56 volumio volumio[987]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:864:33) Aug 20 17:52:56 volumio volumio[987]: at Socket.emit (events.js:315:20) Aug 20 17:52:56 volumio volumio[987]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 20 17:52:56 volumio volumio[987]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Aug 20 17:52:56 volumio volumio[987]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 20 17:52:57 volumio sudo[3342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-20 17:51 Aug 20 17:52:57 volumio sudo[3342]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"