-- Logs begin at Tue 2024-07-23 14:47:55 UTC, end at Fri 2024-07-26 12:15:01 UTC. -- Jul 26 12:14:13 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:14:13 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:14:13 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 12:14:13 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:14:13 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:14:13 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:14:13 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:14:13 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:14:13 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:14:13 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:14:13 volumio shairport-sync[936]: {"time":1721993711774,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jul 26 12:14:13 volumio shairport-sync[936]: Dload Upload Total Spent Left Speed Jul 26 12:14:13 volumio volumio[584]: info: Jul 26 12:14:13 volumio volumio[584]: ---------------------------- Client requests Stop Airplay Playback Jul 26 12:14:13 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Jul 26 12:14:13 volumio volumio[584]: info: Airplay playback stop Jul 26 12:14:13 volumio volumio[584]: info: Airplay Playback Stopped, clearing state Jul 26 12:14:13 volumio volumio[584]: info: CoreStateMachine::resetVolumioState Jul 26 12:14:13 volumio volumio[584]: info: CoreStateMachine::getcurrentVolume Jul 26 12:14:13 volumio volumio[584]: info: CoreCommandRouter::volumioRetrievevolume Jul 26 12:14:13 volumio shairport-sync[936]: [158B blob data] Jul 26 12:14:13 volumio volumio[584]: info: VolumeController:: Volume=13 Mute =false Jul 26 12:14:13 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:14:13 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:14:13 volumio volumio[584]: info: CoreStateMachine::updateTrackBlock Jul 26 12:14:13 volumio volumio[584]: info: CorePlayQueue::getTrackBlock Jul 26 12:14:13 volumio volumio[584]: info: CoreCommandRouter::volumioRetrievevolume Jul 26 12:14:13 volumio volumio[584]: info: VolumeController:: Volume=13 Mute =false Jul 26 12:14:13 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:14:13 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:14:14 volumio volumio[584]: info: Airplay started streaming, receiving metadatas Jul 26 12:14:14 volumio volumio[584]: info: Airplay started streaming, receiving metadatas Jul 26 12:14:14 volumio volumio[584]: info: Airplay started streaming, receiving metadatas Jul 26 12:14:14 volumio shairport-sync[936]: {"time":1721996053840,"response":"stopAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jul 26 12:14:14 volumio shairport-sync[936]: Dload Upload Total Spent Left Speed Jul 26 12:14:14 volumio volumio[584]: info: Jul 26 12:14:14 volumio volumio[584]: ---------------------------- Client requests Start Airplay PlaybackRoutine Jul 26 12:14:14 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Jul 26 12:14:14 volumio volumio[584]: info: Airplay playback start Jul 26 12:14:14 volumio shairport-sync[936]: [158B blob data] Jul 26 12:14:14 volumio shairport-sync[936]: {"time":1721996054796,"response":"startAirplayPlayback Success"} Jul 26 12:14:14 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=11/SEGV Jul 26 12:14:14 volumio systemd[1]: shairport-sync.service: Failed with result 'signal'. Jul 26 12:14:15 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:14:15 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:14:15 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 12:14:15 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:14:15 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:14:15 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:14:15 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:14:15 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:14:15 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:14:15 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:14:15 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:14:15 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:14:15 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:14:30 volumio volumio[584]: verbose: New Socket.io Connection to 192.168.129.37 from 192.168.129.15 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.5 Safari/605.1.15 Total Clients: 2 Jul 26 12:14:30 volumio volumio[584]: info: CoreCommandRouter::volumioGetState Jul 26 12:14:30 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 26 12:14:30 volumio volumio[584]: info: CoreCommandRouter::volumioGetVisibleSources Jul 26 12:14:30 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 26 12:14:30 volumio volumio[584]: info: Listing playlists Jul 26 12:14:57 volumio volumio[584]: info: Clearing queue after UPNP request Jul 26 12:14:57 volumio volumio[584]: verbose: UNSET VOLATILE Jul 26 12:14:57 volumio volumio[584]: info: Stopping Airplay Playback and sending pause command to client via USR2 Jul 26 12:14:58 volumio sudo[28447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 Jul 26 12:14:58 volumio sudo[28447]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 26 12:14:58 volumio sudo[28447]: pam_unix(sudo:session): session closed for user root Jul 26 12:14:58 volumio volumio[584]: info: Cannot execute Shairport-sync USR2 kill: Error: Command failed: /usr/bin/sudo /bin/kill -USR2 $(pidof shairport-sync) Jul 26 12:14:58 volumio volumio[584]: Usage: Jul 26 12:14:58 volumio volumio[584]: kill [options] [...] Jul 26 12:14:58 volumio volumio[584]: Options: Jul 26 12:14:58 volumio volumio[584]: [...] send signal to every listed Jul 26 12:14:58 volumio volumio[584]: -, -s, --signal Jul 26 12:14:58 volumio volumio[584]: specify the to be sent Jul 26 12:14:58 volumio volumio[584]: -l, --list=[] list all signal names, or convert one to a name Jul 26 12:14:58 volumio volumio[584]: -L, --table list all signal names in a nice table Jul 26 12:14:58 volumio volumio[584]: -h, --help display this help and exit Jul 26 12:14:58 volumio volumio[584]: -V, --version output version information and exit Jul 26 12:14:58 volumio volumio[584]: For more details see kill(1). Jul 26 12:14:58 volumio volumio[584]: info: CoreStateMachine::ClearQueue Jul 26 12:14:58 volumio volumio[584]: info: CoreStateMachine::stop Jul 26 12:14:58 volumio volumio[584]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 12:14:58 volumio volumio[584]: verbose: UNSET VOLATILE Jul 26 12:14:58 volumio volumio[584]: info: CoreStateMachine::stPlaybackTimer Jul 26 12:14:58 volumio volumio[584]: info: CoreStateMachine::updateTrackBlock Jul 26 12:14:58 volumio volumio[584]: info: CorePlayQueue::getTrackBlock Jul 26 12:14:58 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:14:58 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:14:58 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 12:14:58 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:14:58 volumio volumio[584]: info: CoreStateMachine::serviceStop Jul 26 12:14:58 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:14:58 volumio volumio[584]: info: CoreCommandRouter::serviceStop Jul 26 12:14:58 volumio volumio[584]: info: ControllerMpd::stop Jul 26 12:14:58 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand stop Jul 26 12:14:58 volumio volumio[584]: info: CorePlayQueue::clearPlayQueue Jul 26 12:14:58 volumio volumio[584]: info: CorePlayQueue::saveQueue Jul 26 12:14:58 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:14:58 volumio volumio[584]: info: CoreCommandRouter::volumioPushQueue Jul 26 12:14:58 volumio volumio[584]: error: Upnp client error: Error: This socket has been ended by the other party Jul 26 12:14:58 volumio volumio[584]: info: sendMpdCommand stop took 4 milliseconds Jul 26 12:14:58 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:14:58 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:14:58 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:14:58 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 12:14:58 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:14:58 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:14:58 volumio volumio[584]: verbose: STATE SERVICE {"status":"stop","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B0000032OY.jpg","uri":"https://stream.radioparadise.com/flac","name":"Zen Archer","title":"Zen Archer","artist":"Todd Rundgren","album":"A Wizard, a True Star","streaming":true,"disableUiControls":true,"duration":332,"seek":212891,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 26 12:14:58 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:14:58 volumio volumio[584]: info: CoreStateMachine::syncState stateService stop Jul 26 12:14:58 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus stop Jul 26 12:14:58 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:14:58 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:14:58 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 12:14:58 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:14:58 volumio volumio[584]: info: No code Jul 26 12:14:58 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:14:58 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:14:58 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:14:59 volumio volumio[584]: info: Jul 26 12:14:59 volumio volumio[584]: ---------------------------- MPD announces state update: options Jul 26 12:14:59 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:14:59 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:14:59 volumio volumio[584]: info: Jul 26 12:14:59 volumio volumio[584]: ---------------------------- MPD announces state update: options Jul 26 12:14:59 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:14:59 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:14:59 volumio volumio[584]: info: Jul 26 12:14:59 volumio volumio[584]: ---------------------------- MPD announces state update: options Jul 26 12:14:59 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:14:59 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:14:59 volumio volumio[584]: info: Jul 26 12:14:59 volumio volumio[584]: ---------------------------- MPD announces state update: options Jul 26 12:14:59 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:14:59 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:14:59 volumio volumio[584]: info: Jul 26 12:14:59 volumio volumio[584]: ---------------------------- MPD announces state update: options Jul 26 12:14:59 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:14:59 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:14:59 volumio volumio[584]: info: Jul 26 12:14:59 volumio volumio[584]: ---------------------------- MPD announces state update: options Jul 26 12:14:59 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:14:59 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:14:59 volumio volumio[584]: info: Starting UPNP Playback Jul 26 12:15:00 volumio volumio[584]: info: Preparing playback through UPNP Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioGetState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 6 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 6 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 6 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 5 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 5 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 4 milliseconds Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseTrackInfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseTrackInfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseTrackInfo Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: 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":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService stop Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus stop Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: No code Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: 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":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService stop Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus stop Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: No code Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: 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":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService stop Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus stop Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: No code Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: 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":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService stop Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus stop Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: No code Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: 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":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService stop Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus stop Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: No code Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: 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":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService stop Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus stop Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: No code Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 29ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 29ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 29ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 28ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 28ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 28ms Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 3ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 2ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 1ms Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 8ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 7ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 3ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 2ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 1ms Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 3ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 2ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 1ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 1ms Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 3ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 2ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 1ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 2ms Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 2ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 3ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 2ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 1ms Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 3ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 2ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 1ms Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 5 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 5 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 4 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 4 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 3 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 2 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 6 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 4 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 3 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 4 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 3 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 2 milliseconds Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseTrackInfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseTrackInfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseTrackInfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus stop Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::volumioPushState Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 28ms Jul 26 12:15:00 volumio volumio[584]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 28ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 27ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 26ms Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 12 milliseconds Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseTrackInfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseTrackInfo Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jul 26 12:15:00 volumio volumio[584]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 52ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 46ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 45ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 44ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 43ms Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces system playlist update Jul 26 12:15:00 volumio volumio[584]: info: Ignoring MPD Status Update Jul 26 12:15:00 volumio volumio[584]: info: Jul 26 12:15:00 volumio volumio[584]: ---------------------------- MPD announces state update: player Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::getState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand status Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 6ms Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 5 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 5ms Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 4 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 4ms Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 3 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 3ms Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 3 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 4ms Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 3 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 3ms Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand status took 2 milliseconds Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseState Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 12:15:00 volumio volumio[584]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseTrackInfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseTrackInfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseTrackInfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseTrackInfo Jul 26 12:15:00 volumio volumio[584]: verbose: ControllerMpd::parseTrackInfo Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: info: ControllerMpd::pushState Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::servicePushState Jul 26 12:15:00 volumio volumio[584]: verbose: In UPNP mode Jul 26 12:15:00 volumio volumio[584]: verbose: STATE SERVICE {"status":"play","position":1,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/flac","trackType":"com/flac"} Jul 26 12:15:00 volumio volumio[584]: verbose: CURRENT POSITION 0 Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState stateService play Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::syncState currentStatus play Jul 26 12:15:00 volumio volumio[584]: info: Received an update from plugin. extracting info from payload Jul 26 12:15:00 volumio volumio[584]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 26 12:15:00 volumio volumio[584]: info: CoreStateMachine::pushState Jul 26 12:15:00 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:00 volumio volumio[584]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jul 26 12:15:00 volumio volumio[584]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jul 26 12:15:00 volumio volumio[584]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 27ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 26ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 25ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 24ms Jul 26 12:15:00 volumio volumio[584]: info: ------------------------------ 23ms Jul 26 12:15:01 volumio volumio[584]: info: Starting UPNP Playback Jul 26 12:15:01 volumio volumio[584]: info: Preparing playback through UPNP Jul 26 12:15:01 volumio volumio[584]: info: Consume mode Jul 26 12:15:01 volumio volumio[584]: info: CoreCommandRouter::volumioGetState Jul 26 12:15:01 volumio volumio[584]: info: CorePlayQueue::getTrack 0 Jul 26 12:15:01 volumio volumio[584]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 26 12:15:01 volumio volumio[584]: TypeError: Cannot read property 'name' of undefined Jul 26 12:15:01 volumio volumio[584]: at CoreStateMachine.getState (/volumio/app/statemachine.js:122:48) Jul 26 12:15:01 volumio volumio[584]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:104:28) Jul 26 12:15:01 volumio volumio[584]: at UpnpInterface.prepareUpnpPlayback (/volumio/app/plugins/audio_interface/upnp/index.js:257:34) Jul 26 12:15:01 volumio volumio[584]: at Socket. (/volumio/app/plugins/audio_interface/upnp/index.js:44:14) Jul 26 12:15:01 volumio volumio[584]: at Socket.emit (events.js:400:28) Jul 26 12:15:01 volumio volumio[584]: at addChunk (internal/streams/readable.js:293:12) Jul 26 12:15:01 volumio volumio[584]: at readableAddChunk (internal/streams/readable.js:263:11) Jul 26 12:15:01 volumio volumio[584]: at Socket.Readable.push (internal/streams/readable.js:206:10) Jul 26 12:15:01 volumio volumio[584]: at TCP.onStreamRead (internal/stream_base_commons.js:188:23) Jul 26 12:15:01 volumio volumio[584]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 26 12:15:01 volumio sudo[28480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-26 12:14 Jul 26 12:15:01 volumio sudo[28480]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="9eadfb08439e8c37bef9a38c0641d736c1391e0c" VOLUMIO_FE_VERSION="e6f7875b0e497e33187ca2553d7998c4aeb06af9" VOLUMIO_FE3_VERSION="8d9f9503eeacae3e8f349def90b368b32462d83b" VOLUMIO_BE_VERSION="1cdccc4d006cc26abc6312edbeae58f3081200d4" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Feb 2022 07:32:58 PM CET" VOLUMIO_VERSION="3.233" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="9627ddf93d9d3caee1c6149151b31faa"