-- Logs begin at Wed 2024-10-09 06:39:08 BST, end at Fri 2024-10-11 21:17:44 BST. -- Oct 11 21:16:06 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:06 volumio volumio[1072]: info: CorePlayQueue::getTrack 5 Oct 11 21:16:06 volumio volumio[1072]: info: Listing playlists Oct 11 21:16:06 volumio volumio[1072]: info: Listing playlists Oct 11 21:16:16 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:16 volumio volumio[1072]: info: CorePlayQueue::getTrack 5 Oct 11 21:16:26 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:26 volumio volumio[1072]: info: CorePlayQueue::getTrack 5 Oct 11 21:16:26 volumio volumio[1072]: info: Listing playlists Oct 11 21:16:26 volumio volumio[1072]: info: Listing playlists Oct 11 21:16:29 volumio volumio[1072]: info: CorePlayQueue::getTrack 5 Oct 11 21:16:29 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:29 volumio volumio[1072]: info: Prefetching next song Oct 11 21:16:29 volumio volumio[1072]: info: [1728677789397] ControllerVolusonic::prefetch Oct 11 21:16:29 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.56:4533/rest/stream.view?id=8e5b9db13de4c921085634cfb8b63e14&format=raw&u=lee1471&p=enc:31343731&v=1.10.2&f=json&c=volusonic" Oct 11 21:16:29 volumio volumio[1072]: info: sendMpdCommand add "http://192.168.1.56:4533/rest/stream.view?id=8e5b9db13de4c921085634cfb8b63e14&format=raw&u=lee1471&p=enc:31343731&v=1.10.2&f=json&c=volusonic" took 1 milliseconds Oct 11 21:16:29 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 11 21:16:29 volumio volumio[1072]: info: Oct 11 21:16:29 volumio volumio[1072]: ---------------------------- MPD announces system playlist update Oct 11 21:16:29 volumio volumio[1072]: info: Ignoring MPD Status Update Oct 11 21:16:29 volumio volumio[1072]: info: sendMpdCommand consume 1 took 1 milliseconds Oct 11 21:16:29 volumio volumio[1072]: info: Oct 11 21:16:29 volumio volumio[1072]: ---------------------------- MPD announces system playlist update Oct 11 21:16:29 volumio volumio[1072]: info: Ignoring MPD Status Update Oct 11 21:16:29 volumio volumio[1072]: info: Oct 11 21:16:29 volumio volumio[1072]: ---------------------------- MPD announces system playlist update Oct 11 21:16:29 volumio volumio[1072]: info: Ignoring MPD Status Update Oct 11 21:16:29 volumio volumio[1072]: info: Oct 11 21:16:29 volumio volumio[1072]: ---------------------------- MPD announces system playlist update Oct 11 21:16:29 volumio volumio[1072]: info: Ignoring MPD Status Update Oct 11 21:16:29 volumio volumio[1072]: info: ------------------------------ 3ms Oct 11 21:16:29 volumio volumio[1072]: info: ------------------------------ 3ms Oct 11 21:16:29 volumio volumio[1072]: info: ------------------------------ 2ms Oct 11 21:16:30 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 21:16:30 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 21:16:30 volumio volumio[1072]: info: Discovery: Getting this device information Oct 11 21:16:30 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:30 volumio volumio[1072]: info: CorePlayQueue::getTrack 5 Oct 11 21:16:30 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 21:16:30 volumio volumio[1072]: verbose: New Socket.io Connection to 192.168.1.147 from 192.168.1.95 UA: Mozilla/5.0 (Linux; Android 13; SM-G988B Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.81 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 11 21:16:30 volumio volumio[1072]: verbose: New Socket.io Connection to 192.168.1.147 from 192.168.1.95 UA: Mozilla/5.0 (Linux; Android 13; SM-G988B Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.81 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Oct 11 21:16:30 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 21:16:30 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 21:16:30 volumio volumio[1072]: info: Discovery: Getting this device information Oct 11 21:16:30 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:30 volumio volumio[1072]: info: CorePlayQueue::getTrack 5 Oct 11 21:16:30 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 21:16:31 volumio volumio[1072]: verbose: New Socket.io Connection to 192.168.1.147:3000 from 192.168.1.95 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Oct 11 21:16:31 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 21:16:31 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 21:16:31 volumio volumio[1072]: info: Discovery: Getting this device information Oct 11 21:16:31 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:31 volumio volumio[1072]: info: CorePlayQueue::getTrack 5 Oct 11 21:16:31 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 21:16:33 volumio volumio[1072]: info: CoreStateMachine::startPlaybackTimer Oct 11 21:16:33 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:34 volumio volumio[1072]: info: CoreStateMachine::pushState Oct 11 21:16:34 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:34 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 21:16:34 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Oct 11 21:16:34 volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Oct 11 21:16:34 volumio volumio[1072]: info: CoreStateMachine::getQueue Oct 11 21:16:34 volumio volumio[1072]: info: CorePlayQueue::getQueue Oct 11 21:16:34 volumio volumio[1072]: info: Oct 11 21:16:34 volumio volumio[1072]: ---------------------------- MPD announces system playlist update Oct 11 21:16:34 volumio volumio[1072]: info: Ignoring MPD Status Update Oct 11 21:16:34 volumio volumio[1072]: info: [1728677794673] ControllerVolusonic: MPD player state update Oct 11 21:16:34 volumio volumio[1072]: info: ControllerMpd::getState Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand status Oct 11 21:16:34 volumio volumio[1072]: info: Oct 11 21:16:34 volumio volumio[1072]: ---------------------------- MPD announces state update: player Oct 11 21:16:34 volumio volumio[1072]: info: ControllerMpd::getState Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand status Oct 11 21:16:34 volumio volumio[1072]: info: Oct 11 21:16:34 volumio volumio[1072]: ---------------------------- MPD announces system playlist update Oct 11 21:16:34 volumio volumio[1072]: info: Ignoring MPD Status Update Oct 11 21:16:34 volumio volumio[1072]: info: Oct 11 21:16:34 volumio volumio[1072]: ---------------------------- MPD announces state update: player Oct 11 21:16:34 volumio volumio[1072]: info: ControllerMpd::getState Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand status Oct 11 21:16:34 volumio volumio[1072]: info: Oct 11 21:16:34 volumio volumio[1072]: ---------------------------- MPD announces system playlist update Oct 11 21:16:34 volumio volumio[1072]: info: Ignoring MPD Status Update Oct 11 21:16:34 volumio volumio[1072]: info: Oct 11 21:16:34 volumio volumio[1072]: ---------------------------- MPD announces state update: player Oct 11 21:16:34 volumio volumio[1072]: info: ControllerMpd::getState Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand status Oct 11 21:16:34 volumio volumio[1072]: info: Oct 11 21:16:34 volumio volumio[1072]: ---------------------------- MPD announces system playlist update Oct 11 21:16:34 volumio volumio[1072]: info: Ignoring MPD Status Update Oct 11 21:16:34 volumio volumio[1072]: info: Oct 11 21:16:34 volumio volumio[1072]: ---------------------------- MPD announces state update: player Oct 11 21:16:34 volumio volumio[1072]: info: ControllerMpd::getState Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand status Oct 11 21:16:34 volumio volumio[1072]: info: sendMpdCommand status took 10 milliseconds Oct 11 21:16:34 volumio volumio[1072]: info: ------------------------------ 13ms Oct 11 21:16:34 volumio volumio[1072]: info: sendMpdCommand status took 10 milliseconds Oct 11 21:16:34 volumio volumio[1072]: info: ------------------------------ 10ms Oct 11 21:16:34 volumio volumio[1072]: info: sendMpdCommand status took 9 milliseconds Oct 11 21:16:34 volumio volumio[1072]: info: ------------------------------ 8ms Oct 11 21:16:34 volumio volumio[1072]: info: sendMpdCommand status took 7 milliseconds Oct 11 21:16:34 volumio volumio[1072]: info: ------------------------------ 7ms Oct 11 21:16:34 volumio volumio[1072]: info: sendMpdCommand status took 5 milliseconds Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::parseState Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::parseState Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::parseState Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::parseState Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::parseState Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 21:16:34 volumio volumio[1072]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 11 21:16:34 volumio volumio[1072]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 11 21:16:34 volumio volumio[1072]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 11 21:16:34 volumio volumio[1072]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 11 21:16:34 volumio volumio[1072]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::parseTrackInfo Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::parseTrackInfo Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::parseTrackInfo Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::parseTrackInfo Oct 11 21:16:34 volumio volumio[1072]: verbose: ControllerMpd::parseTrackInfo Oct 11 21:16:34 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:34 volumio volumio[1072]: info: [1728677794698] ControllerVolusonic::pushState Oct 11 21:16:34 volumio volumio[1072]: info: CoreCommandRouter::servicePushState Oct 11 21:16:34 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:34 volumio volumio[1072]: verbose: STATE SERVICE {"status":"play","position":0,"seek":31,"duration":246,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3496 Kbps","isStreaming":false,"title":"Human Nature","artist":"Michael Jackson","album":"Thriller","uri":"http://192.168.1.56:4533/rest/stream.view?id=8e5b9db13de4c921085634cfb8b63e14&format=raw&u=lee1471&p=enc:31343731&v=1.10.2&f=json&c=volusonic","trackType":""} Oct 11 21:16:34 volumio volumio[1072]: verbose: CURRENT POSITION 6 Oct 11 21:16:34 volumio volumio[1072]: info: CoreStateMachine::syncState stateService play Oct 11 21:16:34 volumio volumio[1072]: info: CoreStateMachine::syncState currentStatus play Oct 11 21:16:34 volumio volumio[1072]: info: Received an update from plugin. extracting info from payload Oct 11 21:16:34 volumio volumio[1072]: info: CoreStateMachine::pushState Oct 11 21:16:34 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:34 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 21:16:34 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Oct 11 21:16:34 volumio volumio[1072]: info: CoreStateMachine::pushState Oct 11 21:16:34 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:34 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Oct 11 21:16:34 volumio volumio[1072]: info: ControllerMpd::pushState Oct 11 21:16:34 volumio volumio[1072]: info: CoreCommandRouter::servicePushState Oct 11 21:16:34 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:34 volumio volumio[1072]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received mpd Oct 11 21:16:34 volumio volumio[1072]: info: ControllerMpd::pushState Oct 11 21:16:34 volumio volumio[1072]: info: CoreCommandRouter::servicePushState Oct 11 21:16:34 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:34 volumio volumio[1072]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received mpd Oct 11 21:16:34 volumio volumio[1072]: info: ControllerMpd::pushState Oct 11 21:16:34 volumio volumio[1072]: info: CoreCommandRouter::servicePushState Oct 11 21:16:34 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:34 volumio volumio[1072]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received mpd Oct 11 21:16:34 volumio volumio[1072]: info: ControllerMpd::pushState Oct 11 21:16:34 volumio volumio[1072]: info: CoreCommandRouter::servicePushState Oct 11 21:16:34 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:34 volumio volumio[1072]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received mpd Oct 11 21:16:34 volumio volumio[1072]: info: ------------------------------ 42ms Oct 11 21:16:34 volumio volumio[1072]: info: ------------------------------ 40ms Oct 11 21:16:34 volumio volumio[1072]: info: ------------------------------ 38ms Oct 11 21:16:34 volumio volumio[1072]: info: ------------------------------ 36ms Oct 11 21:16:36 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:36 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:43 volumio volumio[1072]: verbose: New Socket.io Connection to 192.168.1.147 from 192.168.1.95 UA: Mozilla/5.0 (Linux; Android 13; SM-G988B Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.81 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Oct 11 21:16:44 volumio volumio[1072]: info: Received Get System Info Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 21:16:44 volumio volumio[1072]: info: Discovery: Getting this device information Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:44 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:44 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::volumioGetVisibleSources Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:44 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 11 21:16:44 volumio volumio[1072]: info: Received Get System Info Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 21:16:44 volumio volumio[1072]: info: Discovery: Getting this device information Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:44 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:44 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:44 volumio volumio[1072]: info: Listing playlists Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Oct 11 21:16:44 volumio volumio[1072]: info: CoreStateMachine::getQueue Oct 11 21:16:44 volumio volumio[1072]: info: CorePlayQueue::getQueue Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 11 21:16:44 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 11 21:16:46 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:46 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:46 volumio volumio[1072]: info: Listing playlists Oct 11 21:16:46 volumio volumio[1072]: info: Listing playlists Oct 11 21:16:49 volumio sudo[2127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 11 21:16:49 volumio sudo[2127]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 21:16:49 volumio sudo[2127]: pam_unix(sudo:session): session closed for user root Oct 11 21:16:49 volumio sudo[2130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 11 21:16:49 volumio sudo[2130]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 21:16:49 volumio sudo[2130]: pam_unix(sudo:session): session closed for user root Oct 11 21:16:49 volumio volumio[1072]: verbose: New Socket.io Connection to 192.168.1.147 from 192.168.1.95 UA: Mozilla/5.0 (Linux; Android 13; SM-G988B Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.81 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Oct 11 21:16:50 volumio sudo[2133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 11 21:16:50 volumio sudo[2133]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 21:16:50 volumio sudo[2133]: pam_unix(sudo:session): session closed for user root Oct 11 21:16:50 volumio sudo[2136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 11 21:16:50 volumio sudo[2136]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 21:16:50 volumio sudo[2136]: pam_unix(sudo:session): session closed for user root Oct 11 21:16:50 volumio volumio[1072]: verbose: New Socket.io Connection to 192.168.1.147 from 192.168.1.95 UA: Mozilla/5.0 (Linux; Android 13; SM-G988B Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.81 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::volumioGetVisibleSources Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:50 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Oct 11 21:16:50 volumio volumio[1072]: info: CoreStateMachine::getQueue Oct 11 21:16:50 volumio volumio[1072]: info: CorePlayQueue::getQueue Oct 11 21:16:50 volumio volumio[1072]: info: Listing playlists Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 11 21:16:50 volumio volumio[1072]: info: Received Get System Info Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 21:16:50 volumio volumio[1072]: info: Discovery: Getting this device information Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:50 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:50 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 11 21:16:50 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 11 21:16:52 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 11 21:16:52 volumio volumio[1072]: info: Received Get System Info Oct 11 21:16:52 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 21:16:52 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 21:16:52 volumio volumio[1072]: info: Discovery: Getting this device information Oct 11 21:16:52 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:52 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:52 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 21:16:52 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 11 21:16:53 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 11 21:16:53 volumio volumio[1072]: info: Received Get System Info Oct 11 21:16:53 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 21:16:53 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 21:16:53 volumio volumio[1072]: info: Discovery: Getting this device information Oct 11 21:16:53 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:53 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:53 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 21:16:54 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 11 21:16:56 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:16:56 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:16:57 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volusonic , handleBrowseUri Oct 11 21:16:57 volumio volumio[1072]: info: Preload queue cleared Oct 11 21:17:00 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 11 21:17:01 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 21:17:01 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 21:17:01 volumio volumio[1072]: info: Discovery: Getting this device information Oct 11 21:17:01 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:17:01 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:17:01 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 21:17:02 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volusonic , handleBrowseUri Oct 11 21:17:02 volumio volumio[1072]: info: Preload queue cleared Oct 11 21:17:06 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:17:06 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:17:06 volumio volumio[1072]: info: Listing playlists Oct 11 21:17:06 volumio volumio[1072]: info: Listing playlists Oct 11 21:17:08 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 11 21:17:08 volumio volumio[1072]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 11 21:17:08 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 11 21:17:08 volumio volumio[1072]: info: Received Get System Version Oct 11 21:17:08 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 11 21:17:08 volumio volumio[1072]: info: Received Get System Info Oct 11 21:17:08 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 21:17:08 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 21:17:08 volumio volumio[1072]: info: Discovery: Getting this device information Oct 11 21:17:08 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:17:08 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:17:08 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 21:17:12 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volusonic , handleBrowseUri Oct 11 21:17:12 volumio volumio[1072]: info: Preload queue cleared Oct 11 21:17:12 volumio volumio[1072]: info: Preloading song: volusonic/track/17509ff61a3acb27bf9a3c8078f8cf13 Oct 11 21:17:12 volumio volumio[1072]: info: Preloading song: volusonic/track/a1a8f1328933173c096c4d22d43906d6 Oct 11 21:17:12 volumio volumio[1072]: info: Preloading song: volusonic/track/808b03697bffc2f9021f53e5c7ad2cb2 Oct 11 21:17:12 volumio volumio[1072]: info: Preloading song: volusonic/track/2e0e380efec5ce9a93b5c63b5430ee29 Oct 11 21:17:12 volumio volumio[1072]: info: Preloading song: volusonic/track/017623d5826fd4e78ee452c5854e9dda Oct 11 21:17:12 volumio volumio[1072]: info: Preloading song: volusonic/track/dfd2f675a1f48e28c5e7adf961017032 Oct 11 21:17:12 volumio volumio[1072]: info: Preloading song: volusonic/track/93b7256055ea71615361ef5259acfe52 Oct 11 21:17:12 volumio volumio[1072]: info: Preloading song: volusonic/track/fa98ad58dcdf4fb81019c30fdb700c71 Oct 11 21:17:12 volumio volumio[1072]: info: Preloading song: volusonic/track/5ffdd314ca9e5213766c72c6941830ed Oct 11 21:17:12 volumio volumio[1072]: info: Preloading song: volusonic/track/41627d16f4658ccdab9aeeed42a17e82 Oct 11 21:17:12 volumio volumio[1072]: info: Preloading song: volusonic/track/e41efbcd085654ae1a31a9209c5f20c0 Oct 11 21:17:12 volumio volumio[1072]: info: Exploding uri volusonic/track/17509ff61a3acb27bf9a3c8078f8cf13 in service volusonic Oct 11 21:17:12 volumio volumio[1072]: info: Exploding uri volusonic/track/a1a8f1328933173c096c4d22d43906d6 in service volusonic Oct 11 21:17:12 volumio volumio[1072]: info: No valid Plugin REST Endpoint Oct 11 21:17:12 volumio volumio[1072]: info: Exploding uri volusonic/track/808b03697bffc2f9021f53e5c7ad2cb2 in service volusonic Oct 11 21:17:12 volumio volumio[1072]: info: Exploding uri volusonic/track/2e0e380efec5ce9a93b5c63b5430ee29 in service volusonic Oct 11 21:17:12 volumio volumio[1072]: info: Exploding uri volusonic/track/017623d5826fd4e78ee452c5854e9dda in service volusonic Oct 11 21:17:12 volumio volumio[1072]: info: Exploding uri volusonic/track/dfd2f675a1f48e28c5e7adf961017032 in service volusonic Oct 11 21:17:12 volumio volumio[1072]: info: Exploding uri volusonic/track/93b7256055ea71615361ef5259acfe52 in service volusonic Oct 11 21:17:12 volumio volumio[1072]: info: Exploding uri volusonic/track/fa98ad58dcdf4fb81019c30fdb700c71 in service volusonic Oct 11 21:17:13 volumio volumio[1072]: info: Exploding uri volusonic/track/5ffdd314ca9e5213766c72c6941830ed in service volusonic Oct 11 21:17:13 volumio volumio[1072]: info: Exploding uri volusonic/track/41627d16f4658ccdab9aeeed42a17e82 in service volusonic Oct 11 21:17:13 volumio volumio[1072]: info: Exploding uri volusonic/track/e41efbcd085654ae1a31a9209c5f20c0 in service volusonic Oct 11 21:17:16 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:17:16 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:17:26 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:17:26 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:17:26 volumio volumio[1072]: info: Listing playlists Oct 11 21:17:26 volumio volumio[1072]: info: Listing playlists Oct 11 21:17:26 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volusonic , handleBrowseUri Oct 11 21:17:26 volumio volumio[1072]: info: Preload queue cleared Oct 11 21:17:26 volumio volumio[1072]: info: Preloading song: volusonic/track/28bba93d508d5cccb806b2436b6fe893 Oct 11 21:17:26 volumio volumio[1072]: info: Preloading song: volusonic/track/98e697f1c373bdd7e4ca4c040f7ec650 Oct 11 21:17:26 volumio volumio[1072]: info: Preloading song: volusonic/track/9e52f8f6622378963668bc387d6595b5 Oct 11 21:17:26 volumio volumio[1072]: info: Preloading song: volusonic/track/a11fed1875d99829bf77feea3b06b56e Oct 11 21:17:26 volumio volumio[1072]: info: Preloading song: volusonic/track/c127452cd751713b1ec2150bb5c0db0e Oct 11 21:17:26 volumio volumio[1072]: info: Preloading song: volusonic/track/d9621b1b57a9250ea5d93f770eff8683 Oct 11 21:17:26 volumio volumio[1072]: info: Preloading song: volusonic/track/54831676ecb626cb639546bc360d92f1 Oct 11 21:17:26 volumio volumio[1072]: info: Preloading song: volusonic/track/f0bae108d32cee5e60b8c7a6540310c1 Oct 11 21:17:26 volumio volumio[1072]: info: Preloading song: volusonic/track/861d0963e4e547af1673c1cf76f5cf31 Oct 11 21:17:26 volumio volumio[1072]: info: Preloading song: volusonic/track/b78d7459130c4bf79883dd2bc9380ad5 Oct 11 21:17:26 volumio volumio[1072]: info: Preloading song: volusonic/track/77867d2938f4a5d064f481177615ecd8 Oct 11 21:17:26 volumio volumio[1072]: info: Preloading song: volusonic/track/f88bc8a4527d3fc3f9999ed7b5fbc296 Oct 11 21:17:26 volumio volumio[1072]: info: Preloading song: volusonic/track/3a8f608d7abf6e9ffee7ed3c4902950c Oct 11 21:17:26 volumio volumio[1072]: info: Preloading song: volusonic/track/649ad235aa89e2fa9f69667f0f8743c2 Oct 11 21:17:26 volumio volumio[1072]: info: Exploding uri volusonic/track/28bba93d508d5cccb806b2436b6fe893 in service volusonic Oct 11 21:17:26 volumio volumio[1072]: info: Exploding uri volusonic/track/98e697f1c373bdd7e4ca4c040f7ec650 in service volusonic Oct 11 21:17:26 volumio volumio[1072]: info: No valid Plugin REST Endpoint Oct 11 21:17:26 volumio volumio[1072]: info: Exploding uri volusonic/track/9e52f8f6622378963668bc387d6595b5 in service volusonic Oct 11 21:17:26 volumio volumio[1072]: info: Exploding uri volusonic/track/a11fed1875d99829bf77feea3b06b56e in service volusonic Oct 11 21:17:27 volumio volumio[1072]: info: Exploding uri volusonic/track/c127452cd751713b1ec2150bb5c0db0e in service volusonic Oct 11 21:17:27 volumio volumio[1072]: info: Exploding uri volusonic/track/d9621b1b57a9250ea5d93f770eff8683 in service volusonic Oct 11 21:17:27 volumio volumio[1072]: info: Exploding uri volusonic/track/54831676ecb626cb639546bc360d92f1 in service volusonic Oct 11 21:17:27 volumio volumio[1072]: info: Exploding uri volusonic/track/f0bae108d32cee5e60b8c7a6540310c1 in service volusonic Oct 11 21:17:27 volumio volumio[1072]: info: Exploding uri volusonic/track/861d0963e4e547af1673c1cf76f5cf31 in service volusonic Oct 11 21:17:27 volumio volumio[1072]: info: Exploding uri volusonic/track/b78d7459130c4bf79883dd2bc9380ad5 in service volusonic Oct 11 21:17:27 volumio volumio[1072]: info: Exploding uri volusonic/track/77867d2938f4a5d064f481177615ecd8 in service volusonic Oct 11 21:17:27 volumio volumio[1072]: info: Exploding uri volusonic/track/f88bc8a4527d3fc3f9999ed7b5fbc296 in service volusonic Oct 11 21:17:27 volumio volumio[1072]: info: Exploding uri volusonic/track/3a8f608d7abf6e9ffee7ed3c4902950c in service volusonic Oct 11 21:17:27 volumio volumio[1072]: info: Exploding uri volusonic/track/649ad235aa89e2fa9f69667f0f8743c2 in service volusonic Oct 11 21:17:31 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 21:17:31 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 21:17:31 volumio volumio[1072]: info: Discovery: Getting this device information Oct 11 21:17:31 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:17:31 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:17:31 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 21:17:36 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Oct 11 21:17:36 volumio volumio[1072]: info: CorePlayQueue::getTrack 6 Oct 11 21:17:44 volumio volumio[1072]: info: Adding volusonic/track/98e697f1c373bdd7e4ca4c040f7ec650 to favourites with specific volusonic method Oct 11 21:17:44 volumio volumio[1072]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 21:17:44 volumio volumio[1072]: TypeError: Cannot read property 'then' of undefined Oct 11 21:17:44 volumio volumio[1072]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:679:20) Oct 11 21:17:44 volumio volumio[1072]: at Socket.emit (events.js:315:20) Oct 11 21:17:44 volumio volumio[1072]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 11 21:17:44 volumio volumio[1072]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 11 21:17:44 volumio volumio[1072]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 21:17:44 volumio sudo[2297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-11 21:16 Oct 11 21:17:44 volumio sudo[2297]: 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"