-- Logs begin at Mon 2025-06-09 18:21:33 CEST, end at Mon 2025-06-09 18:24:17 CEST. --
Jun 09 18:23:27 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 09 18:23:27 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 09 18:23:27 volumiogk volumio[877]: info: Discovery: Getting this device information
Jun 09 18:23:27 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetState
Jun 09 18:23:27 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:23:27 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 09 18:23:27 volumiogk volumio[877]: verbose: New Socket.io Connection to 192.168.188.51:3000 from 192.168.188.54 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7
Jun 09 18:23:27 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetState
Jun 09 18:23:27 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:23:27 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jun 09 18:23:27 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jun 09 18:23:29 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetState
Jun 09 18:23:29 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:23:29 volumiogk volumio[877]: verbose: New Socket.io Connection to 192.168.188.51:3000 from 192.168.188.54 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8
Jun 09 18:23:29 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetState
Jun 09 18:23:29 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:23:30 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jun 09 18:23:30 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jun 09 18:23:30 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetState
Jun 09 18:23:30 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:23:30 volumiogk sudo[2380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 09 18:23:30 volumiogk sudo[2382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 09 18:23:30 volumiogk sudo[2380]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 09 18:23:30 volumiogk sudo[2382]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 09 18:23:30 volumiogk sudo[2380]: pam_unix(sudo:session): session closed for user root
Jun 09 18:23:30 volumiogk sudo[2382]: pam_unix(sudo:session): session closed for user root
Jun 09 18:23:30 volumiogk volumio[877]: verbose: New Socket.io Connection to 192.168.188.51 from 192.168.188.54 UA: Mozilla/5.0 (Linux; Android 12; AC2001 Build/RKQ1.211119.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Jun 09 18:23:30 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 09 18:23:30 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 09 18:23:30 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetState
Jun 09 18:23:30 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:23:30 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jun 09 18:23:30 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jun 09 18:23:30 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jun 09 18:23:30 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 09 18:23:31 volumiogk sudo[2414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 09 18:23:31 volumiogk sudo[2416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 09 18:23:31 volumiogk sudo[2414]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 09 18:23:31 volumiogk sudo[2414]: pam_unix(sudo:session): session closed for user root
Jun 09 18:23:31 volumiogk sudo[2416]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 09 18:23:31 volumiogk sudo[2416]: pam_unix(sudo:session): session closed for user root
Jun 09 18:23:31 volumiogk volumio[877]: verbose: New Socket.io Connection to 192.168.188.51 from 192.168.188.54 UA: Mozilla/5.0 (Linux; Android 12; AC2001 Build/RKQ1.211119.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.125 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Jun 09 18:23:31 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetState
Jun 09 18:23:31 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:23:31 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 09 18:23:31 volumiogk volumio[877]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jun 09 18:23:31 volumiogk volumio[877]: info: Listing playlists
Jun 09 18:23:31 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jun 09 18:23:31 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jun 09 18:23:31 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jun 09 18:23:31 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 09 18:23:33 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 09 18:23:33 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 09 18:23:33 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetQueue
Jun 09 18:23:33 volumiogk volumio[877]: info: CoreStateMachine::getQueue
Jun 09 18:23:33 volumiogk volumio[877]: info: CorePlayQueue::getQueue
Jun 09 18:23:33 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 09 18:23:33 volumiogk volumio[877]: info: Received Get System Info
Jun 09 18:23:33 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 09 18:23:33 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 09 18:23:33 volumiogk volumio[877]: info: Discovery: Getting this device information
Jun 09 18:23:33 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetState
Jun 09 18:23:33 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:23:33 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 09 18:23:34 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 09 18:23:34 volumiogk volumio[877]: info: Received Get System Info
Jun 09 18:23:34 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 09 18:23:34 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 09 18:23:34 volumiogk volumio[877]: info: Discovery: Getting this device information
Jun 09 18:23:34 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetState
Jun 09 18:23:34 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:23:34 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 09 18:23:35 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jun 09 18:23:35 volumiogk volumio[877]: info: Preload queue cleared
Jun 09 18:23:39 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jun 09 18:23:39 volumiogk volumio[877]: info: Preload queue cleared
Jun 09 18:23:42 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jun 09 18:23:42 volumiogk volumio[877]: info: Preload queue cleared
Jun 09 18:23:49 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 09 18:23:49 volumiogk volumio[877]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jun 09 18:23:49 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jun 09 18:23:49 volumiogk volumio[877]: info: Received Get System Version
Jun 09 18:23:49 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 09 18:23:49 volumiogk volumio[877]: info: Received Get System Info
Jun 09 18:23:49 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 09 18:23:49 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 09 18:23:49 volumiogk volumio[877]: info: Discovery: Getting this device information
Jun 09 18:23:49 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetState
Jun 09 18:23:49 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:23:49 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 09 18:23:52 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: Cannot compose Albumart path
Jun 09 18:23:55 volumiogk volumio[877]: info: Preload queue cleared
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233535
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233533
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233539
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233536
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233532
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233534
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233538
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233537
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222073
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222074
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222075
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222076
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222077
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222078
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222079
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222080
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222081
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222082
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248914
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248917
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248918
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248912
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248916
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248920
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248909
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248910
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248911
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248921
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248913
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248919
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248915
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221046
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221041
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221050
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221038
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221045
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221036
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221043
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221049
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221044
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221042
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221040
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221037
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221039
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221047
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221048
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218127
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218132
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218129
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218125
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218128
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218121
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218133
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218123
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218126
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218130
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218124
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218131
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218122
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213918
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213910
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213912
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213916
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213919
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213913
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213914
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213915
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213911
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213917
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247990
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247987
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247986
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247989
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247984
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247992
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247983
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247985
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247988
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247991
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243440
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243438
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243427
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243429
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243439
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243434
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243436
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243435
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243431
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243437
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243428
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243433
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243430
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243432
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243441
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@259777
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@259792
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@259806
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@259799
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@259810
Jun 09 18:23:55 volumiogk volumio[877]: info: Preloading song: upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@259776
Jun 09 18:23:55 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233535 in service upnp_browser
Jun 09 18:23:55 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233533 in service upnp_browser
Jun 09 18:23:55 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233539 in service upnp_browser
Jun 09 18:23:55 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233536 in service upnp_browser
Jun 09 18:23:55 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233532 in service upnp_browser
Jun 09 18:23:55 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233534 in service upnp_browser
Jun 09 18:23:55 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233538 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@233537 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222073 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222074 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222075 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222076 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222077 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222078 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222079 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222080 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222081 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@222082 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248914 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248917 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248918 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248912 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248916 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248920 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248909 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248910 in service upnp_browser
Jun 09 18:23:56 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248911 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 09 18:23:57 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 09 18:23:57 volumiogk volumio[877]: info: Discovery: Getting this device information
Jun 09 18:23:57 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetState
Jun 09 18:23:57 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:23:57 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248921 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248913 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248919 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@248915 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221046 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221041 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221050 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221038 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221045 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221036 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221043 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221049 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221044 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221042 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221040 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221037 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221039 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221047 in service upnp_browser
Jun 09 18:23:57 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@221048 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218127 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218132 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218129 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218125 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218128 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218121 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218133 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218123 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218126 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218130 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218124 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218131 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@218122 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213918 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213910 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213912 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213916 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213919 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213913 in service upnp_browser
Jun 09 18:23:58 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213914 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213915 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213911 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@213917 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247990 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247987 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247986 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247989 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247984 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247992 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247983 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247985 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247988 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@247991 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243440 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243438 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243427 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243429 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243439 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243434 in service upnp_browser
Jun 09 18:23:59 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243436 in service upnp_browser
Jun 09 18:24:00 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243435 in service upnp_browser
Jun 09 18:24:00 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243431 in service upnp_browser
Jun 09 18:24:00 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243437 in service upnp_browser
Jun 09 18:24:00 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243428 in service upnp_browser
Jun 09 18:24:00 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243433 in service upnp_browser
Jun 09 18:24:00 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243430 in service upnp_browser
Jun 09 18:24:00 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243432 in service upnp_browser
Jun 09 18:24:00 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@243441 in service upnp_browser
Jun 09 18:24:00 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@259777 in service upnp_browser
Jun 09 18:24:00 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@259792 in service upnp_browser
Jun 09 18:24:00 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@259806 in service upnp_browser
Jun 09 18:24:00 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@259799 in service upnp_browser
Jun 09 18:24:00 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@259810 in service upnp_browser
Jun 09 18:24:00 volumiogk volumio[877]: info: Exploding uri upnp/http://192.168.188.27:50001/ContentDirectory/control@23$@259776 in service upnp_browser
Jun 09 18:24:02 volumiogk volumio[877]: info: Preload queue cleared
Jun 09 18:24:02 volumiogk volumio[877]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 09 18:24:02 volumiogk volumio[877]: info: CoreStateMachine::ClearQueue
Jun 09 18:24:02 volumiogk volumio[877]: info: CoreStateMachine::stop
Jun 09 18:24:02 volumiogk volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 09 18:24:02 volumiogk volumio[877]: info: CorePlayQueue::clearPlayQueue
Jun 09 18:24:02 volumiogk volumio[877]: info: CorePlayQueue::saveQueue
Jun 09 18:24:02 volumiogk volumio[877]: info: CoreCommandRouter::volumioPushQueue
Jun 09 18:24:02 volumiogk volumio[877]: info: CoreStateMachine::addQueueItems
Jun 09 18:24:02 volumiogk volumio[877]: info: CorePlayQueue::addQueueItems
Jun 09 18:24:02 volumiogk volumio[877]: info: Preload queue cleared
Jun 09 18:24:02 volumiogk volumio[877]: info: Adding Item to queue: upnp/folder/http://192.168.188.27:50001/ContentDirectory/control@23
Jun 09 18:24:02 volumiogk volumio[877]: info: Exploding uri upnp/folder/http://192.168.188.27:50001/ContentDirectory/control@23 in service upnp_browser
Jun 09 18:24:04 volumiogk volumio[877]: info: CoreCommandRouter::volumioPushQueue
Jun 09 18:24:04 volumiogk volumio[877]: info: CorePlayQueue::saveQueue
Jun 09 18:24:04 volumiogk volumio[877]: info: CoreStateMachine::updateTrackBlock
Jun 09 18:24:04 volumiogk volumio[877]: info: CorePlayQueue::getTrackBlock
Jun 09 18:24:04 volumiogk volumio[877]: info: CoreCommandRouter::volumioPlay
Jun 09 18:24:04 volumiogk volumio[877]: info: CoreStateMachine::play index 0
Jun 09 18:24:04 volumiogk volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 09 18:24:04 volumiogk volumio[877]: info: CoreStateMachine::stop
Jun 09 18:24:04 volumiogk volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 09 18:24:04 volumiogk volumio[877]: info: CoreStateMachine::play index undefined
Jun 09 18:24:04 volumiogk volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 09 18:24:04 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:24:04 volumiogk volumio[877]: info: CoreStateMachine::startPlaybackTimer
Jun 09 18:24:04 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:24:04 volumiogk volumio[877]: info: [1749486244681] ControllerUPNPBrowser::clearAddPlayTrack
Jun 09 18:24:04 volumiogk volumio[877]: verbose: ControllerMpd::sendMpdCommand stop
Jun 09 18:24:04 volumiogk volumio[877]: info: sendMpdCommand stop took 67 milliseconds
Jun 09 18:24:04 volumiogk volumio[877]: verbose: ControllerMpd::sendMpdCommand clear
Jun 09 18:24:04 volumiogk volumio[877]: info:
Jun 09 18:24:04 volumiogk volumio[877]: ---------------------------- MPD announces system playlist update
Jun 09 18:24:04 volumiogk volumio[877]: info: Ignoring MPD Status Update
Jun 09 18:24:04 volumiogk volumio[877]: info: sendMpdCommand clear took 15 milliseconds
Jun 09 18:24:04 volumiogk volumio[877]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.188.27:50002/m/MP3/233535.mp3"
Jun 09 18:24:04 volumiogk volumio[877]: error: updateQueue error: null
Jun 09 18:24:04 volumiogk volumio[877]: info: ------------------------------ 6ms
Jun 09 18:24:04 volumiogk volumio[877]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.188.27:50002/m/MP3/233535.mp3"
Jun 09 18:24:04 volumiogk volumio[877]: info:
Jun 09 18:24:04 volumiogk volumio[877]: ---------------------------- MPD announces system playlist update
Jun 09 18:24:04 volumiogk volumio[877]: info: Ignoring MPD Status Update
Jun 09 18:24:04 volumiogk volumio[877]: info: sendMpdCommand add "http://192.168.188.27:50002/m/MP3/233535.mp3" took 1 milliseconds
Jun 09 18:24:04 volumiogk volumio[877]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 09 18:24:04 volumiogk volumio[877]: verbose: ControllerMpd::sendMpdCommand play
Jun 09 18:24:04 volumiogk volumio[877]: info: ------------------------------ 2ms
Jun 09 18:24:04 volumiogk volumio[877]: info: sendMpdCommand play took 2 milliseconds
Jun 09 18:24:04 volumiogk volumio[877]: info:
Jun 09 18:24:04 volumiogk volumio[877]: ---------------------------- MPD announces state update: player
Jun 09 18:24:04 volumiogk volumio[877]: info: ControllerMpd::getState
Jun 09 18:24:04 volumiogk volumio[877]: verbose: ControllerMpd::sendMpdCommand status
Jun 09 18:24:04 volumiogk volumio[877]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Jun 09 18:24:04 volumiogk volumio[877]: info: FusionDsp - ---- read samplerate from file: 44100
Jun 09 18:24:04 volumiogk volumio[877]: info: camilladsp stopping service pid 1611...
Jun 09 18:24:04 volumiogk volumio[877]: info: camilladsp service terminated, instance 1
Jun 09 18:24:04 volumiogk volumio[877]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Jun 09 18:24:04 volumiogk volumio[877]: info: FusionDsp - Nulleq applied
Jun 09 18:24:04 volumiogk volumio[877]: info: camilladsp service started and running in background, instance 1
Jun 09 18:24:04 volumiogk volumio[877]: info:
Jun 09 18:24:04 volumiogk volumio[877]: ---------------------------- MPD announces state update: player
Jun 09 18:24:04 volumiogk volumio[877]: info: sendMpdCommand status took 75 milliseconds
Jun 09 18:24:04 volumiogk volumio[877]: info: ControllerMpd::getState
Jun 09 18:24:04 volumiogk volumio[877]: verbose: ControllerMpd::sendMpdCommand status
Jun 09 18:24:04 volumiogk volumio[877]: verbose: ControllerMpd::parseState
Jun 09 18:24:04 volumiogk volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 09 18:24:04 volumiogk volumio[877]: info:
Jun 09 18:24:04 volumiogk volumio[877]: ---------------------------- MPD announces system playlist update
Jun 09 18:24:04 volumiogk volumio[877]: info: Ignoring MPD Status Update
Jun 09 18:24:04 volumiogk volumio[877]: info:
Jun 09 18:24:04 volumiogk volumio[877]: ---------------------------- MPD announces state update: player
Jun 09 18:24:04 volumiogk volumio[877]: info: ControllerMpd::getState
Jun 09 18:24:04 volumiogk volumio[877]: verbose: ControllerMpd::sendMpdCommand status
Jun 09 18:24:04 volumiogk volumio[877]: info: sendMpdCommand status took 19 milliseconds
Jun 09 18:24:04 volumiogk volumio[877]: info: sendMpdCommand playlistinfo took 20 milliseconds
Jun 09 18:24:04 volumiogk volumio[877]: verbose: ControllerMpd::parseState
Jun 09 18:24:04 volumiogk volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 09 18:24:04 volumiogk volumio[877]: verbose: ControllerMpd::parseTrackInfo
Jun 09 18:24:04 volumiogk volumio[877]: info: ControllerMpd::pushState
Jun 09 18:24:04 volumiogk volumio[877]: info: CoreCommandRouter::servicePushState
Jun 09 18:24:04 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:24:04 volumiogk volumio[877]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"First I Look At The Purse","artist":"J. Geils Band","album":"'Live' Full House","uri":"http://192.168.188.27:50002/m/MP3/233535.mp3","trackType":"mp3"}
Jun 09 18:24:04 volumiogk volumio[877]: verbose: CURRENT POSITION 0
Jun 09 18:24:04 volumiogk volumio[877]: info: CoreStateMachine::syncState stateService play
Jun 09 18:24:04 volumiogk volumio[877]: info: CoreStateMachine::syncState currentStatus stop
Jun 09 18:24:04 volumiogk volumio[877]: info: ------------------------------ 119ms
Jun 09 18:24:04 volumiogk volumio[877]: info: camilladsp spawned new process with pid 2537, instance 1, run: true
Jun 09 18:24:05 volumiogk volumio[877]: info: ------------------------------ 75ms
Jun 09 18:24:05 volumiogk volumio[877]: info: sendMpdCommand status took 69 milliseconds
Jun 09 18:24:05 volumiogk volumio[877]: info: sendMpdCommand playlistinfo took 59 milliseconds
Jun 09 18:24:05 volumiogk volumio[877]: verbose: ControllerMpd::parseState
Jun 09 18:24:05 volumiogk volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 09 18:24:05 volumiogk volumio[877]: verbose: ControllerMpd::parseTrackInfo
Jun 09 18:24:05 volumiogk volumio[877]: info: ControllerMpd::pushState
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreCommandRouter::servicePushState
Jun 09 18:24:05 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:24:05 volumiogk volumio[877]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"First I Look At The Purse","artist":"J. Geils Band","album":"'Live' Full House","uri":"http://192.168.188.27:50002/m/MP3/233535.mp3","trackType":"mp3"}
Jun 09 18:24:05 volumiogk volumio[877]: verbose: CURRENT POSITION 0
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreStateMachine::syncState stateService play
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreStateMachine::syncState currentStatus play
Jun 09 18:24:05 volumiogk volumio[877]: info: Received an update from plugin. extracting info from payload
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreStateMachine::pushState
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreCommandRouter::volumioPushState
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetState
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreStateMachine::pushState
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreCommandRouter::volumioPushState
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetState
Jun 09 18:24:05 volumiogk volumio[877]: info: ------------------------------ 189ms
Jun 09 18:24:05 volumiogk volumio[877]: info: sendMpdCommand playlistinfo took 101 milliseconds
Jun 09 18:24:05 volumiogk volumio[877]: verbose: ControllerMpd::parseTrackInfo
Jun 09 18:24:05 volumiogk volumio[877]: info: ControllerMpd::pushState
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreCommandRouter::servicePushState
Jun 09 18:24:05 volumiogk volumio[877]: info: CorePlayQueue::getTrack 0
Jun 09 18:24:05 volumiogk volumio[877]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"First I Look At The Purse","artist":"J. Geils Band","album":"'Live' Full House","uri":"http://192.168.188.27:50002/m/MP3/233535.mp3","trackType":"mp3"}
Jun 09 18:24:05 volumiogk volumio[877]: verbose: CURRENT POSITION 0
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreStateMachine::syncState stateService play
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreStateMachine::syncState currentStatus play
Jun 09 18:24:05 volumiogk volumio[877]: info: Received an update from plugin. extracting info from payload
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreStateMachine::pushState
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreCommandRouter::volumioPushState
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetState
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreStateMachine::pushState
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreCommandRouter::volumioPushState
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetState
Jun 09 18:24:05 volumiogk volumio[877]: info: ------------------------------ 210ms
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetQueue
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreStateMachine::getQueue
Jun 09 18:24:05 volumiogk volumio[877]: info: CorePlayQueue::getQueue
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetQueue
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreStateMachine::getQueue
Jun 09 18:24:05 volumiogk volumio[877]: info: CorePlayQueue::getQueue
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetQueue
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreStateMachine::getQueue
Jun 09 18:24:05 volumiogk volumio[877]: info: CorePlayQueue::getQueue
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreCommandRouter::volumioGetQueue
Jun 09 18:24:05 volumiogk volumio[877]: info: CoreStateMachine::getQueue
Jun 09 18:24:05 volumiogk volumio[877]: info: CorePlayQueue::getQueue
Jun 09 18:24:17 volumiogk volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jun 09 18:24:17 volumiogk volumio[877]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 09 18:24:17 volumiogk volumio[877]: TypeError: Cannot read property 'length' of undefined
Jun 09 18:24:17 volumiogk volumio[877]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25
Jun 09 18:24:17 volumiogk volumio[877]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13
Jun 09 18:24:17 volumiogk volumio[877]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18)
Jun 09 18:24:17 volumiogk volumio[877]: at Parser.emit (events.js:400:28)
Jun 09 18:24:17 volumiogk volumio[877]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26)
Jun 09 18:24:17 volumiogk volumio[877]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35)
Jun 09 18:24:17 volumiogk volumio[877]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5)
Jun 09 18:24:17 volumiogk volumio[877]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7)
Jun 09 18:24:17 volumiogk volumio[877]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13)
Jun 09 18:24:17 volumiogk volumio[877]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31)
Jun 09 18:24:17 volumiogk volumio[877]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59)
Jun 09 18:24:17 volumiogk volumio[877]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19)
Jun 09 18:24:17 volumiogk volumio[877]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15)
Jun 09 18:24:17 volumiogk volumio[877]: at IncomingMessage.emit (events.js:412:35)
Jun 09 18:24:17 volumiogk volumio[877]: at endReadableNT (internal/streams/readable.js:1333:12)
Jun 09 18:24:17 volumiogk volumio[877]: at processTicksAndRejections (internal/process/task_queues.js:82:21)
Jun 09 18:24:17 volumiogk volumio[877]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 09 18:24:17 volumiogk sudo[2569]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-09 18:23
Jun 09 18:24:17 volumiogk sudo[2569]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 03 Jun 2025 10:59:11 AM CEST"
VOLUMIO_VERSION="3.813"
VOLUMIO_HARDWARE="tinkerboard"
VOLUMIO_DEVICENAME="Asus Tinkerboard"
VOLUMIO_HASH="4ab7906c45503ee0ba719461ff7118b6"