-- Logs begin at Sun 2025-11-02 13:51:43 UTC, end at Sun 2025-11-02 14:05:28 UTC. -- Nov 02 14:04:01 volumio volumio[958]: info: Nov 02 14:04:01 volumio volumio[958]: ---------------------------- MPD announces system playlist update Nov 02 14:04:01 volumio volumio[958]: info: Ignoring MPD Status Update Nov 02 14:04:01 volumio volumio[958]: info: Nov 02 14:04:01 volumio volumio[958]: ---------------------------- MPD announces state update: player Nov 02 14:04:01 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:04:01 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:04:01 volumio volumio[958]: info: ------------------------------ 14ms Nov 02 14:04:01 volumio volumio[958]: info: sendMpdCommand status took 13 milliseconds Nov 02 14:04:01 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:04:01 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:04:01 volumio volumio[958]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 02 14:04:01 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:04:01 volumio volumio[958]: info: ControllerMpd::pushState Nov 02 14:04:01 volumio volumio[958]: info: CoreCommandRouter::servicePushState Nov 02 14:04:01 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:04:01 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":601286,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Whitney Houston - I Wanna Dance With Somebody (Who Loves Me)","artist":"24-7 Legends","album":null,"uri":"http://82.145.63.122:4295/stream","trackType":""} Nov 02 14:04:01 volumio volumio[958]: verbose: CURRENT POSITION 0 Nov 02 14:04:01 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Nov 02 14:04:01 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Nov 02 14:04:01 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Nov 02 14:04:01 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 02 14:04:01 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:04:01 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:04:01 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:04:01 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:04:01 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:04:01 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:04:01 volumio volumio[958]: info: ------------------------------ 47ms Nov 02 14:05:03 volumio sudo[2960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 02 14:05:03 volumio sudo[2960]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 14:05:03 volumio sudo[2962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 02 14:05:03 volumio sudo[2960]: pam_unix(sudo:session): session closed for user root Nov 02 14:05:03 volumio sudo[2962]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 14:05:03 volumio sudo[2962]: pam_unix(sudo:session): session closed for user root Nov 02 14:05:03 volumio volumio[958]: info: CoreCommandRouter::volumioGetVisibleSources Nov 02 14:05:03 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 02 14:05:03 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Nov 02 14:05:03 volumio volumio[958]: info: CoreCommandRouter::volumioGetQueue Nov 02 14:05:03 volumio volumio[958]: info: CoreStateMachine::getQueue Nov 02 14:05:03 volumio volumio[958]: info: CorePlayQueue::getQueue Nov 02 14:05:03 volumio volumio[958]: info: Listing playlists Nov 02 14:05:03 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 02 14:05:03 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 02 14:05:03 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 02 14:05:03 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 02 14:05:03 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 02 14:05:06 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 02 14:05:06 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 02 14:05:07 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Nov 02 14:05:07 volumio volumio[958]: info: ControllerPersonalRadio::handleBrowseUri Nov 02 14:05:10 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Nov 02 14:05:10 volumio volumio[958]: info: ControllerPersonalRadio::handleBrowseUri Nov 02 14:05:12 volumio volumio[958]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::ClearQueue Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::stop Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 14:05:12 volumio volumio[958]: UNSET VOLATILE Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::stPlaybackTimer Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Nov 02 14:05:12 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:12 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:12 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:12 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::serviceStop Nov 02 14:05:12 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:12 volumio volumio[958]: info: CoreCommandRouter::serviceStop Nov 02 14:05:12 volumio volumio[958]: info: [1762092312498] ControllerWebradio::stop Nov 02 14:05:12 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 14:05:12 volumio volumio[958]: info: CorePlayQueue::clearPlayQueue Nov 02 14:05:12 volumio volumio[958]: info: CorePlayQueue::saveQueue Nov 02 14:05:12 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:12 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:12 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::addQueueItems Nov 02 14:05:12 volumio volumio[958]: info: CorePlayQueue::addQueueItems Nov 02 14:05:12 volumio volumio[958]: info: Adding Item to queue: weblinn/0 Nov 02 14:05:12 volumio volumio[958]: info: Exploding uri weblinn/0 in service personal_radio Nov 02 14:05:12 volumio volumio[958]: info: CorePlayQueue::saveQueue Nov 02 14:05:12 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Nov 02 14:05:12 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Nov 02 14:05:12 volumio volumio[958]: info: CoreCommandRouter::volumioPlay Nov 02 14:05:12 volumio volumio[958]: UNSET VOLATILE Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::play index 0 Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::stop Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 14:05:12 volumio volumio[958]: UNSET VOLATILE Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::play index undefined Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 14:05:12 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::startPlaybackTimer Nov 02 14:05:12 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:12 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 14:05:12 volumio volumio[958]: info: Nov 02 14:05:12 volumio volumio[958]: ---------------------------- MPD announces state update: player Nov 02 14:05:12 volumio volumio[958]: info: sendMpdCommand stop took 75 milliseconds Nov 02 14:05:12 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:05:12 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:05:12 volumio volumio[958]: info: sendMpdCommand stop took 28 milliseconds Nov 02 14:05:12 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand clear Nov 02 14:05:12 volumio volumio[958]: info: Nov 02 14:05:12 volumio volumio[958]: ---------------------------- MPD announces system playlist update Nov 02 14:05:12 volumio volumio[958]: info: Ignoring MPD Status Update Nov 02 14:05:12 volumio volumio[958]: info: sendMpdCommand status took 4 milliseconds Nov 02 14:05:12 volumio volumio[958]: info: sendMpdCommand clear took 3 milliseconds Nov 02 14:05:12 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:05:12 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:05:12 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand add "http://radio.linnrecords.com:8000/stream" Nov 02 14:05:12 volumio volumio[958]: error: updateQueue error: null Nov 02 14:05:12 volumio volumio[958]: info: Nov 02 14:05:12 volumio volumio[958]: ---------------------------- MPD announces system playlist update Nov 02 14:05:12 volumio volumio[958]: info: Ignoring MPD Status Update Nov 02 14:05:12 volumio volumio[958]: info: ------------------------------ 8ms Nov 02 14:05:12 volumio volumio[958]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 02 14:05:12 volumio volumio[958]: info: sendMpdCommand add "http://radio.linnrecords.com:8000/stream" took 5 milliseconds Nov 02 14:05:12 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:05:12 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand play Nov 02 14:05:12 volumio volumio[958]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 02 14:05:12 volumio volumio[958]: info: ------------------------------ 20ms Nov 02 14:05:12 volumio volumio[958]: info: ------------------------------ 10ms Nov 02 14:05:12 volumio volumio[958]: info: sendMpdCommand play took 3 milliseconds Nov 02 14:05:12 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 02 14:05:13 volumio volumio[958]: info: Nov 02 14:05:13 volumio volumio[958]: ---------------------------- MPD announces state update: player Nov 02 14:05:13 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:05:13 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:05:13 volumio volumio[958]: info: sendMpdCommand status took 9 milliseconds Nov 02 14:05:13 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:05:13 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:05:13 volumio volumio[958]: info: Nov 02 14:05:13 volumio volumio[958]: ---------------------------- MPD announces system playlist update Nov 02 14:05:13 volumio volumio[958]: info: Ignoring MPD Status Update Nov 02 14:05:13 volumio volumio[958]: info: Nov 02 14:05:13 volumio volumio[958]: ---------------------------- MPD announces state update: player Nov 02 14:05:13 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:05:13 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:05:13 volumio volumio[958]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 02 14:05:13 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:05:13 volumio volumio[958]: info: ControllerMpd::pushState Nov 02 14:05:13 volumio volumio[958]: info: CoreCommandRouter::servicePushState Nov 02 14:05:13 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:13 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tommy Smith - Journeys Home, Destination Unk","artist":"Linn Jazz","album":null,"uri":"http://radio.linnrecords.com:8000/stream","trackType":""} Nov 02 14:05:13 volumio volumio[958]: verbose: CURRENT POSITION 0 Nov 02 14:05:13 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Nov 02 14:05:13 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus stop Nov 02 14:05:13 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:13 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:13 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:13 volumio volumio[958]: info: ------------------------------ 36ms Nov 02 14:05:13 volumio volumio[958]: info: ------------------------------ 21ms Nov 02 14:05:13 volumio volumio[958]: info: sendMpdCommand status took 20 milliseconds Nov 02 14:05:13 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:05:13 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:05:13 volumio volumio[958]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 02 14:05:13 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:05:13 volumio volumio[958]: info: ControllerMpd::pushState Nov 02 14:05:13 volumio volumio[958]: info: CoreCommandRouter::servicePushState Nov 02 14:05:13 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:13 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":481,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Tommy Smith - Journeys Home, Destination Unk","artist":"Linn Jazz","album":null,"uri":"http://radio.linnrecords.com:8000/stream","trackType":""} Nov 02 14:05:13 volumio volumio[958]: verbose: CURRENT POSITION 0 Nov 02 14:05:13 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Nov 02 14:05:13 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Nov 02 14:05:13 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Nov 02 14:05:13 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:13 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:13 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:13 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:13 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:13 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:13 volumio volumio[958]: info: ------------------------------ 57ms Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::ClearQueue Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::stop Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 14:05:18 volumio volumio[958]: UNSET VOLATILE Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::stPlaybackTimer Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Nov 02 14:05:18 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:18 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::serviceStop Nov 02 14:05:18 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::serviceStop Nov 02 14:05:18 volumio volumio[958]: info: ControllerMpd::stop Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 14:05:18 volumio volumio[958]: info: CorePlayQueue::clearPlayQueue Nov 02 14:05:18 volumio volumio[958]: info: CorePlayQueue::saveQueue Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::addQueueItems Nov 02 14:05:18 volumio volumio[958]: info: CorePlayQueue::addQueueItems Nov 02 14:05:18 volumio volumio[958]: info: Adding Item to queue: weblinn/1 Nov 02 14:05:18 volumio volumio[958]: info: Exploding uri weblinn/1 in service personal_radio Nov 02 14:05:18 volumio volumio[958]: info: CorePlayQueue::saveQueue Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Nov 02 14:05:18 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::volumioPlay Nov 02 14:05:18 volumio volumio[958]: UNSET VOLATILE Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::play index 0 Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::stop Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 14:05:18 volumio volumio[958]: UNSET VOLATILE Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::play index undefined Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 14:05:18 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::startPlaybackTimer Nov 02 14:05:18 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 14:05:18 volumio volumio[958]: info: sendMpdCommand stop took 134 milliseconds Nov 02 14:05:18 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:05:18 volumio volumio[958]: info: Nov 02 14:05:18 volumio volumio[958]: ---------------------------- MPD announces state update: player Nov 02 14:05:18 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:05:18 volumio volumio[958]: info: sendMpdCommand stop took 92 milliseconds Nov 02 14:05:18 volumio volumio[958]: info: sendMpdCommand status took 3 milliseconds Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand clear Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:05:18 volumio volumio[958]: info: Nov 02 14:05:18 volumio volumio[958]: ---------------------------- MPD announces system playlist update Nov 02 14:05:18 volumio volumio[958]: info: Ignoring MPD Status Update Nov 02 14:05:18 volumio volumio[958]: info: sendMpdCommand status took 6 milliseconds Nov 02 14:05:18 volumio volumio[958]: info: sendMpdCommand clear took 5 milliseconds Nov 02 14:05:18 volumio volumio[958]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand add "http://radio.linnrecords.com:8003/stream" Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:05:18 volumio volumio[958]: error: updateQueue error: null Nov 02 14:05:18 volumio volumio[958]: info: Nov 02 14:05:18 volumio volumio[958]: ---------------------------- MPD announces system playlist update Nov 02 14:05:18 volumio volumio[958]: info: Ignoring MPD Status Update Nov 02 14:05:18 volumio volumio[958]: info: ------------------------------ 8ms Nov 02 14:05:18 volumio volumio[958]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 02 14:05:18 volumio volumio[958]: info: sendMpdCommand add "http://radio.linnrecords.com:8003/stream" took 5 milliseconds Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand play Nov 02 14:05:18 volumio volumio[958]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 02 14:05:18 volumio volumio[958]: info: ------------------------------ 23ms Nov 02 14:05:18 volumio volumio[958]: info: ------------------------------ 11ms Nov 02 14:05:18 volumio volumio[958]: info: sendMpdCommand play took 3 milliseconds Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 02 14:05:18 volumio volumio[958]: info: Nov 02 14:05:18 volumio volumio[958]: ---------------------------- MPD announces state update: player Nov 02 14:05:18 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:05:18 volumio volumio[958]: info: Nov 02 14:05:18 volumio volumio[958]: ---------------------------- MPD announces state update: player Nov 02 14:05:18 volumio volumio[958]: info: sendMpdCommand status took 6 milliseconds Nov 02 14:05:18 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:05:18 volumio volumio[958]: info: Nov 02 14:05:18 volumio volumio[958]: ---------------------------- MPD announces system playlist update Nov 02 14:05:18 volumio volumio[958]: info: Ignoring MPD Status Update Nov 02 14:05:18 volumio volumio[958]: info: sendMpdCommand status took 6 milliseconds Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:05:18 volumio volumio[958]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 02 14:05:18 volumio volumio[958]: info: ------------------------------ 7ms Nov 02 14:05:18 volumio volumio[958]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:05:18 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:05:18 volumio volumio[958]: info: ControllerMpd::pushState Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::servicePushState Nov 02 14:05:18 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:18 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Sir Willard White - Lazy Bones","artist":"Linn Radio","album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":""} Nov 02 14:05:18 volumio volumio[958]: verbose: CURRENT POSITION 0 Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus stop Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:18 volumio volumio[958]: info: ControllerMpd::pushState Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::servicePushState Nov 02 14:05:18 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:18 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Sir Willard White - Lazy Bones","artist":"Linn Radio","album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":""} Nov 02 14:05:18 volumio volumio[958]: verbose: CURRENT POSITION 0 Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Nov 02 14:05:18 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:18 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:18 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:18 volumio volumio[958]: info: ------------------------------ 54ms Nov 02 14:05:18 volumio volumio[958]: info: ------------------------------ 50ms Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::ClearQueue Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::stop Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 14:05:20 volumio volumio[958]: UNSET VOLATILE Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::stPlaybackTimer Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Nov 02 14:05:20 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:20 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::serviceStop Nov 02 14:05:20 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::serviceStop Nov 02 14:05:20 volumio volumio[958]: info: ControllerMpd::stop Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 14:05:20 volumio volumio[958]: info: CorePlayQueue::clearPlayQueue Nov 02 14:05:20 volumio volumio[958]: info: CorePlayQueue::saveQueue Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::addQueueItems Nov 02 14:05:20 volumio volumio[958]: info: CorePlayQueue::addQueueItems Nov 02 14:05:20 volumio volumio[958]: info: Adding Item to queue: weblinn/2 Nov 02 14:05:20 volumio volumio[958]: info: Exploding uri weblinn/2 in service personal_radio Nov 02 14:05:20 volumio volumio[958]: info: CorePlayQueue::saveQueue Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Nov 02 14:05:20 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::volumioPlay Nov 02 14:05:20 volumio volumio[958]: UNSET VOLATILE Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::play index 0 Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::stop Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 14:05:20 volumio volumio[958]: UNSET VOLATILE Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::play index undefined Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 14:05:20 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::startPlaybackTimer Nov 02 14:05:20 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 14:05:20 volumio volumio[958]: info: Nov 02 14:05:20 volumio volumio[958]: ---------------------------- MPD announces state update: player Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand stop took 61 milliseconds Nov 02 14:05:20 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand stop took 20 milliseconds Nov 02 14:05:20 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand clear Nov 02 14:05:20 volumio volumio[958]: info: Nov 02 14:05:20 volumio volumio[958]: ---------------------------- MPD announces system playlist update Nov 02 14:05:20 volumio volumio[958]: info: Ignoring MPD Status Update Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand status took 6 milliseconds Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand status took 5 milliseconds Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand clear took 5 milliseconds Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand add "http://radio.linnrecords.com:8004/stream" Nov 02 14:05:20 volumio volumio[958]: error: updateQueue error: null Nov 02 14:05:20 volumio volumio[958]: info: Nov 02 14:05:20 volumio volumio[958]: ---------------------------- MPD announces system playlist update Nov 02 14:05:20 volumio volumio[958]: info: Ignoring MPD Status Update Nov 02 14:05:20 volumio volumio[958]: info: ------------------------------ 11ms Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand add "http://radio.linnrecords.com:8004/stream" took 7 milliseconds Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand play Nov 02 14:05:20 volumio volumio[958]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 02 14:05:20 volumio volumio[958]: info: ------------------------------ 25ms Nov 02 14:05:20 volumio volumio[958]: info: ------------------------------ 17ms Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand play took 9 milliseconds Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 02 14:05:20 volumio volumio[958]: info: Nov 02 14:05:20 volumio volumio[958]: ---------------------------- MPD announces state update: player Nov 02 14:05:20 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:05:20 volumio volumio[958]: info: Nov 02 14:05:20 volumio volumio[958]: ---------------------------- MPD announces state update: player Nov 02 14:05:20 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:05:20 volumio volumio[958]: info: Nov 02 14:05:20 volumio volumio[958]: ---------------------------- MPD announces system playlist update Nov 02 14:05:20 volumio volumio[958]: info: Ignoring MPD Status Update Nov 02 14:05:20 volumio volumio[958]: info: Nov 02 14:05:20 volumio volumio[958]: ---------------------------- MPD announces state update: player Nov 02 14:05:20 volumio volumio[958]: info: Nov 02 14:05:20 volumio volumio[958]: ---------------------------- MPD announces system playlist update Nov 02 14:05:20 volumio volumio[958]: info: Ignoring MPD Status Update Nov 02 14:05:20 volumio volumio[958]: info: Nov 02 14:05:20 volumio volumio[958]: ---------------------------- MPD announces state update: player Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand status took 28 milliseconds Nov 02 14:05:20 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand status took 22 milliseconds Nov 02 14:05:20 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:05:20 volumio volumio[958]: info: ------------------------------ 27ms Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand status took 9 milliseconds Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:05:20 volumio volumio[958]: info: ------------------------------ 32ms Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand status took 13 milliseconds Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand playlistinfo took 13 milliseconds Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand playlistinfo took 13 milliseconds Nov 02 14:05:20 volumio volumio[958]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:05:20 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:05:20 volumio volumio[958]: info: ControllerMpd::pushState Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::servicePushState Nov 02 14:05:20 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:20 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":220,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Magnificat - Sicut lilium inter spinas","artist":"Linn Classical","album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Nov 02 14:05:20 volumio volumio[958]: verbose: CURRENT POSITION 0 Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus stop Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:20 volumio volumio[958]: info: ControllerMpd::pushState Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::servicePushState Nov 02 14:05:20 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:20 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Magnificat - Sicut lilium inter spinas","artist":"Linn Classical","album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Nov 02 14:05:20 volumio volumio[958]: verbose: CURRENT POSITION 0 Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Nov 02 14:05:20 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:20 volumio volumio[958]: info: ControllerMpd::pushState Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::servicePushState Nov 02 14:05:20 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:20 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Magnificat - Sicut lilium inter spinas","artist":"Linn Classical","album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Nov 02 14:05:20 volumio volumio[958]: verbose: CURRENT POSITION 0 Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Nov 02 14:05:20 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:20 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:20 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:20 volumio volumio[958]: info: ------------------------------ 149ms Nov 02 14:05:21 volumio volumio[958]: info: ------------------------------ 147ms Nov 02 14:05:21 volumio volumio[958]: info: ------------------------------ 137ms Nov 02 14:05:21 volumio volumio[958]: info: sendMpdCommand playlistinfo took 99 milliseconds Nov 02 14:05:21 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:05:21 volumio volumio[958]: info: ControllerMpd::pushState Nov 02 14:05:21 volumio volumio[958]: info: CoreCommandRouter::servicePushState Nov 02 14:05:21 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:21 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Magnificat - Sicut lilium inter spinas","artist":"Linn Classical","album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Nov 02 14:05:21 volumio volumio[958]: verbose: CURRENT POSITION 0 Nov 02 14:05:21 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Nov 02 14:05:21 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Nov 02 14:05:21 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Nov 02 14:05:21 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:21 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:21 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:21 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:21 volumio volumio[958]: info: ------------------------------ 166ms Nov 02 14:05:24 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Nov 02 14:05:24 volumio volumio[958]: info: ControllerPersonalRadio::handleBrowseUri Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::ClearQueue Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::stop Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 14:05:26 volumio volumio[958]: UNSET VOLATILE Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::stPlaybackTimer Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Nov 02 14:05:26 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:26 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::serviceStop Nov 02 14:05:26 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::serviceStop Nov 02 14:05:26 volumio volumio[958]: info: ControllerMpd::stop Nov 02 14:05:26 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 14:05:26 volumio volumio[958]: info: CorePlayQueue::clearPlayQueue Nov 02 14:05:26 volumio volumio[958]: info: CorePlayQueue::saveQueue Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::addQueueItems Nov 02 14:05:26 volumio volumio[958]: info: CorePlayQueue::addQueueItems Nov 02 14:05:26 volumio volumio[958]: info: Adding Item to queue: webmbc/0 Nov 02 14:05:26 volumio volumio[958]: info: Exploding uri webmbc/0 in service personal_radio Nov 02 14:05:26 volumio volumio[958]: info: Nov 02 14:05:26 volumio volumio[958]: ---------------------------- MPD announces state update: player Nov 02 14:05:26 volumio volumio[958]: info: sendMpdCommand stop took 118 milliseconds Nov 02 14:05:26 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:05:26 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:05:26 volumio volumio[958]: info: ControllerMpd::getState Nov 02 14:05:26 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Nov 02 14:05:26 volumio volumio[958]: info: sendMpdCommand status took 3 milliseconds Nov 02 14:05:26 volumio volumio[958]: info: sendMpdCommand status took 2 milliseconds Nov 02 14:05:26 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:05:26 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:05:26 volumio volumio[958]: verbose: ControllerMpd::parseState Nov 02 14:05:26 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 14:05:26 volumio volumio[958]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 14:05:26 volumio volumio[958]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 14:05:26 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:05:26 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Nov 02 14:05:26 volumio volumio[958]: info: ControllerMpd::pushState Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::servicePushState Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:26 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:26 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:26 volumio volumio[958]: 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":"Magnificat - Sicut lilium inter spinas","artist":"Linn Classical","album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Nov 02 14:05:26 volumio volumio[958]: verbose: CURRENT POSITION 0 Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::syncState stateService stop Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus stop Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:26 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:26 volumio volumio[958]: info: No code Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:26 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:26 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:26 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:26 volumio volumio[958]: 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":"Magnificat - Sicut lilium inter spinas","artist":"Linn Classical","album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":""} Nov 02 14:05:26 volumio volumio[958]: verbose: CURRENT POSITION 0 Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::syncState stateService stop Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus stop Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:26 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:26 volumio volumio[958]: info: No code Nov 02 14:05:26 volumio volumio[958]: info: CoreStateMachine::pushState Nov 02 14:05:26 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Nov 02 14:05:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 14:05:26 volumio volumio[958]: info: ------------------------------ 62ms Nov 02 14:05:27 volumio volumio[958]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 14:05:27 volumio volumio[958]: TypeError: Cannot read property 'replace' of undefined Nov 02 14:05:27 volumio volumio[958]: at /data/plugins/music_service/personal_radio/index.js:499:45 Nov 02 14:05:27 volumio volumio[958]: at Request.handleRequestResponse [as _callback] (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:463:26) Nov 02 14:05:27 volumio volumio[958]: at Request.self.callback (/data/plugins/music_service/personal_radio/node_modules/request/request.js:187:22) Nov 02 14:05:27 volumio volumio[958]: at emitTwo (events.js:126:13) Nov 02 14:05:27 volumio volumio[958]: at Request.emit (events.js:214:7) Nov 02 14:05:27 volumio volumio[958]: at Request. (/data/plugins/music_service/personal_radio/node_modules/request/request.js:1044:10) Nov 02 14:05:27 volumio volumio[958]: at emitOne (events.js:116:13) Nov 02 14:05:27 volumio volumio[958]: at Request.emit (events.js:211:7) Nov 02 14:05:27 volumio volumio[958]: at IncomingMessage. (/data/plugins/music_service/personal_radio/node_modules/request/request.js:965:12) Nov 02 14:05:27 volumio volumio[958]: at emitNone (events.js:111:20) Nov 02 14:05:27 volumio volumio[958]: at IncomingMessage.emit (events.js:208:7) Nov 02 14:05:27 volumio volumio[958]: at endReadableNT (_stream_readable.js:1064:12) Nov 02 14:05:27 volumio volumio[958]: at _combinedTickCallback (internal/process/next_tick.js:138:11) Nov 02 14:05:27 volumio volumio[958]: at process._tickCallback (internal/process/next_tick.js:180:9) Nov 02 14:05:27 volumio volumio[958]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 14:05:28 volumio sudo[3029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-02 14:04 Nov 02 14:05:28 volumio sudo[3029]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="e81b2037a65d8f554cb0c857a1007d659ad7f838" VOLUMIO_FE_VERSION="e489037accd8e0b2dcbd6e0b054400d8cd36d4e2" VOLUMIO_BE_VERSION="25875b197c75cd1ac7eb5664d94cdd19afb06985" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Feb 19 17:57:53 CET 2021" VOLUMIO_VERSION="2.873" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="aa20cea461a8f0bd689fe0d5d2a83194"