Jan 11 15:25:00 volumio dhcpcd[893]: eth0: using static address 192.168.1.55/24
Jan 11 15:25:00 volumio dhcpcd[893]: eth0: adding route to 192.168.1.0/24
Jan 11 15:25:00 volumio dhcpcd[893]: eth0: adding default route via 192.168.1.1
Jan 11 15:25:00 volumio avahi-daemon[865]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.55.
Jan 11 15:25:00 volumio avahi-daemon[865]: New relevant interface eth0.IPv4 for mDNS.
Jan 11 15:25:00 volumio avahi-daemon[865]: Registering new address record for 192.168.1.55 on eth0.IPv4.
Jan 11 15:25:00 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:25:00 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Jan 11 15:25:00 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Jan 11 15:25:00 volumio systemd[1]: welcome.service: Deactivated successfully.
Jan 11 15:25:00 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Jan 11 15:25:00 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Jan 11 15:25:00 volumio volumio[1172]: info: Listing playlists
Jan 11 15:25:00 volumio volumio[1172]: info: Listing playlists
Jan 11 15:25:00 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Jan 11 15:25:00 volumio welcome[3658]: Resolved ip:[1] 192.168.1.55
Jan 11 15:25:00 volumio systemd[1]: Finished welcome.service - Show a welcome message on console.
Jan 11 15:25:00 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Jan 11 15:25:00 volumio dhcpcd[846]: eth0: using static address 192.168.1.55/24
Jan 11 15:25:00 volumio dhcpcd[846]: eth0: adding route to 192.168.1.0/24
Jan 11 15:25:00 volumio dhcpcd[846]: eth0: adding default route via 192.168.1.1
Jan 11 15:25:00 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Jan 11 15:25:00 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Jan 11 15:25:00 volumio systemd[1]: welcome.service: Deactivated successfully.
Jan 11 15:25:00 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Jan 11 15:25:00 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Jan 11 15:25:00 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Jan 11 15:25:00 volumio welcome[3687]: Resolved ip:[1] 192.168.1.55
Jan 11 15:25:00 volumio systemd[1]: Finished welcome.service - Show a welcome message on console.
Jan 11 15:25:00 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Jan 11 15:25:00 volumio volumio[1172]: verbose: New Socket.io Connection to 192.168.1.55 from 192.168.1.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Edg/143.0.0.0 Engine version: 3 Transport: polling Total Clients: 7
Jan 11 15:25:00 volumio volumio[1172]: verbose: New Socket.io Connection to 192.168.1.55 from 192.168.1.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Edg/143.0.0.0 Engine version: 3 Transport: polling Total Clients: 8
Jan 11 15:25:01 volumio volumio[1172]: info: Discovery: adding 16f5f909-e0db-4daa-a5d9-4fb43c837537
Jan 11 15:25:01 volumio volumio[1172]: info: Discovery: Found device Volumio
Jan 11 15:25:01 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:25:01 volumio volumio[1172]: info: Discovery: this is already registered, 16f5f909-e0db-4daa-a5d9-4fb43c837537
Jan 11 15:25:01 volumio volumio[1172]: info: Discovery: Found device Volumio
Jan 11 15:25:01 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:25:01 volumio volumio[1172]: verbose: New Socket.io Connection to 192.168.1.55 from 192.168.1.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Edg/143.0.0.0 Engine version: 3 Transport: polling Total Clients: 9
Jan 11 15:25:01 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 11 15:25:01 volumio volumio[1172]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 11 15:25:01 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 11 15:25:01 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:25:01 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:25:01 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 11 15:25:01 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 11 15:25:01 volumio volumio[1172]: info: Received Get System Info
Jan 11 15:25:01 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 11 15:25:01 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 11 15:25:01 volumio volumio[1172]: info: Discovery: Getting this device information
Jan 11 15:25:01 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:25:01 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 11 15:25:01 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:25:01 volumio volumio[1172]: info: Listing playlists
Jan 11 15:25:01 volumio volumio[1172]: info: CoreCommandRouter::volumioGetQueue
Jan 11 15:25:01 volumio volumio[1172]: info: CoreStateMachine::getQueue
Jan 11 15:25:01 volumio volumio[1172]: info: CorePlayQueue::getQueue
Jan 11 15:25:01 volumio ntpd[1116]: IO: Listen normally on 6 eth0 192.168.1.55:123
Jan 11 15:25:01 volumio ntpd[1116]: IO: new interface(s) found: waking up resolver
Jan 11 15:25:04 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:25:04 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart
Jan 11 15:25:04 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart
Jan 11 15:25:04 volumio volumio[1172]: info: Refreshing Cached IP Addresses
Jan 11 15:25:04 volumio sudo[3751]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli
Jan 11 15:25:04 volumio sudo[3751]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:25:04 volumio sudo[3753]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 11 15:25:04 volumio sudo[3753]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:25:04 volumio sudo[3753]: pam_unix(sudo:session): session closed for user root
Jan 11 15:25:04 volumio sudo[3756]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 11 15:25:04 volumio systemd[1]: upmpdcli.service: Deactivated successfully.
Jan 11 15:25:04 volumio sudo[3751]: pam_unix(sudo:session): session closed for user root
Jan 11 15:25:04 volumio sudo[3756]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:25:04 volumio sudo[3756]: pam_unix(sudo:session): session closed for user root
Jan 11 15:25:05 volumio volumio[1172]: info: CoreCommandRouter::volumioGetQueue
Jan 11 15:25:05 volumio volumio[1172]: info: CoreStateMachine::getQueue
Jan 11 15:25:05 volumio volumio[1172]: info: CorePlayQueue::getQueue
Jan 11 15:25:08 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:25:09 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jan 11 15:25:09 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:10 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jan 11 15:25:10 volumio volumio[1172]: info: TuneIn handleBrowseUri: tunein/best
Jan 11 15:25:10 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:11 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::ClearQueue
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::stPlaybackTimer
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::updateTrackBlock
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrackBlock
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::serviceStop
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::serviceStop
Jan 11 15:25:11 volumio volumio[1172]: info: [1768119911649] ControllerWebradio::stop
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::clearPlayQueue
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::addQueueItems
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::addQueueItems
Jan 11 15:25:11 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:11 volumio volumio[1172]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s7210
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 11 15:25:11 volumio volumio[1172]: info:
Jan 11 15:25:11 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:11 volumio volumio[1172]: info: sendMpdCommand stop took 18 milliseconds
Jan 11 15:25:11 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:11 volumio volumio[1172]: info:
Jan 11 15:25:11 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:11 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:11 volumio volumio[1172]: info:
Jan 11 15:25:11 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:11 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:11 volumio volumio[1172]: info: sendMpdCommand status took 1 milliseconds
Jan 11 15:25:11 volumio volumio[1172]: info: sendMpdCommand status took 1 milliseconds
Jan 11 15:25:11 volumio volumio[1172]: info: sendMpdCommand status took 1 milliseconds
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:11 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:11 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:11 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:11 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio.mp3","artist":"Topradio","album":null,"uri":"https://a10.asurahosting.com:8250/radio.mp3","trackType":"mp3"}
Jan 11 15:25:11 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::syncState stateService stop
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:11 volumio volumio[1172]: info: No code
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:11 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio.mp3","artist":"Topradio","album":null,"uri":"https://a10.asurahosting.com:8250/radio.mp3","trackType":"mp3"}
Jan 11 15:25:11 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::syncState stateService stop
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:11 volumio volumio[1172]: info: No code
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:11 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio.mp3","artist":"Topradio","album":null,"uri":"https://a10.asurahosting.com:8250/radio.mp3","trackType":"mp3"}
Jan 11 15:25:11 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::syncState stateService stop
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:11 volumio volumio[1172]: info: No code
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:11 volumio volumio[1172]: info: ------------------------------ 48ms
Jan 11 15:25:11 volumio volumio[1172]: info: ------------------------------ 48ms
Jan 11 15:25:11 volumio volumio[1172]: info: ------------------------------ 48ms
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::updateTrackBlock
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrackBlock
Jan 11 15:25:11 volumio volumio[1172]: info: CoreCommandRouter::volumioPlay
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::play index 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::play index undefined
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: info: CoreStateMachine::startPlaybackTimer
Jan 11 15:25:11 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:11 volumio volumio[1172]: info: [1768119911989] ControllerWebradio::clearAddPlayTrack
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 15:25:11 volumio volumio[1172]: info: sendMpdCommand stop took 1 milliseconds
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand clear
Jan 11 15:25:11 volumio volumio[1172]: info:
Jan 11 15:25:11 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:11 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:11 volumio volumio[1172]: info: sendMpdCommand clear took 0 milliseconds
Jan 11 15:25:11 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand load "http://rstream.mcot.net:8000/fm1005"
Jan 11 15:25:11 volumio volumio[1172]: info:
Jan 11 15:25:11 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:11 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:11 volumio volumio[1172]: info:
Jan 11 15:25:11 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:11 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:11 volumio volumio[1172]: error: updateQueue error: null
Jan 11 15:25:11 volumio volumio[1172]: info: ------------------------------ 2ms
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand add "http://rstream.mcot.net:8000/fm1005"
Jan 11 15:25:12 volumio volumio[1172]: error: updateQueue error: null
Jan 11 15:25:12 volumio volumio[1172]: error: updateQueue error: null
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 197ms
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 197ms
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand add "http://rstream.mcot.net:8000/fm1005" took 1 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand play
Jan 11 15:25:12 volumio volumio[1172]: info:
Jan 11 15:25:12 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:12 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:12 volumio volumio[1172]: info:
Jan 11 15:25:12 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:12 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:12 volumio volumio[1172]: info:
Jan 11 15:25:12 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:12 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand play took 3 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 2ms
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 2ms
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 2ms
Jan 11 15:25:12 volumio volumio[1172]: info:
Jan 11 15:25:12 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:12 volumio volumio[1172]: info:
Jan 11 15:25:12 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:12 volumio volumio[1172]: info:
Jan 11 15:25:12 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:12 volumio volumio[1172]: info:
Jan 11 15:25:12 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand status took 1 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:12 volumio volumio[1172]: info:
Jan 11 15:25:12 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:12 volumio volumio[1172]: info:
Jan 11 15:25:12 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand status took 1 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand status took 1 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand status took 1 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand status took 1 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"fm1005","artist":null,"album":null,"uri":"http://rstream.mcot.net:8000/fm1005","trackType":""}
Jan 11 15:25:12 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState stateService play
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 3ms
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand status took 1 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"fm1005","artist":null,"album":null,"uri":"http://rstream.mcot.net:8000/fm1005","trackType":""}
Jan 11 15:25:12 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState stateService play
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus play
Jan 11 15:25:12 volumio volumio[1172]: info: Received an update from plugin. extracting info from payload
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"fm1005","artist":null,"album":null,"uri":"http://rstream.mcot.net:8000/fm1005","trackType":""}
Jan 11 15:25:12 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState stateService play
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus play
Jan 11 15:25:12 volumio volumio[1172]: info: Received an update from plugin. extracting info from payload
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"fm1005","artist":null,"album":null,"uri":"http://rstream.mcot.net:8000/fm1005","trackType":""}
Jan 11 15:25:12 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState stateService play
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus play
Jan 11 15:25:12 volumio volumio[1172]: info: Received an update from plugin. extracting info from payload
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"fm1005","artist":null,"album":null,"uri":"http://rstream.mcot.net:8000/fm1005","trackType":""}
Jan 11 15:25:12 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState stateService play
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus play
Jan 11 15:25:12 volumio volumio[1172]: info: Received an update from plugin. extracting info from payload
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"fm1005","artist":null,"album":null,"uri":"http://rstream.mcot.net:8000/fm1005","trackType":""}
Jan 11 15:25:12 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState stateService play
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus play
Jan 11 15:25:12 volumio volumio[1172]: info: Received an update from plugin. extracting info from payload
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 55ms
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 55ms
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 55ms
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 56ms
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 55ms
Jan 11 15:25:12 volumio volumio[1172]: info:
Jan 11 15:25:12 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:12 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:12 volumio volumio[1172]: info:
Jan 11 15:25:12 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:12 volumio volumio[1172]: info:
Jan 11 15:25:12 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:12 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:12 volumio volumio[1172]: info:
Jan 11 15:25:12 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:12 volumio volumio[1172]: info:
Jan 11 15:25:12 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:12 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:12 volumio volumio[1172]: info:
Jan 11 15:25:12 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 9ms
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand status took 8 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 2ms
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand status took 1 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 1ms
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand status took 2 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":754,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"fm1005","artist":"FM 100.5 MHz","album":null,"uri":"http://rstream.mcot.net:8000/fm1005","trackType":""}
Jan 11 15:25:12 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState stateService play
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus play
Jan 11 15:25:12 volumio volumio[1172]: info: Received an update from plugin. extracting info from payload
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":754,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"fm1005","artist":"FM 100.5 MHz","album":null,"uri":"http://rstream.mcot.net:8000/fm1005","trackType":""}
Jan 11 15:25:12 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState stateService play
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus play
Jan 11 15:25:12 volumio volumio[1172]: info: Received an update from plugin. extracting info from payload
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 26ms
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 19ms
Jan 11 15:25:12 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jan 11 15:25:12 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:12 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":754,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"fm1005","artist":"FM 100.5 MHz","album":null,"uri":"http://rstream.mcot.net:8000/fm1005","trackType":""}
Jan 11 15:25:12 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState stateService play
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus play
Jan 11 15:25:12 volumio volumio[1172]: info: Received an update from plugin. extracting info from payload
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:12 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:12 volumio volumio[1172]: info: ------------------------------ 32ms
Jan 11 15:25:14 volumio sudo[3793]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 11 15:25:14 volumio sudo[3793]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:25:14 volumio sudo[3793]: pam_unix(sudo:session): session closed for user root
Jan 11 15:25:14 volumio sudo[3794]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 11 15:25:14 volumio sudo[3794]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:25:14 volumio sudo[3796]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jan 11 15:25:14 volumio sudo[3796]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:25:14 volumio sudo[3794]: pam_unix(sudo:session): session closed for user root
Jan 11 15:25:15 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:25:18 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:25:18 volumio volumio[1172]: info: Listing playlists
Jan 11 15:25:18 volumio volumio[1172]: info: Listing playlists
Jan 11 15:25:20 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 5.
Jan 11 15:25:20 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Jan 11 15:25:20 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Jan 11 15:25:20 volumio sudo[3796]: pam_unix(sudo:session): session closed for user root
Jan 11 15:25:20 volumio volumio[1172]: info: Upmpdcli Daemon Started
Jan 11 15:25:20 volumio upmpdcli[3821]: writing RSA key
Jan 11 15:25:20 volumio volumio[1172]: info: CoreCommandRouter::volumioStop
Jan 11 15:25:20 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:25:20 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:20 volumio volumio[1172]: info: CoreStateMachine::stPlaybackTimer
Jan 11 15:25:20 volumio volumio[1172]: info: CoreStateMachine::updateTrackBlock
Jan 11 15:25:20 volumio volumio[1172]: info: CorePlayQueue::getTrackBlock
Jan 11 15:25:20 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:20 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:20 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 15:25:20 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:20 volumio volumio[1172]: info: CoreStateMachine::serviceStop
Jan 11 15:25:20 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:20 volumio volumio[1172]: info: CoreCommandRouter::serviceStop
Jan 11 15:25:20 volumio volumio[1172]: info: [1768119920976] ControllerWebradio::stop
Jan 11 15:25:20 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 15:25:20 volumio volumio[1172]: info: sendMpdCommand stop took 3 milliseconds
Jan 11 15:25:20 volumio volumio[1172]: info:
Jan 11 15:25:20 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:20 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:20 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:20 volumio volumio[1172]: info:
Jan 11 15:25:20 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:20 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:20 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:20 volumio volumio[1172]: info:
Jan 11 15:25:20 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:20 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:20 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:20 volumio volumio[1172]: info: sendMpdCommand status took 2 milliseconds
Jan 11 15:25:20 volumio volumio[1172]: info: sendMpdCommand status took 1 milliseconds
Jan 11 15:25:20 volumio volumio[1172]: info: sendMpdCommand status took 1 milliseconds
Jan 11 15:25:20 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:20 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:20 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:20 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:20 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:20 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:20 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:20 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:20 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:20 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:20 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:20 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:20 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:20 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:20 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:20 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:20 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:20 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:20 volumio volumio[1172]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jan 11 15:25:20 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:20 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:20 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:20 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:20 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:20 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:20 volumio volumio[1172]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jan 11 15:25:20 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:20 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:20 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:20 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:20 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:20 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:20 volumio volumio[1172]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jan 11 15:25:20 volumio volumio[1172]: info: ------------------------------ 14ms
Jan 11 15:25:20 volumio volumio[1172]: info: ------------------------------ 15ms
Jan 11 15:25:20 volumio volumio[1172]: info: ------------------------------ 14ms
Jan 11 15:25:25 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jan 11 15:25:25 volumio volumio[1172]: info: TuneIn handleBrowseUri: tunein/location
Jan 11 15:25:25 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:27 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jan 11 15:25:27 volumio volumio[1172]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101216
Jan 11 15:25:27 volumio volumio[1172]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101216
Jan 11 15:25:27 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:28 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:25:28 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:30 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jan 11 15:25:30 volumio volumio[1172]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101255
Jan 11 15:25:30 volumio volumio[1172]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101255
Jan 11 15:25:31 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:31 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:36 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jan 11 15:25:36 volumio volumio[1172]: info: TuneIn handleBrowseUri: tunein/browse/?id=r100932
Jan 11 15:25:36 volumio volumio[1172]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r100932
Jan 11 15:25:36 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:36 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:38 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:25:38 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:38 volumio volumio[1172]: info: Listing playlists
Jan 11 15:25:38 volumio volumio[1172]: info: Listing playlists
Jan 11 15:25:39 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:39 volumio volumio[1172]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 11 15:25:39 volumio volumio[1172]: info: CoreStateMachine::ClearQueue
Jan 11 15:25:39 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:25:39 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:39 volumio volumio[1172]: info: CorePlayQueue::clearPlayQueue
Jan 11 15:25:39 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:25:39 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:25:39 volumio volumio[1172]: info: CoreStateMachine::addQueueItems
Jan 11 15:25:39 volumio volumio[1172]: info: CorePlayQueue::addQueueItems
Jan 11 15:25:39 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:39 volumio volumio[1172]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s299418
Jan 11 15:25:39 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 11 15:25:39 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:25:39 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:25:39 volumio volumio[1172]: info: CoreStateMachine::updateTrackBlock
Jan 11 15:25:39 volumio volumio[1172]: info: CorePlayQueue::getTrackBlock
Jan 11 15:25:39 volumio volumio[1172]: info: CoreCommandRouter::volumioPlay
Jan 11 15:25:39 volumio volumio[1172]: info: CoreStateMachine::play index 0
Jan 11 15:25:39 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:39 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:25:39 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:39 volumio volumio[1172]: info: CoreStateMachine::play index undefined
Jan 11 15:25:39 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:39 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:39 volumio volumio[1172]: info: CoreStateMachine::startPlaybackTimer
Jan 11 15:25:39 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:39 volumio volumio[1172]: info: [1768119939841] ControllerWebradio::clearAddPlayTrack
Jan 11 15:25:39 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 15:25:39 volumio volumio[1172]: info: sendMpdCommand stop took 1 milliseconds
Jan 11 15:25:39 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand clear
Jan 11 15:25:39 volumio volumio[1172]: info: sendMpdCommand clear took 0 milliseconds
Jan 11 15:25:39 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand load "http://titan.shoutca.st:8790/"
Jan 11 15:25:39 volumio volumio[1172]: info:
Jan 11 15:25:39 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:39 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:39 volumio volumio[1172]: info:
Jan 11 15:25:39 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:39 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:39 volumio volumio[1172]: info:
Jan 11 15:25:39 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:39 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand add "http://titan.shoutca.st:8790/"
Jan 11 15:25:40 volumio volumio[1172]: error: updateQueue error: null
Jan 11 15:25:40 volumio volumio[1172]: error: updateQueue error: null
Jan 11 15:25:40 volumio volumio[1172]: error: updateQueue error: null
Jan 11 15:25:40 volumio volumio[1172]: info:
Jan 11 15:25:40 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:40 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:40 volumio volumio[1172]: info: ------------------------------ 209ms
Jan 11 15:25:40 volumio volumio[1172]: info: ------------------------------ 208ms
Jan 11 15:25:40 volumio volumio[1172]: info: ------------------------------ 208ms
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand add "http://titan.shoutca.st:8790/" took 1 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand play
Jan 11 15:25:40 volumio volumio[1172]: info:
Jan 11 15:25:40 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:40 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:40 volumio volumio[1172]: info:
Jan 11 15:25:40 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:40 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:40 volumio volumio[1172]: info: ------------------------------ 1ms
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand play took 6 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: info: ------------------------------ 6ms
Jan 11 15:25:40 volumio volumio[1172]: info: ------------------------------ 6ms
Jan 11 15:25:40 volumio volumio[1172]: info:
Jan 11 15:25:40 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:40 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:40 volumio volumio[1172]: info:
Jan 11 15:25:40 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:40 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:40 volumio volumio[1172]: info:
Jan 11 15:25:40 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:40 volumio volumio[1172]: info:
Jan 11 15:25:40 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:40 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand clearerror
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand status took 3 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:40 volumio volumio[1172]: info:
Jan 11 15:25:40 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:40 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:40 volumio volumio[1172]: info:
Jan 11 15:25:40 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:40 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand clearerror
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand status took 4 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand clearerror
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand status took 7 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand clearerror took 6 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand status took 6 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand status took 5 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand status took 5 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand clearerror took 4 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand clearerror took 2 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:40 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:40 volumio volumio[1172]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://titan.shoutca.st:8790/","trackType":"st:8790/"}
Jan 11 15:25:40 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::syncState stateService stop
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: No code
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:40 volumio volumio[1172]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://titan.shoutca.st:8790/","trackType":"st:8790/"}
Jan 11 15:25:40 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::syncState stateService stop
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: No code
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:40 volumio volumio[1172]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://titan.shoutca.st:8790/","trackType":"st:8790/"}
Jan 11 15:25:40 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::syncState stateService stop
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: No code
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: ------------------------------ 42ms
Jan 11 15:25:40 volumio volumio[1172]: info: ------------------------------ 42ms
Jan 11 15:25:40 volumio volumio[1172]: info: ------------------------------ 42ms
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 44 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 44 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 44 milliseconds
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:40 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:40 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:40 volumio volumio[1172]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://titan.shoutca.st:8790/","trackType":"st:8790/"}
Jan 11 15:25:40 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::syncState stateService stop
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: No code
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:40 volumio volumio[1172]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://titan.shoutca.st:8790/","trackType":"st:8790/"}
Jan 11 15:25:40 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::syncState stateService stop
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: No code
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:40 volumio volumio[1172]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://titan.shoutca.st:8790/","trackType":"st:8790/"}
Jan 11 15:25:40 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::syncState stateService stop
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: No code
Jan 11 15:25:40 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:40 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:40 volumio volumio[1172]: info: ------------------------------ 80ms
Jan 11 15:25:40 volumio volumio[1172]: info: ------------------------------ 77ms
Jan 11 15:25:40 volumio volumio[1172]: info: ------------------------------ 77ms
Jan 11 15:25:42 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::ClearQueue
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:42 volumio volumio[1172]: info: CorePlayQueue::clearPlayQueue
Jan 11 15:25:42 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::addQueueItems
Jan 11 15:25:42 volumio volumio[1172]: info: CorePlayQueue::addQueueItems
Jan 11 15:25:42 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:42 volumio volumio[1172]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s8138
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:25:42 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::updateTrackBlock
Jan 11 15:25:42 volumio volumio[1172]: info: CorePlayQueue::getTrackBlock
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::volumioPlay
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::play index 0
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::play index undefined
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:42 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::startPlaybackTimer
Jan 11 15:25:42 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:42 volumio volumio[1172]: info: [1768119942585] ControllerWebradio::clearAddPlayTrack
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand stop took 0 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand clear
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand clear took 0 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand load "http://cdn-cms.tunein.com/service/Audio/notcompatible.enUS.mp3"
Jan 11 15:25:42 volumio volumio[1172]: info:
Jan 11 15:25:42 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:42 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:42 volumio volumio[1172]: info:
Jan 11 15:25:42 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:42 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:42 volumio volumio[1172]: info:
Jan 11 15:25:42 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:42 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand add "http://cdn-cms.tunein.com/service/Audio/notcompatible.enUS.mp3"
Jan 11 15:25:42 volumio volumio[1172]: error: updateQueue error: null
Jan 11 15:25:42 volumio volumio[1172]: error: updateQueue error: null
Jan 11 15:25:42 volumio volumio[1172]: error: updateQueue error: null
Jan 11 15:25:42 volumio volumio[1172]: info: ------------------------------ 255ms
Jan 11 15:25:42 volumio volumio[1172]: info: ------------------------------ 255ms
Jan 11 15:25:42 volumio volumio[1172]: info: ------------------------------ 255ms
Jan 11 15:25:42 volumio volumio[1172]: info:
Jan 11 15:25:42 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:42 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand add "http://cdn-cms.tunein.com/service/Audio/notcompatible.enUS.mp3" took 1 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand play
Jan 11 15:25:42 volumio volumio[1172]: info:
Jan 11 15:25:42 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:42 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:42 volumio volumio[1172]: info:
Jan 11 15:25:42 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:42 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:42 volumio volumio[1172]: info: ------------------------------ 3ms
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand play took 2 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: info: ------------------------------ 2ms
Jan 11 15:25:42 volumio volumio[1172]: info: ------------------------------ 2ms
Jan 11 15:25:42 volumio volumio[1172]: info:
Jan 11 15:25:42 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:42 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:42 volumio volumio[1172]: info:
Jan 11 15:25:42 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:42 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:42 volumio volumio[1172]: info:
Jan 11 15:25:42 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:42 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:42 volumio volumio[1172]: info:
Jan 11 15:25:42 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand status took 55 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:42 volumio volumio[1172]: info:
Jan 11 15:25:42 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:42 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand status took 55 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand status took 55 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand status took 1 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:42 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:42 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:42 volumio volumio[1172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":12,"samplerate":"16 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"notcompatible.enUS.mp3","artist":null,"album":null,"uri":"http://cdn-cms.tunein.com/service/Audio/notcompatible.enUS.mp3","trackType":"mp3"}
Jan 11 15:25:42 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::syncState stateService play
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:42 volumio volumio[1172]: info: ------------------------------ 57ms
Jan 11 15:25:42 volumio volumio[1172]: info:
Jan 11 15:25:42 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:42 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand status took 2 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand status took 0 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:42 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:42 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:42 volumio volumio[1172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":12,"samplerate":"16 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"24 Kbps","isStreaming":false,"title":"notcompatible.enUS.mp3","artist":null,"album":null,"uri":"http://cdn-cms.tunein.com/service/Audio/notcompatible.enUS.mp3","trackType":"mp3"}
Jan 11 15:25:42 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::syncState stateService play
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus play
Jan 11 15:25:42 volumio volumio[1172]: info: Received an update from plugin. extracting info from payload
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:42 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:42 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:42 volumio volumio[1172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":12,"samplerate":"16 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"24 Kbps","isStreaming":false,"title":"notcompatible.enUS.mp3","artist":null,"album":null,"uri":"http://cdn-cms.tunein.com/service/Audio/notcompatible.enUS.mp3","trackType":"mp3"}
Jan 11 15:25:42 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::syncState stateService play
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus play
Jan 11 15:25:42 volumio volumio[1172]: info: Received an update from plugin. extracting info from payload
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:42 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:42 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:42 volumio volumio[1172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1068,"duration":12,"samplerate":"16 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"24 Kbps","isStreaming":false,"title":"notcompatible.enUS.mp3","artist":null,"album":null,"uri":"http://cdn-cms.tunein.com/service/Audio/notcompatible.enUS.mp3","trackType":"mp3"}
Jan 11 15:25:42 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::syncState stateService play
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus play
Jan 11 15:25:42 volumio volumio[1172]: info: Received an update from plugin. extracting info from payload
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:42 volumio volumio[1172]: info: ------------------------------ 77ms
Jan 11 15:25:42 volumio volumio[1172]: info: ------------------------------ 80ms
Jan 11 15:25:42 volumio volumio[1172]: info: ------------------------------ 57ms
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 24 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 23 milliseconds
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:42 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:42 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:42 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:42 volumio volumio[1172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1068,"duration":12,"samplerate":"16 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"24 Kbps","isStreaming":false,"title":"notcompatible.enUS.mp3","artist":null,"album":null,"uri":"http://cdn-cms.tunein.com/service/Audio/notcompatible.enUS.mp3","trackType":"mp3"}
Jan 11 15:25:42 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::syncState stateService play
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus play
Jan 11 15:25:42 volumio volumio[1172]: info: Received an update from plugin. extracting info from payload
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:42 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:42 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:42 volumio volumio[1172]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1068,"duration":12,"samplerate":"16 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"24 Kbps","isStreaming":false,"title":"notcompatible.enUS.mp3","artist":null,"album":null,"uri":"http://cdn-cms.tunein.com/service/Audio/notcompatible.enUS.mp3","trackType":"mp3"}
Jan 11 15:25:42 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::syncState stateService play
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus play
Jan 11 15:25:42 volumio volumio[1172]: info: Received an update from plugin. extracting info from payload
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:42 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:42 volumio volumio[1172]: info: ------------------------------ 35ms
Jan 11 15:25:42 volumio volumio[1172]: info: ------------------------------ 34ms
Jan 11 15:25:46 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::ClearQueue
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::stPlaybackTimer
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::updateTrackBlock
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrackBlock
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::serviceStop
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::serviceStop
Jan 11 15:25:46 volumio volumio[1172]: info: [1768119946447] ControllerWebradio::stop
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::clearPlayQueue
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::addQueueItems
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::addQueueItems
Jan 11 15:25:46 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:46 volumio volumio[1172]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s299418
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::updateTrackBlock
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrackBlock
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPlay
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::play index 0
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::play index undefined
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::startPlaybackTimer
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:46 volumio volumio[1172]: info: [1768119946453] ControllerWebradio::clearAddPlayTrack
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 15:25:46 volumio volumio[1172]: info:
Jan 11 15:25:46 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand stop took 8 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand stop took 1 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand clear
Jan 11 15:25:46 volumio volumio[1172]: info:
Jan 11 15:25:46 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:46 volumio volumio[1172]: info:
Jan 11 15:25:46 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:46 volumio volumio[1172]: info:
Jan 11 15:25:46 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:46 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand status took 6 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand clear took 5 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand status took 6 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand status took 6 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand load "http://titan.shoutca.st:8790/"
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:46 volumio volumio[1172]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:46 volumio volumio[1172]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jan 11 15:25:46 volumio volumio[1172]: info: ------------------------------ 10ms
Jan 11 15:25:46 volumio volumio[1172]: info: ------------------------------ 10ms
Jan 11 15:25:46 volumio volumio[1172]: info:
Jan 11 15:25:46 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:46 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:46 volumio volumio[1172]: info:
Jan 11 15:25:46 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:46 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:46 volumio volumio[1172]: error: updateQueue error: null
Jan 11 15:25:46 volumio volumio[1172]: info: ------------------------------ 6ms
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:46 volumio volumio[1172]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 11 15:25:46 volumio volumio[1172]: info: ------------------------------ 12ms
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand add "http://titan.shoutca.st:8790/"
Jan 11 15:25:46 volumio volumio[1172]: error: updateQueue error: null
Jan 11 15:25:46 volumio volumio[1172]: error: updateQueue error: null
Jan 11 15:25:46 volumio volumio[1172]: info:
Jan 11 15:25:46 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:46 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:46 volumio volumio[1172]: info: ------------------------------ 180ms
Jan 11 15:25:46 volumio volumio[1172]: info: ------------------------------ 180ms
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand add "http://titan.shoutca.st:8790/" took 3 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand play
Jan 11 15:25:46 volumio volumio[1172]: info:
Jan 11 15:25:46 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:46 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:46 volumio volumio[1172]: info:
Jan 11 15:25:46 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:46 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:46 volumio volumio[1172]: info: ------------------------------ 4ms
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand play took 4 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: ------------------------------ 3ms
Jan 11 15:25:46 volumio volumio[1172]: info: ------------------------------ 9ms
Jan 11 15:25:46 volumio volumio[1172]: info:
Jan 11 15:25:46 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:46 volumio volumio[1172]: info:
Jan 11 15:25:46 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:46 volumio volumio[1172]: info:
Jan 11 15:25:46 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:46 volumio volumio[1172]: info:
Jan 11 15:25:46 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand clearerror
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand status took 2 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:46 volumio volumio[1172]: info:
Jan 11 15:25:46 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand clearerror
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand status took 3 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand clearerror
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand status took 3 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand clearerror took 1 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand status took 1 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:46 volumio volumio[1172]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://titan.shoutca.st:8790/","trackType":"st:8790/"}
Jan 11 15:25:46 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::syncState stateService stop
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: No code
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: ------------------------------ 12ms
Jan 11 15:25:46 volumio volumio[1172]: info:
Jan 11 15:25:46 volumio volumio[1172]: ---------------------------- MPD announces state update: player
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::getState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand status
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand status took 11 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand clearerror took 11 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand clearerror took 11 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 9 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 9 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 9 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand status took 3 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseState
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:46 volumio volumio[1172]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://titan.shoutca.st:8790/","trackType":"st:8790/"}
Jan 11 15:25:46 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::syncState stateService stop
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: No code
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:46 volumio volumio[1172]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://titan.shoutca.st:8790/","trackType":"st:8790/"}
Jan 11 15:25:46 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::syncState stateService stop
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: No code
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:46 volumio volumio[1172]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://titan.shoutca.st:8790/","trackType":"st:8790/"}
Jan 11 15:25:46 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::syncState stateService stop
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: No code
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: ------------------------------ 32ms
Jan 11 15:25:46 volumio volumio[1172]: info: ------------------------------ 33ms
Jan 11 15:25:46 volumio volumio[1172]: info: ------------------------------ 33ms
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 20 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: info: sendMpdCommand playlistinfo took 20 milliseconds
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:46 volumio volumio[1172]: verbose: ControllerMpd::parseTrackInfo
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:46 volumio volumio[1172]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://titan.shoutca.st:8790/","trackType":"st:8790/"}
Jan 11 15:25:46 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::syncState stateService stop
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: No code
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: ControllerMpd::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::servicePushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:46 volumio volumio[1172]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://titan.shoutca.st:8790/","trackType":"st:8790/"}
Jan 11 15:25:46 volumio volumio[1172]: verbose: CURRENT POSITION 0
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::syncState stateService stop
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::syncState currentStatus stop
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: No code
Jan 11 15:25:46 volumio volumio[1172]: info: CoreStateMachine::pushState
Jan 11 15:25:46 volumio volumio[1172]: info: CoreCommandRouter::volumioPushState
Jan 11 15:25:46 volumio volumio[1172]: info: ------------------------------ 44ms
Jan 11 15:25:46 volumio volumio[1172]: info: ------------------------------ 35ms
Jan 11 15:25:48 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:25:50 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jan 11 15:25:50 volumio volumio[1172]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101800
Jan 11 15:25:50 volumio volumio[1172]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101800
Jan 11 15:25:50 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:50 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:51 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:51 volumio volumio[1172]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 11 15:25:51 volumio volumio[1172]: info: CoreStateMachine::ClearQueue
Jan 11 15:25:51 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:25:51 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:51 volumio volumio[1172]: info: CorePlayQueue::clearPlayQueue
Jan 11 15:25:51 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:25:51 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:25:51 volumio volumio[1172]: info: CoreStateMachine::addQueueItems
Jan 11 15:25:51 volumio volumio[1172]: info: CorePlayQueue::addQueueItems
Jan 11 15:25:51 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:51 volumio volumio[1172]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s88623
Jan 11 15:25:51 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 11 15:25:51 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:25:51 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:25:51 volumio volumio[1172]: info: CoreStateMachine::updateTrackBlock
Jan 11 15:25:51 volumio volumio[1172]: info: CorePlayQueue::getTrackBlock
Jan 11 15:25:51 volumio volumio[1172]: info: CoreCommandRouter::volumioPlay
Jan 11 15:25:51 volumio volumio[1172]: info: CoreStateMachine::play index 0
Jan 11 15:25:51 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:51 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:25:51 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:51 volumio volumio[1172]: info: CoreStateMachine::play index undefined
Jan 11 15:25:51 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:51 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:51 volumio volumio[1172]: info: CoreStateMachine::startPlaybackTimer
Jan 11 15:25:51 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:51 volumio volumio[1172]: info: [1768119951876] ControllerWebradio::clearAddPlayTrack
Jan 11 15:25:51 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 15:25:51 volumio volumio[1172]: info: sendMpdCommand stop took 1 milliseconds
Jan 11 15:25:51 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand clear
Jan 11 15:25:51 volumio volumio[1172]: info:
Jan 11 15:25:51 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:51 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:51 volumio volumio[1172]: info: sendMpdCommand clear took 3 milliseconds
Jan 11 15:25:51 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand load "mms://211.1.40.29/castle"
Jan 11 15:25:51 volumio volumio[1172]: info:
Jan 11 15:25:51 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:51 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:51 volumio volumio[1172]: info:
Jan 11 15:25:51 volumio volumio[1172]: ---------------------------- MPD announces system playlist update
Jan 11 15:25:51 volumio volumio[1172]: info: Ignoring MPD Status Update
Jan 11 15:25:58 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jan 11 15:25:58 volumio volumio[1172]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101674
Jan 11 15:25:58 volumio volumio[1172]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101674
Jan 11 15:25:58 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:25:58 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:25:58 volumio volumio[1172]: info: Listing playlists
Jan 11 15:25:58 volumio volumio[1172]: info: Listing playlists
Jan 11 15:25:58 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:59 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:59 volumio volumio[1172]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 11 15:25:59 volumio volumio[1172]: info: CoreStateMachine::ClearQueue
Jan 11 15:25:59 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:25:59 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:25:59 volumio volumio[1172]: info: CorePlayQueue::clearPlayQueue
Jan 11 15:25:59 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:25:59 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:25:59 volumio volumio[1172]: info: CoreStateMachine::addQueueItems
Jan 11 15:25:59 volumio volumio[1172]: info: CorePlayQueue::addQueueItems
Jan 11 15:25:59 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:25:59 volumio volumio[1172]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s14574
Jan 11 15:25:59 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 11 15:26:00 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:26:00 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:26:00 volumio volumio[1172]: info: CoreStateMachine::updateTrackBlock
Jan 11 15:26:00 volumio volumio[1172]: info: CorePlayQueue::getTrackBlock
Jan 11 15:26:00 volumio volumio[1172]: info: CoreCommandRouter::volumioPlay
Jan 11 15:26:00 volumio volumio[1172]: info: CoreStateMachine::play index 0
Jan 11 15:26:00 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:00 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:26:00 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:00 volumio volumio[1172]: info: CoreStateMachine::play index undefined
Jan 11 15:26:00 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:00 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:00 volumio volumio[1172]: info: CoreStateMachine::startPlaybackTimer
Jan 11 15:26:00 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:00 volumio volumio[1172]: info: [1768119960024] ControllerWebradio::clearAddPlayTrack
Jan 11 15:26:00 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 15:26:01 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:26:01 volumio volumio[1172]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 11 15:26:01 volumio volumio[1172]: info: CoreStateMachine::ClearQueue
Jan 11 15:26:01 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:26:01 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:01 volumio volumio[1172]: info: CorePlayQueue::clearPlayQueue
Jan 11 15:26:01 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:26:01 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:26:01 volumio volumio[1172]: info: CoreStateMachine::addQueueItems
Jan 11 15:26:01 volumio volumio[1172]: info: CorePlayQueue::addQueueItems
Jan 11 15:26:01 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:26:01 volumio volumio[1172]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s14574
Jan 11 15:26:01 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 11 15:26:01 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:26:01 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:26:01 volumio volumio[1172]: info: CoreStateMachine::updateTrackBlock
Jan 11 15:26:01 volumio volumio[1172]: info: CorePlayQueue::getTrackBlock
Jan 11 15:26:01 volumio volumio[1172]: info: CoreCommandRouter::volumioPlay
Jan 11 15:26:01 volumio volumio[1172]: info: CoreStateMachine::play index 0
Jan 11 15:26:01 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:01 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:26:01 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:01 volumio volumio[1172]: info: CoreStateMachine::play index undefined
Jan 11 15:26:01 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:01 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:01 volumio volumio[1172]: info: CoreStateMachine::startPlaybackTimer
Jan 11 15:26:01 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:01 volumio volumio[1172]: info: [1768119961530] ControllerWebradio::clearAddPlayTrack
Jan 11 15:26:01 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 15:26:06 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jan 11 15:26:06 volumio volumio[1172]: info: Getting BBC Radios
Jan 11 15:26:07 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:26:08 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:26:08 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:08 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:26:08 volumio volumio[1172]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 11 15:26:08 volumio volumio[1172]: info: CoreStateMachine::ClearQueue
Jan 11 15:26:08 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:26:08 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:08 volumio volumio[1172]: info: CorePlayQueue::clearPlayQueue
Jan 11 15:26:08 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:26:08 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:26:08 volumio volumio[1172]: info: CoreStateMachine::addQueueItems
Jan 11 15:26:08 volumio volumio[1172]: info: CorePlayQueue::addQueueItems
Jan 11 15:26:08 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:26:08 volumio volumio[1172]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_23461179/live/ww/bbc_radio_three/bbc_radio_three.isml/bbc_radio_three-audio%3d128000.norewind.m3u8
Jan 11 15:26:08 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 11 15:26:08 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:26:08 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:26:08 volumio volumio[1172]: info: CoreStateMachine::updateTrackBlock
Jan 11 15:26:08 volumio volumio[1172]: info: CorePlayQueue::getTrackBlock
Jan 11 15:26:08 volumio volumio[1172]: info: CoreCommandRouter::volumioPlay
Jan 11 15:26:08 volumio volumio[1172]: info: CoreStateMachine::play index 0
Jan 11 15:26:08 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:08 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:26:08 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:08 volumio volumio[1172]: info: CoreStateMachine::play index undefined
Jan 11 15:26:08 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:08 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:08 volumio volumio[1172]: info: CoreStateMachine::startPlaybackTimer
Jan 11 15:26:08 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:08 volumio volumio[1172]: info: [1768119968873] ControllerWebradio::clearAddPlayTrack
Jan 11 15:26:08 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 15:26:16 volumio mpd_monitor.sh[1867]: MPD Monitor Service: MPD Appears to be inactive, restarting
Jan 11 15:26:16 volumio systemd[1]: Stopping mpd.service - Music Player Daemon...
Jan 11 15:26:18 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:26:18 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:18 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:26:18 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:18 volumio volumio[1172]: info: Listing playlists
Jan 11 15:26:18 volumio volumio[1172]: info: Listing playlists
Jan 11 15:26:18 volumio nmbd[1169]: [2026/01/11 15:26:18.566727, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jan 11 15:26:18 volumio nmbd[1169]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.55 for name WORKGROUP<1d>.
Jan 11 15:26:18 volumio nmbd[1169]: This response was from IP 192.168.1.51, reporting an IP address of 192.168.1.51.
Jan 11 15:26:20 volumio volumio[1172]: info: CoreCommandRouter::volumioPlay
Jan 11 15:26:20 volumio volumio[1172]: info: CoreStateMachine::play index undefined
Jan 11 15:26:20 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:20 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:20 volumio volumio[1172]: info: CoreStateMachine::startPlaybackTimer
Jan 11 15:26:20 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:20 volumio volumio[1172]: info: [1768119980990] ControllerWebradio::clearAddPlayTrack
Jan 11 15:26:20 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 15:26:25 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jan 11 15:26:25 volumio volumio[1172]: info: Getting webradio selection
Jan 11 15:26:25 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:26:27 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:26:27 volumio volumio[1172]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 11 15:26:27 volumio volumio[1172]: info: CoreStateMachine::ClearQueue
Jan 11 15:26:27 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:26:27 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:27 volumio volumio[1172]: info: CorePlayQueue::clearPlayQueue
Jan 11 15:26:27 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:26:27 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:26:27 volumio volumio[1172]: info: CoreStateMachine::addQueueItems
Jan 11 15:26:27 volumio volumio[1172]: info: CorePlayQueue::addQueueItems
Jan 11 15:26:27 volumio volumio[1172]: info: Preload queue cleared
Jan 11 15:26:27 volumio volumio[1172]: info: Adding Item to queue: https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3
Jan 11 15:26:27 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 11 15:26:27 volumio volumio[1172]: info: CoreCommandRouter::volumioPushQueue
Jan 11 15:26:27 volumio volumio[1172]: info: CorePlayQueue::saveQueue
Jan 11 15:26:27 volumio volumio[1172]: info: CoreStateMachine::updateTrackBlock
Jan 11 15:26:27 volumio volumio[1172]: info: CorePlayQueue::getTrackBlock
Jan 11 15:26:27 volumio volumio[1172]: info: CoreCommandRouter::volumioPlay
Jan 11 15:26:27 volumio volumio[1172]: info: CoreStateMachine::play index 0
Jan 11 15:26:27 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:27 volumio volumio[1172]: info: CoreStateMachine::stop
Jan 11 15:26:27 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:27 volumio volumio[1172]: info: CoreStateMachine::play index undefined
Jan 11 15:26:27 volumio volumio[1172]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 11 15:26:27 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:27 volumio volumio[1172]: info: CoreStateMachine::startPlaybackTimer
Jan 11 15:26:27 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:27 volumio volumio[1172]: info: [1768119987617] ControllerWebradio::clearAddPlayTrack
Jan 11 15:26:27 volumio volumio[1172]: verbose: ControllerMpd::sendMpdCommand stop
Jan 11 15:26:28 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:26:28 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:35 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:26:35 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:38 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:26:38 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:38 volumio volumio[1172]: info: Listing playlists
Jan 11 15:26:38 volumio volumio[1172]: info: Listing playlists
Jan 11 15:26:39 volumio volumio[1172]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 11 15:26:39 volumio volumio[1172]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory
Jan 11 15:26:39 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jan 11 15:26:39 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Jan 11 15:26:39 volumio sudo[4210]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Jan 11 15:26:39 volumio sudo[4205]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
Jan 11 15:26:39 volumio sudo[4205]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:26:39 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Jan 11 15:26:39 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Jan 11 15:26:39 volumio sudo[4216]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Jan 11 15:26:39 volumio sudo[4216]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:26:39 volumio sudo[4210]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:26:39 volumio sudo[4205]: pam_unix(sudo:session): session closed for user root
Jan 11 15:26:39 volumio sudo[4218]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Jan 11 15:26:39 volumio sudo[4218]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:26:39 volumio sudo[4223]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 11 15:26:39 volumio sudo[4223]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:26:39 volumio sudo[4227]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 11 15:26:39 volumio sudo[4227]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:26:39 volumio sudo[4231]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jan 11 15:26:39 volumio sudo[4231]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:26:39 volumio sudo[4223]: pam_unix(sudo:session): session closed for user root
Jan 11 15:26:39 volumio sudo[4216]: pam_unix(sudo:session): session closed for user root
Jan 11 15:26:39 volumio sudo[4227]: pam_unix(sudo:session): session closed for user root
Jan 11 15:26:39 volumio sudo[4210]: pam_unix(sudo:session): session closed for user root
Jan 11 15:26:39 volumio sudo[4218]: pam_unix(sudo:session): session closed for user root
Jan 11 15:26:39 volumio sudo[4231]: pam_unix(sudo:session): session closed for user root
Jan 11 15:26:39 volumio volumio[1172]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Jan 11 15:26:39 volumio volumio[1172]: wlan0 Interface doesn't support scanning.
Jan 11 15:26:39 volumio volumio[1172]: info: Cannot use regular scanning, forcing with ap-force
Jan 11 15:26:39 volumio sudo[4256]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Jan 11 15:26:39 volumio sudo[4256]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:26:39 volumio sudo[4256]: pam_unix(sudo:session): session closed for user root
Jan 11 15:26:39 volumio volumio[1172]: command failed: No such device (-19)
Jan 11 15:26:39 volumio volumio[1172]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Jan 11 15:26:39 volumio volumio[1172]: command failed: No such device (-19)
Jan 11 15:26:41 volumio volumio[1172]: info: CALLMETHOD: system_controller network saveWiredNet [object Object]
Jan 11 15:26:41 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: network , saveWiredNet
Jan 11 15:26:41 volumio sudo[4264]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces
Jan 11 15:26:41 volumio sudo[4264]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:26:41 volumio sudo[4264]: pam_unix(sudo:session): session closed for user root
Jan 11 15:26:41 volumio sudo[4266]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf
Jan 11 15:26:41 volumio sudo[4266]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:26:41 volumio sudo[4266]: pam_unix(sudo:session): session closed for user root
Jan 11 15:26:41 volumio volumio[1172]: info: Permissions for /etc/network/interfaces set
Jan 11 15:26:41 volumio volumio[1172]: info: Restarting Wired Network
Jan 11 15:26:41 volumio volumio[1172]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart
Jan 11 15:26:41 volumio volumio[1172]: info: Discovery: Restarting Advertising due to device name change
Jan 11 15:26:41 volumio sudo[4269]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ip addr flush dev eth0
Jan 11 15:26:41 volumio sudo[4269]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:26:41 volumio avahi-daemon[865]: Withdrawing address record for 192.168.1.55 on eth0.
Jan 11 15:26:41 volumio avahi-daemon[865]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.55.
Jan 11 15:26:41 volumio avahi-daemon[865]: Interface eth0.IPv4 no longer relevant for mDNS.
Jan 11 15:26:41 volumio dhcpcd[893]: eth0: pid 4270 deleted IP address 192.168.1.55/24
Jan 11 15:26:41 volumio dhcpcd[893]: eth0: deleting route to 192.168.1.0/24
Jan 11 15:26:41 volumio dhcpcd[893]: eth0: deleting default route via 192.168.1.1
Jan 11 15:26:41 volumio sudo[4269]: pam_unix(sudo:session): session closed for user root
Jan 11 15:26:41 volumio dhcpcd[846]: eth0: pid 4270 deleted IP address 192.168.1.55/24
Jan 11 15:26:41 volumio dhcpcd[846]: eth0: deleting route to 192.168.1.0/24
Jan 11 15:26:41 volumio dhcpcd[846]: eth0: deleting default route via 192.168.1.1
Jan 11 15:26:41 volumio volumio[1172]: info: Discovery: A device disappeared from network
Jan 11 15:26:41 volumio volumio[1172]: info: Discovery: Device volumio disappeared from network
Jan 11 15:26:41 volumio sudo[4274]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 down
Jan 11 15:26:41 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Jan 11 15:26:41 volumio sudo[4274]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:26:41 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Jan 11 15:26:41 volumio systemd[1]: welcome.service: Deactivated successfully.
Jan 11 15:26:41 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Jan 11 15:26:41 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Jan 11 15:26:41 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Jan 11 15:26:41 volumio dhcpcd[893]: eth0: probing address 192.168.1.55/24
Jan 11 15:26:41 volumio dhcpcd[846]: eth0: probing address 192.168.1.55/24
Jan 11 15:26:41 volumio dhcpcd[846]: eth0: carrier lost
Jan 11 15:26:41 volumio dhcpcd[893]: eth0: carrier lost
Jan 11 15:26:41 volumio welcome[4285]: Resolved ip:[0]
Jan 11 15:26:41 volumio sudo[4274]: pam_unix(sudo:session): session closed for user root
Jan 11 15:26:41 volumio sudo[4299]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 up
Jan 11 15:26:41 volumio systemd[1]: Finished welcome.service - Show a welcome message on console.
Jan 11 15:26:41 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Jan 11 15:26:41 volumio sudo[4299]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 15:26:41 volumio kernel: 8021q: adding VLAN 0 to HW filter on device eth0
Jan 11 15:26:41 volumio sudo[4299]: pam_unix(sudo:session): session closed for user root
Jan 11 15:26:41 volumio kernel: e1000: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: None
Jan 11 15:26:41 volumio dhcpcd[846]: eth0: carrier acquired
Jan 11 15:26:41 volumio dhcpcd[846]: eth0: config file changed, expiring leases
Jan 11 15:26:41 volumio dhcpcd[846]: eth0: IAID 29:78:9a:41
Jan 11 15:26:41 volumio dhcpcd[893]: eth0: carrier acquired
Jan 11 15:26:41 volumio dhcpcd[893]: eth0: config file changed, expiring leases
Jan 11 15:26:41 volumio dhcpcd[893]: eth0: IAID 29:78:9a:41
Jan 11 15:26:42 volumio volumio[1172]: info: Discovery: A device disappeared from network
Jan 11 15:26:42 volumio dhcpcd[846]: eth0: soliciting an IPv6 router
Jan 11 15:26:42 volumio dhcpcd[893]: eth0: soliciting an IPv6 router
Jan 11 15:26:42 volumio ntpd[1116]: IO: Deleting interface #6 eth0, 192.168.1.55#123, interface stats: received=18, sent=18, dropped=0, active_time=101 secs
Jan 11 15:26:42 volumio ntpd[1116]: PROTO: 202.28.116.236 unlink local addr 192.168.1.55 ->
Jan 11 15:26:42 volumio ntpd[1116]: PROTO: 165.154.232.19 unlink local addr 192.168.1.55 ->
Jan 11 15:26:42 volumio ntpd[1116]: PROTO: 203.159.70.33 unlink local addr 192.168.1.55 ->
Jan 11 15:26:42 volumio ntpd[1116]: PROTO: 147.50.17.138 unlink local addr 192.168.1.55 ->
Jan 11 15:26:42 volumio ntpd[1116]: PROTO: 124.109.2.169 unlink local addr 192.168.1.55 ->
Jan 11 15:26:42 volumio ntpd[1116]: PROTO: 202.28.33.225 unlink local addr 192.168.1.55 ->
Jan 11 15:26:42 volumio ntpd[1116]: PROTO: 202.12.97.45 unlink local addr 192.168.1.55 ->
Jan 11 15:26:42 volumio ntpd[1116]: PROTO: 202.29.58.130 unlink local addr 192.168.1.55 ->
Jan 11 15:26:42 volumio ntpd[1116]: PROTO: 202.28.92.208 unlink local addr 192.168.1.55 ->
Jan 11 15:26:42 volumio ntpd[1116]: PROTO: 171.103.24.86 unlink local addr 192.168.1.55 ->
Jan 11 15:26:42 volumio dhcpcd[846]: eth0: rebinding lease of 192.168.1.178
Jan 11 15:26:43 volumio dhcpcd[846]: eth0: probing address 192.168.1.178/24
Jan 11 15:26:43 volumio dhcpcd[893]: eth0: rebinding lease of 192.168.1.178
Jan 11 15:26:43 volumio dhcpcd[893]: eth0: probing address 192.168.1.178/24
Jan 11 15:26:44 volumio volumio[1172]: info: Volumio Network Manager: Network status updated: 0
Jan 11 15:26:46 volumio volumio[1172]: info: Discovery: Started advertising with name: Volumio
Jan 11 15:26:47 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:26:47 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:47 volumio volumio[1172]: info: Discovery: adding 16f5f909-e0db-4daa-a5d9-4fb43c837537
Jan 11 15:26:47 volumio volumio[1172]: info: Discovery: Found device Volumio
Jan 11 15:26:47 volumio volumio[1172]: info: CoreCommandRouter::volumioGetState
Jan 11 15:26:47 volumio volumio[1172]: info: CorePlayQueue::getTrack 0
Jan 11 15:26:48 volumio dhcpcd[846]: eth0: leased 192.168.1.178 for 86400 seconds
Jan 11 15:26:48 volumio dhcpcd[846]: eth0: adding route to 192.168.1.0/24
Jan 11 15:26:48 volumio dhcpcd[846]: eth0: adding default route via 192.168.1.1
Jan 11 15:26:48 volumio avahi-daemon[865]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.178.
Jan 11 15:26:48 volumio avahi-daemon[865]: New relevant interface eth0.IPv4 for mDNS.
Jan 11 15:26:48 volumio avahi-daemon[865]: Registering new address record for 192.168.1.178 on eth0.IPv4.
Jan 11 15:26:48 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Jan 11 15:26:48 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Jan 11 15:26:48 volumio systemd[1]: welcome.service: Deactivated successfully.
Jan 11 15:26:48 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Jan 11 15:26:48 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Jan 11 15:26:48 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Jan 11 15:26:48 volumio welcome[4374]: Resolved ip:[1] 192.168.1.178
Jan 11 15:26:48 volumio systemd[1]: Finished welcome.service - Show a welcome message on console.
Jan 11 15:26:48 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Jan 11 15:26:48 volumio dhcpcd[893]: eth0: leased 192.168.1.178 for 86400 seconds
Jan 11 15:26:48 volumio dhcpcd[893]: eth0: adding route to 192.168.1.0/24
Jan 11 15:26:48 volumio dhcpcd[893]: eth0: adding default route via 192.168.1.1
Jan 11 15:26:48 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Jan 11 15:26:48 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Jan 11 15:26:48 volumio systemd[1]: welcome.service: Deactivated successfully.
Jan 11 15:26:48 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Jan 11 15:26:48 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Jan 11 15:26:48 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Jan 11 15:26:48 volumio welcome[4396]: Resolved ip:[1] 192.168.1.178
Jan 11 15:26:48 volumio volumio[1172]: compat.c: read() failed: Resource temporarily unavailable
Jan 11 15:26:48 volumio volumio[1172]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 11 15:26:48 volumio systemd[1]: Finished welcome.service - Show a welcome message on console.
Jan 11 15:26:48 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Jan 11 15:26:48 volumio volumio[1172]: Error: dns service error: unknown
Jan 11 15:26:48 volumio volumio[1172]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) {
Jan 11 15:26:48 volumio volumio[1172]: errorCode: -65537
Jan 11 15:26:48 volumio volumio[1172]: }
Jan 11 15:26:48 volumio volumio[1172]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 11 15:26:48 volumio sudo[4429]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-11 15:25'
Jan 11 15:26:48 volumio sudo[4429]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="cfdc872d40b979cca36352a7333c940c38dc64b5"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025"
VOLUMIO_VERSION="4.073"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"