-- Logs begin at Fri 2024-11-01 04:19:59 UTC, end at Fri 2024-11-01 04:40:36 UTC. -- Nov 01 04:39:01 volumio volumio[920]: info: Nov 01 04:39:01 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:01 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:01 volumio volumio[920]: info: Nov 01 04:39:01 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:01 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:01 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:01 volumio volumio[920]: info: sending command... Nov 01 04:39:01 volumio volumio[920]: info: ------------------------------ 10ms Nov 01 04:39:01 volumio volumio[920]: info: parsing response... Nov 01 04:39:01 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:01 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:01 volumio volumio[920]: info: sending command... Nov 01 04:39:01 volumio volumio[920]: info: parsing response... Nov 01 04:39:01 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:01 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:01 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:01 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:01 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:39:01 volumio volumio[920]: info: STATE SERVICE {"status":"play","position":0,"seek":813052,"duration":0,"samplerate":"44.1 KHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"GURU JOSH PROJECT - INFINITY 2008 (KLAAS VOCAL EDIT))","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":"de/absolut-ai/stream/mp3"} Nov 01 04:39:01 volumio volumio[920]: info: CURRENT POSITION 0 Nov 01 04:39:01 volumio volumio[920]: info: CoreStateMachine::syncState stateService play Nov 01 04:39:01 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus play Nov 01 04:39:01 volumio volumio[920]: info: Received an update from plaugin. extracting info from payload Nov 01 04:39:01 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:01 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:01 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:01 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:01 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:01 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:01 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:01 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:01 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:01 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:01 volumio volumio[920]: info: ------------------------------ 93ms Nov 01 04:39:01 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","favourite":false} Nov 01 04:39:01 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","favourite":false} Nov 01 04:39:04 volumio volumio[920]: info: CoreCommandRouter::volumioGetState Nov 01 04:39:04 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:05 volumio volumio[920]: info: CoreCommandRouter::volumioGetBrowseSources Nov 01 04:39:05 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 01 04:39:05 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 01 04:39:05 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 01 04:39:05 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 01 04:39:05 volumio volumio[920]: Plugin multiroom or method getMultiroom not found Nov 01 04:39:05 volumio volumio[920]: info: Listing playlists Nov 01 04:39:07 volumio volumio[920]: info: Reading package lists... Nov 01 04:39:07 volumio volumio[920]: info: CoreCommandRouter::volumioGetQueue Nov 01 04:39:07 volumio volumio[920]: info: CoreStateMachine::getQueue Nov 01 04:39:07 volumio volumio[920]: info: CorePlayQueue::getQueue Nov 01 04:39:07 volumio volumio[920]: info: No input data Nov 01 04:39:07 volumio volumio[920]: info: No input data Nov 01 04:39:07 volumio volumio[920]: info: No input data Nov 01 04:39:07 volumio volumio[920]: info: No input data Nov 01 04:39:08 volumio volumio[920]: info: Building dependency tree... Nov 01 04:39:08 volumio volumio[920]: info: Reading state information... Nov 01 04:39:08 volumio volumio[920]: info: The following package was automatically installed and is no longer required: Nov 01 04:39:08 volumio volumio[920]: info: libpci3 Nov 01 04:39:08 volumio volumio[920]: info: Use 'apt-get autoremove' to remove it. Nov 01 04:39:08 volumio volumio[920]: info: The following extra packages will be installed: Nov 01 04:39:08 volumio volumio[920]: info: libexif12 Nov 01 04:39:08 volumio volumio[920]: info: The following NEW packages will be installed: Nov 01 04:39:08 volumio volumio[920]: info: libexif12 minidlna Nov 01 04:39:09 volumio volumio[920]: info: 0 upgraded, 2 newly installed, 0 to remove and 59 not upgraded. Nov 01 04:39:09 volumio volumio[920]: info: Need to get 466 kB of archives. Nov 01 04:39:09 volumio volumio[920]: info: After this operation, 2,497 kB of additional disk space will be used. Nov 01 04:39:09 volumio volumio[920]: info: WARNING: The following packages cannot be authenticated! Nov 01 04:39:09 volumio volumio[920]: info: libexif12 minidlna Nov 01 04:39:09 volumio sudo[8760]: pam_unix(sudo:session): session closed for user root Nov 01 04:39:09 volumio sudo[8862]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /etc/minidlna.conf Nov 01 04:39:09 volumio sudo[8862]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 04:39:09 volumio sudo[8862]: pam_unix(sudo:session): session closed for user root Nov 01 04:39:09 volumio volumio[920]: info: Creating systemd unit /etc/systemd/system/minidlna.service Nov 01 04:39:09 volumio sudo[8871]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/install -D -m u=rw,go=r /data/plugins/miscellanea/minidlna/minidlna.service /etc/systemd/system/minidlna.service Nov 01 04:39:09 volumio sudo[8871]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 04:39:09 volumio sudo[8871]: pam_unix(sudo:session): session closed for user root Nov 01 04:39:09 volumio sudo[8873]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Nov 01 04:39:09 volumio sudo[8873]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 04:39:09 volumio systemd[1]: Reloading. Nov 01 04:39:10 volumio systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Nov 01 04:39:10 volumio systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Nov 01 04:39:10 volumio systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Nov 01 04:39:10 volumio systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Nov 01 04:39:11 volumio systemd[1]: Configuration file /lib/systemd/system/spop.service is marked executable. Please remove executable permission bits. Proceeding anyway. Nov 01 04:39:11 volumio sudo[8873]: pam_unix(sudo:session): session closed for user root Nov 01 04:39:11 volumio volumio[920]: info: Setting values for "network_interface" and "model_number" in /data/plugins/miscellanea/minidlna/config.json Nov 01 04:39:11 volumio volumio[920]: info: Setting permissions to miniDLNA folders Nov 01 04:39:11 volumio sudo[8906]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown -R volumio:volumio /var/cache/minidlna/ Nov 01 04:39:11 volumio sudo[8906]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 04:39:11 volumio sudo[8906]: pam_unix(sudo:session): session closed for user root Nov 01 04:39:11 volumio volumio[920]: Plugin install end detected on script Nov 01 04:39:11 volumio sudo[8654]: pam_unix(sudo:session): session closed for user root Nov 01 04:39:11 volumio volumio[920]: info: Install script completed Nov 01 04:39:11 volumio volumio[920]: info: Adding reference to registry Nov 01 04:39:11 volumio volumio[920]: info: Done installing plugin. Nov 01 04:39:11 volumio volumio[920]: info: Folder /tmp/plugins removed Nov 01 04:39:11 volumio volumio[920]: info: Folder /tmp/downloaded_plugin.zip removed Nov 01 04:39:11 volumio volumio[920]: info: Folder /data/temp removed Nov 01 04:39:16 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Nov 01 04:39:16 volumio volumio[920]: info: ControllerPersonalRadio::handleBrowseUri Nov 01 04:39:20 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Nov 01 04:39:20 volumio volumio[920]: info: ControllerPersonalRadio::handleBrowseUri Nov 01 04:39:22 volumio volumio[920]: info: CoreCommandRouter::volumioAddQueueItems Nov 01 04:39:22 volumio volumio[920]: info: CoreStateMachine::addQueueItems Nov 01 04:39:22 volumio volumio[920]: info: CorePlayQueue::addQueueItems Nov 01 04:39:22 volumio volumio[920]: info: Adding Item to queue: weblinn/1 Nov 01 04:39:22 volumio volumio[920]: info: Exploding uri weblinn/1 in service personal_radio Nov 01 04:39:22 volumio volumio[920]: info: CorePlayQueue::saveQueue Nov 01 04:39:22 volumio volumio[920]: info: CoreCommandRouter::volumioPushQueue Nov 01 04:39:22 volumio volumio[920]: info: interfaceApi::pushQueue Nov 01 04:39:22 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:39:22 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:39:22 volumio volumio[920]: info: CoreCommandRouter::volumioPlay Nov 01 04:39:22 volumio volumio[920]: UNSET VOLATILE Nov 01 04:39:22 volumio volumio[920]: info: CoreStateMachine::play index 1 Nov 01 04:39:22 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:39:22 volumio volumio[920]: info: CoreStateMachine::stop Nov 01 04:39:22 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:39:22 volumio volumio[920]: UNSET VOLATILE Nov 01 04:39:22 volumio volumio[920]: info: CoreStateMachine::stPlaybackTimer Nov 01 04:39:22 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:39:22 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:39:22 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:22 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:22 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:39:22 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:22 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:22 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:22 volumio volumio[920]: info: CoreStateMachine::serviceStop Nov 01 04:39:22 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:39:22 volumio volumio[920]: info: CoreCommandRouter::serviceStop Nov 01 04:39:22 volumio volumio[920]: info: [1730435962399] ControllerWebradio::stop Nov 01 04:39:22 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:39:22 volumio volumio[920]: info: sending command... Nov 01 04:39:22 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","favourite":false} Nov 01 04:39:24 volumio volumio[920]: info: parsing response... Nov 01 04:39:24 volumio volumio[920]: info: CoreStateMachine::play index undefined Nov 01 04:39:24 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:39:24 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:24 volumio volumio[920]: info: CoreStateMachine::startPlaybackTimer Nov 01 04:39:24 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:24 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:39:24 volumio volumio[920]: info: sending command... Nov 01 04:39:24 volumio volumio[920]: info: Nov 01 04:39:24 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:24 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:24 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:24 volumio volumio[920]: info: sending command... Nov 01 04:39:24 volumio volumio[920]: info: parsing response... Nov 01 04:39:24 volumio volumio[920]: info: parsing response... Nov 01 04:39:24 volumio volumio[920]: info: ControllerMpd::sendMpdCommand clear Nov 01 04:39:24 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:24 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:24 volumio volumio[920]: info: sending command... Nov 01 04:39:24 volumio volumio[920]: info: sending command... Nov 01 04:39:24 volumio volumio[920]: info: Nov 01 04:39:24 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:24 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:24 volumio volumio[920]: info: parsing response... Nov 01 04:39:24 volumio volumio[920]: info: parsing response... Nov 01 04:39:24 volumio volumio[920]: info: ControllerMpd::sendMpdCommand add "http://radio.linnrecords.com:8003/stream" Nov 01 04:39:24 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:24 volumio volumio[920]: info: sending command... Nov 01 04:39:24 volumio volumio[920]: info: ControllerMpd::pushError Nov 01 04:39:24 volumio volumio[920]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined Nov 01 04:39:24 volumio volumio[920]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:290:54) Nov 01 04:39:24 volumio volumio[920]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Nov 01 04:39:24 volumio volumio[920]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Nov 01 04:39:24 volumio volumio[920]: at process._tickCallback (internal/process/next_tick.js:180:9) Nov 01 04:39:24 volumio volumio[920]: info: ------------------------------ 268ms Nov 01 04:39:24 volumio volumio[920]: info: Nov 01 04:39:24 volumio volumio[920]: info: Nov 01 04:39:24 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:24 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:24 volumio volumio[920]: info: ------------------------------ 262ms Nov 01 04:39:24 volumio volumio[920]: info: parsing response... Nov 01 04:39:24 volumio volumio[920]: info: ControllerMpd::sendMpdCommand play Nov 01 04:39:24 volumio volumio[920]: info: sending command... Nov 01 04:39:24 volumio volumio[920]: info: ------------------------------ 11ms Nov 01 04:39:24 volumio volumio[920]: info: parsing response... Nov 01 04:39:24 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 01 04:39:27 volumio volumio[920]: info: Nov 01 04:39:27 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:27 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:27 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:27 volumio volumio[920]: info: sending command... Nov 01 04:39:27 volumio volumio[920]: info: parsing response... Nov 01 04:39:27 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:27 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:27 volumio volumio[920]: info: sending command... Nov 01 04:39:27 volumio volumio[920]: info: Nov 01 04:39:27 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:27 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:27 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:27 volumio volumio[920]: info: sending command... Nov 01 04:39:27 volumio volumio[920]: info: Nov 01 04:39:27 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:27 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:27 volumio volumio[920]: info: Nov 01 04:39:27 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:27 volumio volumio[920]: info: parsing response... Nov 01 04:39:27 volumio volumio[920]: info: parsing response... Nov 01 04:39:27 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:27 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:27 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:27 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:27 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:27 volumio volumio[920]: info: sending command... Nov 01 04:39:27 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:27 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:27 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:27 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:27 volumio volumio[920]: info: 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,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":"com:8003/stream"} Nov 01 04:39:27 volumio volumio[920]: info: CURRENT POSITION 1 Nov 01 04:39:27 volumio volumio[920]: info: CoreStateMachine::syncState stateService play Nov 01 04:39:27 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus stop Nov 01 04:39:27 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:27 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:27 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:27 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:27 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:27 volumio volumio[920]: info: sending command... Nov 01 04:39:27 volumio volumio[920]: info: ------------------------------ 133ms Nov 01 04:39:27 volumio volumio[920]: info: Nov 01 04:39:28 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:28 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:28 volumio volumio[920]: info: Nov 01 04:39:28 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:28 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:28 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:28 volumio volumio[920]: info: ------------------------------ 98ms Nov 01 04:39:28 volumio volumio[920]: info: parsing response... Nov 01 04:39:28 volumio volumio[920]: info: parsing response... Nov 01 04:39:28 volumio volumio[920]: info: sending command... Nov 01 04:39:28 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:28 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:28 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:28 volumio volumio[920]: info: sending command... Nov 01 04:39:28 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:28 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:28 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:28 volumio volumio[920]: info: 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,"isStreaming":false,"title":"William Jackson - Brian Boru's March","artist":"Linn Radio","album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":"com:8003/stream"} Nov 01 04:39:28 volumio volumio[920]: info: CURRENT POSITION 1 Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::syncState stateService play Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus play Nov 01 04:39:28 volumio volumio[920]: info: Received an update from plaugin. extracting info from payload Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:28 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:28 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:28 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:28 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:28 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:28 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:28 volumio volumio[920]: info: ------------------------------ 168ms Nov 01 04:39:28 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","favourite":false} Nov 01 04:39:28 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:28 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:28 volumio volumio[920]: info: ------------------------------ 263ms Nov 01 04:39:28 volumio volumio[920]: info: parsing response... Nov 01 04:39:28 volumio volumio[920]: info: parsing response... Nov 01 04:39:28 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:28 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:28 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:28 volumio volumio[920]: info: sending command... Nov 01 04:39:28 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:28 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:28 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:28 volumio volumio[920]: info: STATE SERVICE {"status":"play","position":0,"seek":174,"duration":0,"samplerate":"44.1 KHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"William Jackson - Brian Boru's March","artist":"Linn Radio","album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":"com:8003/stream"} Nov 01 04:39:28 volumio volumio[920]: info: CURRENT POSITION 1 Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::syncState stateService play Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus play Nov 01 04:39:28 volumio volumio[920]: info: Received an update from plaugin. extracting info from payload Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:28 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:28 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:28 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:28 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:28 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:28 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:28 volumio volumio[920]: info: ------------------------------ 404ms Nov 01 04:39:28 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:28 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:28 volumio volumio[920]: info: parsing response... Nov 01 04:39:28 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:28 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:28 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:28 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:28 volumio volumio[920]: info: STATE SERVICE {"status":"play","position":0,"seek":267,"duration":0,"samplerate":"44.1 KHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"William Jackson - Brian Boru's March","artist":"Linn Radio","album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":"com:8003/stream"} Nov 01 04:39:28 volumio volumio[920]: info: CURRENT POSITION 1 Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::syncState stateService play Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus play Nov 01 04:39:28 volumio volumio[920]: info: Received an update from plaugin. extracting info from payload Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:28 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:28 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:28 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:28 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:28 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:28 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:28 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:28 volumio volumio[920]: info: ------------------------------ 484ms Nov 01 04:39:28 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:28 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:29 volumio volumio[920]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::ClearQueue Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::stop Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:39:29 volumio volumio[920]: UNSET VOLATILE Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::stPlaybackTimer Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:39:29 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:29 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:29 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:29 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:29 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::serviceStop Nov 01 04:39:29 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:29 volumio volumio[920]: info: CoreCommandRouter::serviceStop Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::stop Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:39:29 volumio volumio[920]: info: CorePlayQueue::clearPlayQueue Nov 01 04:39:29 volumio volumio[920]: info: CorePlayQueue::saveQueue Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::pushEmptyState Nov 01 04:39:29 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:29 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:29 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:29 volumio volumio[920]: info: CoreCommandRouter::volumioPushQueue Nov 01 04:39:29 volumio volumio[920]: info: interfaceApi::pushQueue Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::addQueueItems Nov 01 04:39:29 volumio volumio[920]: info: CorePlayQueue::addQueueItems Nov 01 04:39:29 volumio volumio[920]: info: Adding Item to queue: weblinn/1 Nov 01 04:39:29 volumio volumio[920]: info: Exploding uri weblinn/1 in service personal_radio Nov 01 04:39:29 volumio volumio[920]: info: sending command... Nov 01 04:39:29 volumio volumio[920]: info: CorePlayQueue::saveQueue Nov 01 04:39:29 volumio volumio[920]: info: CoreCommandRouter::volumioPushQueue Nov 01 04:39:29 volumio volumio[920]: info: interfaceApi::pushQueue Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:39:29 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:39:29 volumio volumio[920]: info: CoreCommandRouter::volumioPlay Nov 01 04:39:29 volumio volumio[920]: UNSET VOLATILE Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::play index 0 Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::stop Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:39:29 volumio volumio[920]: UNSET VOLATILE Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::play index undefined Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:39:29 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::startPlaybackTimer Nov 01 04:39:29 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:39:29 volumio volumio[920]: info: sending command... Nov 01 04:39:29 volumio volumio[920]: info: Pushing Favourites {"service":"personal_radio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:29 volumio volumio[920]: info: Pushing Favourites {"service":"mpd","uri":"","favourite":false} Nov 01 04:39:29 volumio volumio[920]: info: Nov 01 04:39:29 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:29 volumio volumio[920]: info: parsing response... Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:29 volumio volumio[920]: info: parsing response... Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:29 volumio volumio[920]: info: sending command... Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::sendMpdCommand clear Nov 01 04:39:29 volumio volumio[920]: info: sending command... Nov 01 04:39:29 volumio volumio[920]: info: sending command... Nov 01 04:39:29 volumio volumio[920]: info: Nov 01 04:39:29 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:29 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:29 volumio volumio[920]: info: parsing response... Nov 01 04:39:29 volumio volumio[920]: info: parsing response... Nov 01 04:39:29 volumio volumio[920]: info: parsing response... Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::sendMpdCommand add "http://radio.linnrecords.com:8003/stream" Nov 01 04:39:29 volumio volumio[920]: info: sending command... Nov 01 04:39:29 volumio volumio[920]: info: sending command... Nov 01 04:39:29 volumio volumio[920]: info: sending command... Nov 01 04:39:29 volumio volumio[920]: info: Nov 01 04:39:29 volumio volumio[920]: info: Nov 01 04:39:29 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:29 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:29 volumio volumio[920]: info: ------------------------------ 9ms Nov 01 04:39:29 volumio volumio[920]: info: parsing response... Nov 01 04:39:29 volumio volumio[920]: info: parsing response... Nov 01 04:39:29 volumio volumio[920]: info: parsing response... Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::sendMpdCommand play Nov 01 04:39:29 volumio volumio[920]: info: ControllerMpd::pushError Nov 01 04:39:29 volumio volumio[920]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined Nov 01 04:39:29 volumio volumio[920]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:290:54) Nov 01 04:39:29 volumio volumio[920]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Nov 01 04:39:29 volumio volumio[920]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Nov 01 04:39:29 volumio volumio[920]: at process._tickCallback (internal/process/next_tick.js:180:9) Nov 01 04:39:29 volumio volumio[920]: info: sending command... Nov 01 04:39:29 volumio volumio[920]: info: ------------------------------ 33ms Nov 01 04:39:29 volumio volumio[920]: info: ------------------------------ 10ms Nov 01 04:39:29 volumio volumio[920]: info: parsing response... Nov 01 04:39:29 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 01 04:39:34 volumio volumio[920]: info: Nov 01 04:39:34 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:34 volumio volumio[920]: info: sending command... Nov 01 04:39:34 volumio volumio[920]: info: Nov 01 04:39:34 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:34 volumio volumio[920]: info: parsing response... Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:34 volumio volumio[920]: info: sending command... Nov 01 04:39:34 volumio volumio[920]: info: sending command... Nov 01 04:39:34 volumio volumio[920]: info: Nov 01 04:39:34 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:34 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:34 volumio volumio[920]: info: Nov 01 04:39:34 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:34 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:34 volumio volumio[920]: info: Nov 01 04:39:34 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:34 volumio volumio[920]: info: parsing response... Nov 01 04:39:34 volumio volumio[920]: info: parsing response... Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:34 volumio volumio[920]: info: sending command... Nov 01 04:39:34 volumio volumio[920]: info: sending command... Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:34 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:34 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:39:34 volumio volumio[920]: info: 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,"isStreaming":false,"title":"stream","artist":"Linn Radio","album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":"com:8003/stream"} Nov 01 04:39:34 volumio volumio[920]: info: CURRENT POSITION 0 Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::syncState stateService play Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus stop Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:34 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:34 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:34 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:34 volumio volumio[920]: info: ------------------------------ 50ms Nov 01 04:39:34 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:34 volumio volumio[920]: info: ------------------------------ 46ms Nov 01 04:39:34 volumio volumio[920]: info: ------------------------------ 49ms Nov 01 04:39:34 volumio volumio[920]: info: parsing response... Nov 01 04:39:34 volumio volumio[920]: info: parsing response... Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:34 volumio volumio[920]: info: sending command... Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:34 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:34 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:39:34 volumio volumio[920]: info: 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,"isStreaming":false,"title":"William Jackson - Brian Boru's March","artist":"Linn Radio","album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":"com:8003/stream"} Nov 01 04:39:34 volumio volumio[920]: info: CURRENT POSITION 0 Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::syncState stateService play Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus play Nov 01 04:39:34 volumio volumio[920]: info: Received an update from plaugin. extracting info from payload Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:34 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:34 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:34 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:34 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:34 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:34 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:34 volumio volumio[920]: info: ------------------------------ 102ms Nov 01 04:39:34 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:34 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:34 volumio volumio[920]: info: parsing response... Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:34 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:34 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:34 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:39:34 volumio volumio[920]: info: STATE SERVICE {"status":"play","position":0,"seek":174,"duration":0,"samplerate":"44.1 KHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"William Jackson - Brian Boru's March","artist":"Linn Radio","album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":"com:8003/stream"} Nov 01 04:39:34 volumio volumio[920]: info: CURRENT POSITION 0 Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::syncState stateService play Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus play Nov 01 04:39:34 volumio volumio[920]: info: Received an update from plaugin. extracting info from payload Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:34 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:34 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:34 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:34 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:34 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:34 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:34 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:34 volumio volumio[920]: info: ------------------------------ 160ms Nov 01 04:39:34 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:34 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:38 volumio volumio[920]: info: CoreCommandRouter::volumioAddQueueItems Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::addQueueItems Nov 01 04:39:38 volumio volumio[920]: info: CorePlayQueue::addQueueItems Nov 01 04:39:38 volumio volumio[920]: info: Adding Item to queue: weblinn/0 Nov 01 04:39:38 volumio volumio[920]: info: Exploding uri weblinn/0 in service personal_radio Nov 01 04:39:38 volumio volumio[920]: info: CorePlayQueue::saveQueue Nov 01 04:39:38 volumio volumio[920]: info: CoreCommandRouter::volumioPushQueue Nov 01 04:39:38 volumio volumio[920]: info: interfaceApi::pushQueue Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:39:38 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:39:38 volumio volumio[920]: info: CoreCommandRouter::volumioPlay Nov 01 04:39:38 volumio volumio[920]: UNSET VOLATILE Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::play index 1 Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::stop Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:39:38 volumio volumio[920]: UNSET VOLATILE Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::stPlaybackTimer Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:39:38 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:38 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:39:38 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:38 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:38 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::serviceStop Nov 01 04:39:38 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:39:38 volumio volumio[920]: info: CoreCommandRouter::serviceStop Nov 01 04:39:38 volumio volumio[920]: info: ControllerMpd::stop Nov 01 04:39:38 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:39:38 volumio volumio[920]: info: sending command... Nov 01 04:39:38 volumio volumio[920]: info: Pushing Favourites {"service":"personal_radio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:38 volumio volumio[920]: info: Nov 01 04:39:38 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:38 volumio volumio[920]: info: parsing response... Nov 01 04:39:38 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:38 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:38 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:38 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:38 volumio volumio[920]: info: sending command... Nov 01 04:39:38 volumio volumio[920]: info: sending command... Nov 01 04:39:38 volumio volumio[920]: info: parsing response... Nov 01 04:39:38 volumio volumio[920]: info: parsing response... Nov 01 04:39:38 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:38 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:38 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:38 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:38 volumio volumio[920]: info: sending command... Nov 01 04:39:38 volumio volumio[920]: info: sending command... Nov 01 04:39:38 volumio volumio[920]: info: parsing response... Nov 01 04:39:38 volumio volumio[920]: info: parsing response... Nov 01 04:39:38 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:38 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:38 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:38 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:38 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:39:38 volumio volumio[920]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current personal_radio Received mpd Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:38 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:39:38 volumio volumio[920]: info: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"William Jackson - Brian Boru's March","artist":"Linn Radio","album":null,"uri":"http://radio.linnrecords.com:8003/stream","trackType":"com:8003/stream"} Nov 01 04:39:38 volumio volumio[920]: info: CURRENT POSITION 0 Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::syncState stateService stop Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus stop Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:38 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:39:38 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:38 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:38 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:38 volumio volumio[920]: info: No code Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:38 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:39:38 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:38 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:38 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:38 volumio volumio[920]: info: ------------------------------ 63ms Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::play index undefined Nov 01 04:39:38 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:39:39 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:39 volumio volumio[920]: info: CoreStateMachine::startPlaybackTimer Nov 01 04:39:39 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:39 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:39:39 volumio volumio[920]: info: sending command... Nov 01 04:39:39 volumio volumio[920]: info: Pushing Favourites {"service":"personal_radio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:39 volumio volumio[920]: info: Pushing Favourites {"service":"personal_radio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:39 volumio volumio[920]: info: parsing response... Nov 01 04:39:39 volumio volumio[920]: info: ControllerMpd::sendMpdCommand clear Nov 01 04:39:39 volumio volumio[920]: info: sending command... Nov 01 04:39:39 volumio volumio[920]: info: Nov 01 04:39:39 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:39 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:39 volumio volumio[920]: info: parsing response... Nov 01 04:39:39 volumio volumio[920]: info: ControllerMpd::sendMpdCommand add "http://radio.linnrecords.com:8000/stream" Nov 01 04:39:39 volumio volumio[920]: info: sending command... Nov 01 04:39:39 volumio volumio[920]: info: Nov 01 04:39:39 volumio volumio[920]: info: Nov 01 04:39:39 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:39 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:39 volumio volumio[920]: info: ------------------------------ 12ms Nov 01 04:39:39 volumio volumio[920]: info: parsing response... Nov 01 04:39:39 volumio volumio[920]: info: ControllerMpd::sendMpdCommand play Nov 01 04:39:39 volumio volumio[920]: info: sending command... Nov 01 04:39:39 volumio volumio[920]: info: ------------------------------ 15ms Nov 01 04:39:39 volumio volumio[920]: info: parsing response... Nov 01 04:39:39 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 01 04:39:41 volumio volumio[920]: info: Nov 01 04:39:41 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:41 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:41 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:41 volumio volumio[920]: info: sending command... Nov 01 04:39:41 volumio volumio[920]: info: Nov 01 04:39:41 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:41 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:41 volumio volumio[920]: info: Nov 01 04:39:41 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:41 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:41 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:41 volumio volumio[920]: info: parsing response... Nov 01 04:39:41 volumio volumio[920]: info: sending command... Nov 01 04:39:41 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:41 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:41 volumio volumio[920]: info: sending command... Nov 01 04:39:41 volumio volumio[920]: info: ------------------------------ 5ms Nov 01 04:39:41 volumio volumio[920]: info: parsing response... Nov 01 04:39:41 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:41 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:41 volumio volumio[920]: info: sending command... Nov 01 04:39:41 volumio volumio[920]: info: Nov 01 04:39:41 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:41 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:41 volumio volumio[920]: info: Nov 01 04:39:41 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:41 volumio volumio[920]: info: parsing response... Nov 01 04:39:41 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:41 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:42 volumio volumio[920]: info: parsing response... Nov 01 04:39:42 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:42 volumio volumio[920]: info: sending command... Nov 01 04:39:42 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:42 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:42 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:42 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:42 volumio volumio[920]: info: 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,"isStreaming":false,"title":"stream","artist":"Linn Jazz","album":null,"uri":"http://radio.linnrecords.com:8000/stream","trackType":"com:8000/stream"} Nov 01 04:39:42 volumio volumio[920]: info: CURRENT POSITION 1 Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::syncState stateService play Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus stop Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:42 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:42 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:42 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:42 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:42 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:42 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:42 volumio volumio[920]: info: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":0,"samplerate":"44.1 KHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Ray Gelato Giants - Apple Honey [7A]","artist":"Linn Jazz","album":null,"uri":"http://radio.linnrecords.com:8000/stream","trackType":"com:8000/stream"} Nov 01 04:39:42 volumio volumio[920]: info: CURRENT POSITION 1 Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::syncState stateService play Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus play Nov 01 04:39:42 volumio volumio[920]: info: Received an update from plaugin. extracting info from payload Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:42 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:42 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:42 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:42 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:42 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:42 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:42 volumio volumio[920]: info: ------------------------------ 121ms Nov 01 04:39:42 volumio volumio[920]: info: ------------------------------ 115ms Nov 01 04:39:42 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8003/stream","favourite":false} Nov 01 04:39:42 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8000/stream","favourite":false} Nov 01 04:39:42 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8000/stream","favourite":false} Nov 01 04:39:42 volumio volumio[920]: info: ------------------------------ 114ms Nov 01 04:39:42 volumio volumio[920]: info: parsing response... Nov 01 04:39:42 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:42 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:42 volumio volumio[920]: info: sending command... Nov 01 04:39:42 volumio volumio[920]: info: parsing response... Nov 01 04:39:42 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:42 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:42 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:42 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:42 volumio volumio[920]: info: STATE SERVICE {"status":"play","position":0,"seek":174,"duration":0,"samplerate":"44.1 KHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Ray Gelato Giants - Apple Honey [7A]","artist":"Linn Jazz","album":null,"uri":"http://radio.linnrecords.com:8000/stream","trackType":"com:8000/stream"} Nov 01 04:39:42 volumio volumio[920]: info: CURRENT POSITION 1 Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::syncState stateService play Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus play Nov 01 04:39:42 volumio volumio[920]: info: Received an update from plaugin. extracting info from payload Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:42 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:42 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:42 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:42 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:42 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:42 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:42 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:42 volumio volumio[920]: info: ------------------------------ 179ms Nov 01 04:39:42 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8000/stream","favourite":false} Nov 01 04:39:42 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8000/stream","favourite":false} Nov 01 04:39:45 volumio volumio[920]: info: CoreCommandRouter::volumioAddQueueItems Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::addQueueItems Nov 01 04:39:45 volumio volumio[920]: info: CorePlayQueue::addQueueItems Nov 01 04:39:45 volumio volumio[920]: info: Adding Item to queue: weblinn/2 Nov 01 04:39:45 volumio volumio[920]: info: Exploding uri weblinn/2 in service personal_radio Nov 01 04:39:45 volumio volumio[920]: info: CorePlayQueue::saveQueue Nov 01 04:39:45 volumio volumio[920]: info: CoreCommandRouter::volumioPushQueue Nov 01 04:39:45 volumio volumio[920]: info: interfaceApi::pushQueue Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:39:45 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:39:45 volumio volumio[920]: info: CoreCommandRouter::volumioPlay Nov 01 04:39:45 volumio volumio[920]: UNSET VOLATILE Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::play index 2 Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::stop Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:39:45 volumio volumio[920]: UNSET VOLATILE Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::stPlaybackTimer Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:39:45 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:45 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:45 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:45 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:45 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::serviceStop Nov 01 04:39:45 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:45 volumio volumio[920]: info: CoreCommandRouter::serviceStop Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::stop Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:39:45 volumio volumio[920]: info: sending command... Nov 01 04:39:45 volumio volumio[920]: info: Pushing Favourites {"service":"personal_radio","uri":"http://radio.linnrecords.com:8000/stream","favourite":false} Nov 01 04:39:45 volumio volumio[920]: info: Nov 01 04:39:45 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:45 volumio volumio[920]: info: parsing response... Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:45 volumio volumio[920]: info: sending command... Nov 01 04:39:45 volumio volumio[920]: info: sending command... Nov 01 04:39:45 volumio volumio[920]: info: parsing response... Nov 01 04:39:45 volumio volumio[920]: info: parsing response... Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:45 volumio volumio[920]: info: sending command... Nov 01 04:39:45 volumio volumio[920]: info: sending command... Nov 01 04:39:45 volumio volumio[920]: info: parsing response... Nov 01 04:39:45 volumio volumio[920]: info: parsing response... Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:45 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:45 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:45 volumio volumio[920]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current personal_radio Received mpd Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:45 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:45 volumio volumio[920]: info: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Ray Gelato Giants - Apple Honey [7A]","artist":"Linn Jazz","album":null,"uri":"http://radio.linnrecords.com:8000/stream","trackType":"com:8000/stream"} Nov 01 04:39:45 volumio volumio[920]: info: CURRENT POSITION 1 Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::syncState stateService stop Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus stop Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:45 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:45 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:45 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:45 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:45 volumio volumio[920]: info: No code Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:45 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:39:45 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:45 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:45 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:45 volumio volumio[920]: info: ------------------------------ 132ms Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::play index undefined Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:39:45 volumio volumio[920]: info: CorePlayQueue::getTrack 2 Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::startPlaybackTimer Nov 01 04:39:45 volumio volumio[920]: info: CorePlayQueue::getTrack 2 Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:39:45 volumio volumio[920]: info: sending command... Nov 01 04:39:45 volumio volumio[920]: info: Pushing Favourites {"service":"personal_radio","uri":"http://radio.linnrecords.com:8000/stream","favourite":false} Nov 01 04:39:45 volumio volumio[920]: info: Pushing Favourites {"service":"personal_radio","uri":"http://radio.linnrecords.com:8000/stream","favourite":false} Nov 01 04:39:45 volumio volumio[920]: info: parsing response... Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::sendMpdCommand clear Nov 01 04:39:45 volumio volumio[920]: info: sending command... Nov 01 04:39:45 volumio volumio[920]: info: Nov 01 04:39:45 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:45 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:45 volumio volumio[920]: info: parsing response... Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::sendMpdCommand add "http://radio.linnrecords.com:8004/stream" Nov 01 04:39:45 volumio volumio[920]: info: sending command... Nov 01 04:39:45 volumio volumio[920]: info: Nov 01 04:39:45 volumio volumio[920]: info: Nov 01 04:39:45 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:45 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:45 volumio volumio[920]: info: ------------------------------ 26ms Nov 01 04:39:45 volumio volumio[920]: info: parsing response... Nov 01 04:39:45 volumio volumio[920]: info: ControllerMpd::sendMpdCommand play Nov 01 04:39:45 volumio volumio[920]: info: sending command... Nov 01 04:39:45 volumio volumio[920]: info: ------------------------------ 25ms Nov 01 04:39:45 volumio volumio[920]: info: parsing response... Nov 01 04:39:45 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 01 04:39:51 volumio volumio[920]: info: Nov 01 04:39:51 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:51 volumio volumio[920]: info: sending command... Nov 01 04:39:51 volumio volumio[920]: info: Nov 01 04:39:51 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:51 volumio volumio[920]: info: parsing response... Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:51 volumio volumio[920]: info: sending command... Nov 01 04:39:51 volumio volumio[920]: info: sending command... Nov 01 04:39:51 volumio volumio[920]: info: Nov 01 04:39:51 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:51 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:51 volumio volumio[920]: info: Nov 01 04:39:51 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:39:51 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:39:51 volumio volumio[920]: info: Nov 01 04:39:51 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:39:51 volumio volumio[920]: info: parsing response... Nov 01 04:39:51 volumio volumio[920]: info: parsing response... Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:51 volumio volumio[920]: info: sending command... Nov 01 04:39:51 volumio volumio[920]: info: sending command... Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:51 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:51 volumio volumio[920]: info: CorePlayQueue::getTrack 2 Nov 01 04:39:51 volumio volumio[920]: info: 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,"isStreaming":false,"title":"stream","artist":"Linn Classical","album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":"com:8004/stream"} Nov 01 04:39:51 volumio volumio[920]: info: CURRENT POSITION 2 Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::syncState stateService play Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus stop Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:51 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:51 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:51 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:51 volumio volumio[920]: info: ------------------------------ 39ms Nov 01 04:39:51 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8000/stream","favourite":false} Nov 01 04:39:51 volumio volumio[920]: info: ------------------------------ 38ms Nov 01 04:39:51 volumio volumio[920]: info: ------------------------------ 38ms Nov 01 04:39:51 volumio volumio[920]: info: parsing response... Nov 01 04:39:51 volumio volumio[920]: info: parsing response... Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:51 volumio volumio[920]: info: sending command... Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:51 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:51 volumio volumio[920]: info: CorePlayQueue::getTrack 2 Nov 01 04:39:51 volumio volumio[920]: info: STATE SERVICE {"status":"play","position":0,"seek":58,"duration":0,"samplerate":"44.1 KHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Dunedin Consort - Christmas Oratorio, BWV 248: Cantata No. 6. Aria. 'Nun mogt ihr stolzen Feinde schrecken' [1wb]","artist":"Linn Classical","album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":"com:8004/stream"} Nov 01 04:39:51 volumio volumio[920]: info: CURRENT POSITION 2 Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::syncState stateService play Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus play Nov 01 04:39:51 volumio volumio[920]: info: Received an update from plaugin. extracting info from payload Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:51 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:51 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:51 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:51 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:51 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:51 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:51 volumio volumio[920]: info: ------------------------------ 146ms Nov 01 04:39:51 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8004/stream","favourite":false} Nov 01 04:39:51 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8004/stream","favourite":false} Nov 01 04:39:51 volumio volumio[920]: info: parsing response... Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:39:51 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:39:51 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:39:51 volumio volumio[920]: info: CorePlayQueue::getTrack 2 Nov 01 04:39:51 volumio volumio[920]: info: STATE SERVICE {"status":"play","position":0,"seek":174,"duration":0,"samplerate":"44.1 KHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Dunedin Consort - Christmas Oratorio, BWV 248: Cantata No. 6. Aria. 'Nun mogt ihr stolzen Feinde schrecken' [1wb]","artist":"Linn Classical","album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":"com:8004/stream"} Nov 01 04:39:51 volumio volumio[920]: info: CURRENT POSITION 2 Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::syncState stateService play Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus play Nov 01 04:39:51 volumio volumio[920]: info: Received an update from plaugin. extracting info from payload Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:51 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:51 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:51 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:39:51 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:39:51 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:39:51 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:39:51 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:39:51 volumio volumio[920]: info: ------------------------------ 242ms Nov 01 04:39:51 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8004/stream","favourite":false} Nov 01 04:39:51 volumio volumio[920]: info: Pushing Favourites {"service":"webradio","uri":"http://radio.linnrecords.com:8004/stream","favourite":false} Nov 01 04:39:53 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Nov 01 04:39:53 volumio volumio[920]: info: ControllerPersonalRadio::handleBrowseUri Nov 01 04:39:55 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Nov 01 04:39:55 volumio volumio[920]: info: ControllerPersonalRadio::handleBrowseUri Nov 01 04:39:58 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Nov 01 04:39:58 volumio volumio[920]: info: ControllerPersonalRadio::handleBrowseUri Nov 01 04:39:59 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Nov 01 04:39:59 volumio volumio[920]: info: ControllerPersonalRadio::handleBrowseUri Nov 01 04:40:01 volumio volumio[920]: info: CoreCommandRouter::volumioAddQueueItems Nov 01 04:40:01 volumio volumio[920]: info: CoreStateMachine::addQueueItems Nov 01 04:40:01 volumio volumio[920]: info: CorePlayQueue::addQueueItems Nov 01 04:40:01 volumio volumio[920]: info: Adding Item to queue: webkbs/0 Nov 01 04:40:01 volumio volumio[920]: info: Exploding uri webkbs/0 in service personal_radio Nov 01 04:40:02 volumio volumio[920]: info: CorePlayQueue::saveQueue Nov 01 04:40:02 volumio volumio[920]: info: CoreCommandRouter::volumioPushQueue Nov 01 04:40:02 volumio volumio[920]: info: interfaceApi::pushQueue Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:40:02 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:40:02 volumio volumio[920]: info: CoreCommandRouter::volumioPlay Nov 01 04:40:02 volumio volumio[920]: UNSET VOLATILE Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::play index 3 Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::stop Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:02 volumio volumio[920]: UNSET VOLATILE Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::stPlaybackTimer Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:40:02 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:40:02 volumio volumio[920]: info: CorePlayQueue::getTrack 2 Nov 01 04:40:02 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:40:02 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:40:02 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::serviceStop Nov 01 04:40:02 volumio volumio[920]: info: CorePlayQueue::getTrack 2 Nov 01 04:40:02 volumio volumio[920]: info: CoreCommandRouter::serviceStop Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::stop Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:40:02 volumio volumio[920]: info: sending command... Nov 01 04:40:02 volumio volumio[920]: info: Pushing Favourites {"service":"personal_radio","uri":"http://radio.linnrecords.com:8004/stream","favourite":false} Nov 01 04:40:02 volumio volumio[920]: info: Nov 01 04:40:02 volumio volumio[920]: ---------------------------- MPD announces state update: player Nov 01 04:40:02 volumio volumio[920]: info: parsing response... Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::getState Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::sendMpdCommand status Nov 01 04:40:02 volumio volumio[920]: info: sending command... Nov 01 04:40:02 volumio volumio[920]: info: sending command... Nov 01 04:40:02 volumio volumio[920]: info: parsing response... Nov 01 04:40:02 volumio volumio[920]: info: parsing response... Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::parseState Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 01 04:40:02 volumio volumio[920]: info: sending command... Nov 01 04:40:02 volumio volumio[920]: info: sending command... Nov 01 04:40:02 volumio volumio[920]: info: parsing response... Nov 01 04:40:02 volumio volumio[920]: info: parsing response... Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::parseTrackInfo Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::pushState Nov 01 04:40:02 volumio volumio[920]: info: CoreCommandRouter::servicePushState Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:40:02 volumio volumio[920]: info: CorePlayQueue::getTrack 2 Nov 01 04:40:02 volumio volumio[920]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current personal_radio Received mpd Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::syncState Nov 01 04:40:02 volumio volumio[920]: info: CorePlayQueue::getTrack 2 Nov 01 04:40:02 volumio volumio[920]: info: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Dunedin Consort - Christmas Oratorio, BWV 248: Cantata No. 6. Aria. 'Nun mogt ihr stolzen Feinde schrecken' [1wb]","artist":"Linn Classical","album":null,"uri":"http://radio.linnrecords.com:8004/stream","trackType":"com:8004/stream"} Nov 01 04:40:02 volumio volumio[920]: info: CURRENT POSITION 2 Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::syncState stateService stop Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::syncState currentStatus stop Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:40:02 volumio volumio[920]: info: CorePlayQueue::getTrack 2 Nov 01 04:40:02 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:40:02 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:40:02 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:40:02 volumio volumio[920]: info: No code Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::pushState Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::getState Nov 01 04:40:02 volumio volumio[920]: info: CorePlayQueue::getTrack 2 Nov 01 04:40:02 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:40:02 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:40:02 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:40:02 volumio volumio[920]: info: ------------------------------ 83ms Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::play index undefined Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:02 volumio volumio[920]: info: CorePlayQueue::getTrack 3 Nov 01 04:40:02 volumio volumio[920]: info: CoreStateMachine::startPlaybackTimer Nov 01 04:40:02 volumio volumio[920]: info: CorePlayQueue::getTrack 3 Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:40:02 volumio volumio[920]: info: sending command... Nov 01 04:40:02 volumio volumio[920]: info: Pushing Favourites {"service":"personal_radio","uri":"http://radio.linnrecords.com:8004/stream","favourite":false} Nov 01 04:40:02 volumio volumio[920]: info: Pushing Favourites {"service":"personal_radio","uri":"http://radio.linnrecords.com:8004/stream","favourite":false} Nov 01 04:40:02 volumio volumio[920]: info: parsing response... Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::sendMpdCommand clear Nov 01 04:40:02 volumio volumio[920]: info: sending command... Nov 01 04:40:02 volumio volumio[920]: info: Nov 01 04:40:02 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:40:02 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:40:02 volumio volumio[920]: info: parsing response... Nov 01 04:40:02 volumio volumio[920]: info: ControllerMpd::sendMpdCommand add "null" Nov 01 04:40:02 volumio volumio[920]: info: sending command... Nov 01 04:40:02 volumio volumio[920]: info: Nov 01 04:40:02 volumio volumio[920]: info: ------------------------------ 16ms Nov 01 04:40:03 volumio volumio[920]: info: CoreCommandRouter::volumioAddQueueItems Nov 01 04:40:03 volumio volumio[920]: info: CoreStateMachine::addQueueItems Nov 01 04:40:03 volumio volumio[920]: info: CorePlayQueue::addQueueItems Nov 01 04:40:03 volumio volumio[920]: info: Adding Item to queue: webkbs/0 Nov 01 04:40:03 volumio volumio[920]: info: Exploding uri webkbs/0 in service personal_radio Nov 01 04:40:04 volumio volumio[920]: info: CorePlayQueue::saveQueue Nov 01 04:40:04 volumio volumio[920]: info: CoreCommandRouter::volumioPushQueue Nov 01 04:40:04 volumio volumio[920]: info: interfaceApi::pushQueue Nov 01 04:40:04 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:40:04 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:40:04 volumio volumio[920]: info: CoreCommandRouter::volumioPlay Nov 01 04:40:04 volumio volumio[920]: UNSET VOLATILE Nov 01 04:40:04 volumio volumio[920]: info: CoreStateMachine::play index 4 Nov 01 04:40:04 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:04 volumio volumio[920]: info: CoreStateMachine::stop Nov 01 04:40:04 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:04 volumio volumio[920]: UNSET VOLATILE Nov 01 04:40:04 volumio volumio[920]: info: CoreStateMachine::play index undefined Nov 01 04:40:04 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:04 volumio volumio[920]: info: CorePlayQueue::getTrack 4 Nov 01 04:40:04 volumio volumio[920]: info: CoreStateMachine::startPlaybackTimer Nov 01 04:40:04 volumio volumio[920]: info: CorePlayQueue::getTrack 4 Nov 01 04:40:04 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:40:04 volumio volumio[920]: info: sending command... Nov 01 04:40:04 volumio volumio[920]: info: parsing response... Nov 01 04:40:04 volumio volumio[920]: info: ControllerMpd::sendMpdCommand clear Nov 01 04:40:04 volumio volumio[920]: info: sending command... Nov 01 04:40:04 volumio volumio[920]: info: Nov 01 04:40:04 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:40:04 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:40:04 volumio volumio[920]: info: parsing response... Nov 01 04:40:04 volumio volumio[920]: info: ControllerMpd::sendMpdCommand add "null" Nov 01 04:40:04 volumio volumio[920]: info: sending command... Nov 01 04:40:04 volumio volumio[920]: info: Nov 01 04:40:04 volumio volumio[920]: info: ------------------------------ 6ms Nov 01 04:40:09 volumio volumio[920]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 01 04:40:09 volumio volumio[920]: info: CoreStateMachine::ClearQueue Nov 01 04:40:09 volumio volumio[920]: info: CoreStateMachine::stop Nov 01 04:40:09 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:09 volumio volumio[920]: UNSET VOLATILE Nov 01 04:40:09 volumio volumio[920]: info: CorePlayQueue::clearPlayQueue Nov 01 04:40:09 volumio volumio[920]: info: CorePlayQueue::saveQueue Nov 01 04:40:09 volumio volumio[920]: info: CoreStateMachine::pushEmptyState Nov 01 04:40:09 volumio volumio[920]: info: CoreCommandRouter::volumioPushState Nov 01 04:40:09 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 04:40:09 volumio volumio[920]: info: interfaceApi::pushState Nov 01 04:40:09 volumio volumio[920]: info: CoreCommandRouter::volumioPushQueue Nov 01 04:40:09 volumio volumio[920]: info: interfaceApi::pushQueue Nov 01 04:40:09 volumio volumio[920]: info: CoreStateMachine::addQueueItems Nov 01 04:40:09 volumio volumio[920]: info: CorePlayQueue::addQueueItems Nov 01 04:40:09 volumio volumio[920]: info: Adding Item to queue: webkbs/0 Nov 01 04:40:09 volumio volumio[920]: info: Exploding uri webkbs/0 in service personal_radio Nov 01 04:40:09 volumio volumio[920]: info: Pushing Favourites {"service":"mpd","uri":"","favourite":false} Nov 01 04:40:10 volumio volumio[920]: info: CorePlayQueue::saveQueue Nov 01 04:40:10 volumio volumio[920]: info: CoreCommandRouter::volumioPushQueue Nov 01 04:40:10 volumio volumio[920]: info: interfaceApi::pushQueue Nov 01 04:40:10 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:40:10 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:40:10 volumio volumio[920]: info: CoreCommandRouter::volumioPlay Nov 01 04:40:10 volumio volumio[920]: UNSET VOLATILE Nov 01 04:40:10 volumio volumio[920]: info: CoreStateMachine::play index 0 Nov 01 04:40:10 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:10 volumio volumio[920]: info: CoreStateMachine::stop Nov 01 04:40:10 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:10 volumio volumio[920]: UNSET VOLATILE Nov 01 04:40:10 volumio volumio[920]: info: CoreStateMachine::play index undefined Nov 01 04:40:10 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:10 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:40:10 volumio volumio[920]: info: CoreStateMachine::startPlaybackTimer Nov 01 04:40:10 volumio volumio[920]: info: CorePlayQueue::getTrack 0 Nov 01 04:40:10 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:40:10 volumio volumio[920]: info: sending command... Nov 01 04:40:10 volumio volumio[920]: info: parsing response... Nov 01 04:40:10 volumio volumio[920]: info: ControllerMpd::sendMpdCommand clear Nov 01 04:40:10 volumio volumio[920]: info: sending command... Nov 01 04:40:10 volumio volumio[920]: info: Nov 01 04:40:10 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:40:10 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:40:10 volumio volumio[920]: info: parsing response... Nov 01 04:40:10 volumio volumio[920]: info: ControllerMpd::sendMpdCommand add "null" Nov 01 04:40:10 volumio volumio[920]: info: sending command... Nov 01 04:40:10 volumio volumio[920]: info: Nov 01 04:40:10 volumio volumio[920]: info: ------------------------------ 3ms Nov 01 04:40:14 volumio volumio[920]: info: CoreCommandRouter::volumioAddQueueItems Nov 01 04:40:14 volumio volumio[920]: info: CoreStateMachine::addQueueItems Nov 01 04:40:14 volumio volumio[920]: info: CorePlayQueue::addQueueItems Nov 01 04:40:14 volumio volumio[920]: info: Adding Item to queue: webkbs/3 Nov 01 04:40:14 volumio volumio[920]: info: Exploding uri webkbs/3 in service personal_radio Nov 01 04:40:15 volumio volumio[920]: info: CoreCommandRouter::volumioAddQueueItems Nov 01 04:40:15 volumio volumio[920]: info: CoreStateMachine::addQueueItems Nov 01 04:40:15 volumio volumio[920]: info: CorePlayQueue::addQueueItems Nov 01 04:40:15 volumio volumio[920]: info: Adding Item to queue: webkbs/3 Nov 01 04:40:15 volumio volumio[920]: info: Exploding uri webkbs/3 in service personal_radio Nov 01 04:40:15 volumio volumio[920]: info: CorePlayQueue::saveQueue Nov 01 04:40:15 volumio volumio[920]: info: CoreCommandRouter::volumioPushQueue Nov 01 04:40:15 volumio volumio[920]: info: interfaceApi::pushQueue Nov 01 04:40:15 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:40:15 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:40:15 volumio volumio[920]: info: CoreCommandRouter::volumioPlay Nov 01 04:40:15 volumio volumio[920]: UNSET VOLATILE Nov 01 04:40:15 volumio volumio[920]: info: CoreStateMachine::play index 1 Nov 01 04:40:15 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:15 volumio volumio[920]: info: CoreStateMachine::stop Nov 01 04:40:15 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:15 volumio volumio[920]: UNSET VOLATILE Nov 01 04:40:15 volumio volumio[920]: info: CoreStateMachine::play index undefined Nov 01 04:40:15 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:16 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:40:16 volumio volumio[920]: info: CoreStateMachine::startPlaybackTimer Nov 01 04:40:16 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:40:16 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:40:16 volumio volumio[920]: info: sending command... Nov 01 04:40:16 volumio volumio[920]: info: parsing response... Nov 01 04:40:16 volumio volumio[920]: info: ControllerMpd::sendMpdCommand clear Nov 01 04:40:16 volumio volumio[920]: info: sending command... Nov 01 04:40:16 volumio volumio[920]: info: Nov 01 04:40:16 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:40:16 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:40:16 volumio volumio[920]: info: parsing response... Nov 01 04:40:16 volumio volumio[920]: info: ControllerMpd::sendMpdCommand add "null" Nov 01 04:40:16 volumio volumio[920]: info: sending command... Nov 01 04:40:16 volumio volumio[920]: info: Nov 01 04:40:16 volumio volumio[920]: info: ------------------------------ 2ms Nov 01 04:40:16 volumio volumio[920]: info: CorePlayQueue::saveQueue Nov 01 04:40:16 volumio volumio[920]: info: CoreCommandRouter::volumioPushQueue Nov 01 04:40:16 volumio volumio[920]: info: interfaceApi::pushQueue Nov 01 04:40:16 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:40:16 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:40:16 volumio volumio[920]: info: CoreCommandRouter::volumioPlay Nov 01 04:40:16 volumio volumio[920]: UNSET VOLATILE Nov 01 04:40:16 volumio volumio[920]: info: CoreStateMachine::play index 1 Nov 01 04:40:16 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:16 volumio volumio[920]: info: CoreStateMachine::stop Nov 01 04:40:16 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:16 volumio volumio[920]: UNSET VOLATILE Nov 01 04:40:16 volumio volumio[920]: info: CoreStateMachine::play index undefined Nov 01 04:40:16 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:16 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:40:16 volumio volumio[920]: info: CoreStateMachine::startPlaybackTimer Nov 01 04:40:16 volumio volumio[920]: info: CorePlayQueue::getTrack 1 Nov 01 04:40:16 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:40:16 volumio volumio[920]: info: sending command... Nov 01 04:40:16 volumio volumio[920]: info: parsing response... Nov 01 04:40:16 volumio volumio[920]: info: ControllerMpd::sendMpdCommand clear Nov 01 04:40:16 volumio volumio[920]: info: sending command... Nov 01 04:40:16 volumio volumio[920]: info: Nov 01 04:40:16 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:40:16 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:40:16 volumio volumio[920]: info: parsing response... Nov 01 04:40:16 volumio volumio[920]: info: ControllerMpd::sendMpdCommand add "null" Nov 01 04:40:16 volumio volumio[920]: info: sending command... Nov 01 04:40:16 volumio volumio[920]: info: Nov 01 04:40:16 volumio volumio[920]: info: ------------------------------ 5ms Nov 01 04:40:18 volumio volumio[920]: info: CoreCommandRouter::volumioAddQueueItems Nov 01 04:40:18 volumio volumio[920]: info: CoreStateMachine::addQueueItems Nov 01 04:40:18 volumio volumio[920]: info: CorePlayQueue::addQueueItems Nov 01 04:40:18 volumio volumio[920]: info: Adding Item to queue: webkbs/5 Nov 01 04:40:18 volumio volumio[920]: info: Exploding uri webkbs/5 in service personal_radio Nov 01 04:40:19 volumio volumio[920]: info: CorePlayQueue::saveQueue Nov 01 04:40:19 volumio volumio[920]: info: CoreCommandRouter::volumioPushQueue Nov 01 04:40:19 volumio volumio[920]: info: interfaceApi::pushQueue Nov 01 04:40:19 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:40:19 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:40:19 volumio volumio[920]: info: CoreCommandRouter::volumioPlay Nov 01 04:40:19 volumio volumio[920]: UNSET VOLATILE Nov 01 04:40:19 volumio volumio[920]: info: CoreStateMachine::play index 3 Nov 01 04:40:19 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:19 volumio volumio[920]: info: CoreStateMachine::stop Nov 01 04:40:19 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:19 volumio volumio[920]: UNSET VOLATILE Nov 01 04:40:19 volumio volumio[920]: info: CoreStateMachine::play index undefined Nov 01 04:40:19 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:19 volumio volumio[920]: info: CorePlayQueue::getTrack 3 Nov 01 04:40:19 volumio volumio[920]: info: CoreStateMachine::startPlaybackTimer Nov 01 04:40:19 volumio volumio[920]: info: CorePlayQueue::getTrack 3 Nov 01 04:40:19 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:40:19 volumio volumio[920]: info: sending command... Nov 01 04:40:19 volumio volumio[920]: info: parsing response... Nov 01 04:40:19 volumio volumio[920]: info: ControllerMpd::sendMpdCommand clear Nov 01 04:40:19 volumio volumio[920]: info: sending command... Nov 01 04:40:19 volumio volumio[920]: info: Nov 01 04:40:19 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:40:19 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:40:19 volumio volumio[920]: info: parsing response... Nov 01 04:40:19 volumio volumio[920]: info: ControllerMpd::sendMpdCommand add "null" Nov 01 04:40:19 volumio volumio[920]: info: sending command... Nov 01 04:40:19 volumio volumio[920]: info: Nov 01 04:40:19 volumio volumio[920]: info: ------------------------------ 5ms Nov 01 04:40:20 volumio volumio[920]: info: CoreCommandRouter::volumioAddQueueItems Nov 01 04:40:20 volumio volumio[920]: info: CoreStateMachine::addQueueItems Nov 01 04:40:20 volumio volumio[920]: info: CorePlayQueue::addQueueItems Nov 01 04:40:20 volumio volumio[920]: info: Adding Item to queue: webkbs/7 Nov 01 04:40:20 volumio volumio[920]: info: Exploding uri webkbs/7 in service personal_radio Nov 01 04:40:21 volumio volumio[920]: info: CorePlayQueue::saveQueue Nov 01 04:40:21 volumio volumio[920]: info: CoreCommandRouter::volumioPushQueue Nov 01 04:40:21 volumio volumio[920]: info: interfaceApi::pushQueue Nov 01 04:40:21 volumio volumio[920]: info: CoreStateMachine::updateTrackBlock Nov 01 04:40:21 volumio volumio[920]: info: CorePlayQueue::getTrackBlock Nov 01 04:40:21 volumio volumio[920]: info: CoreCommandRouter::volumioPlay Nov 01 04:40:21 volumio volumio[920]: UNSET VOLATILE Nov 01 04:40:21 volumio volumio[920]: info: CoreStateMachine::play index 4 Nov 01 04:40:21 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:21 volumio volumio[920]: info: CoreStateMachine::stop Nov 01 04:40:21 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:21 volumio volumio[920]: UNSET VOLATILE Nov 01 04:40:21 volumio volumio[920]: info: CoreStateMachine::play index undefined Nov 01 04:40:21 volumio volumio[920]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 04:40:21 volumio volumio[920]: info: CorePlayQueue::getTrack 4 Nov 01 04:40:21 volumio volumio[920]: info: CoreStateMachine::startPlaybackTimer Nov 01 04:40:21 volumio volumio[920]: info: CorePlayQueue::getTrack 4 Nov 01 04:40:21 volumio volumio[920]: info: ControllerMpd::sendMpdCommand stop Nov 01 04:40:21 volumio volumio[920]: info: sending command... Nov 01 04:40:21 volumio volumio[920]: info: parsing response... Nov 01 04:40:21 volumio volumio[920]: info: ControllerMpd::sendMpdCommand clear Nov 01 04:40:21 volumio volumio[920]: info: sending command... Nov 01 04:40:21 volumio volumio[920]: info: Nov 01 04:40:21 volumio volumio[920]: ---------------------------- MPD announces system playlist update Nov 01 04:40:21 volumio volumio[920]: info: Ignoring MPD Status Update Nov 01 04:40:21 volumio volumio[920]: info: parsing response... Nov 01 04:40:21 volumio volumio[920]: info: ControllerMpd::sendMpdCommand add "null" Nov 01 04:40:21 volumio volumio[920]: info: sending command... Nov 01 04:40:21 volumio volumio[920]: info: Nov 01 04:40:21 volumio volumio[920]: info: ------------------------------ 3ms Nov 01 04:40:23 volumio hostapd[965]: wlan0: STA 7a:13:62:c4:2e:ef WPA: group key handshake completed (RSN) Nov 01 04:40:24 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Nov 01 04:40:24 volumio volumio[920]: info: ControllerPersonalRadio::handleBrowseUri Nov 01 04:40:26 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Nov 01 04:40:26 volumio volumio[920]: info: ControllerPersonalRadio::handleBrowseUri Nov 01 04:40:27 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Nov 01 04:40:27 volumio volumio[920]: info: ControllerPersonalRadio::handleBrowseUri Nov 01 04:40:28 volumio volumio[920]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Nov 01 04:40:28 volumio volumio[920]: info: ControllerPersonalRadio::handleBrowseUri Nov 01 04:40:33 volumio volumio[920]: info: CoreCommandRouter::volumioAddQueueItems Nov 01 04:40:33 volumio volumio[920]: info: CoreStateMachine::addQueueItems Nov 01 04:40:33 volumio volumio[920]: info: CorePlayQueue::addQueueItems Nov 01 04:40:33 volumio volumio[920]: info: Adding Item to queue: webmbc/2 Nov 01 04:40:33 volumio volumio[920]: info: Exploding uri webmbc/2 in service personal_radio Nov 01 04:40:33 volumio volumio[920]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 04:40:33 volumio volumio[920]: TypeError: Cannot read property 'replace' of undefined Nov 01 04:40:33 volumio volumio[920]: at /data/plugins/music_service/personal_radio/index.js:499:45 Nov 01 04:40:33 volumio volumio[920]: at Request.handleRequestResponse [as _callback] (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:463:26) Nov 01 04:40:33 volumio volumio[920]: at Request.self.callback (/data/plugins/music_service/personal_radio/node_modules/request/request.js:187:22) Nov 01 04:40:33 volumio volumio[920]: at emitTwo (events.js:126:13) Nov 01 04:40:33 volumio volumio[920]: at Request.emit (events.js:214:7) Nov 01 04:40:33 volumio volumio[920]: at Request. (/data/plugins/music_service/personal_radio/node_modules/request/request.js:1044:10) Nov 01 04:40:33 volumio volumio[920]: at emitOne (events.js:116:13) Nov 01 04:40:33 volumio volumio[920]: at Request.emit (events.js:211:7) Nov 01 04:40:33 volumio volumio[920]: at IncomingMessage. (/data/plugins/music_service/personal_radio/node_modules/request/request.js:965:12) Nov 01 04:40:33 volumio volumio[920]: at emitNone (events.js:111:20) Nov 01 04:40:33 volumio volumio[920]: at IncomingMessage.emit (events.js:208:7) Nov 01 04:40:33 volumio volumio[920]: at endReadableNT (_stream_readable.js:1064:12) Nov 01 04:40:33 volumio volumio[920]: at _combinedTickCallback (internal/process/next_tick.js:138:11) Nov 01 04:40:33 volumio volumio[920]: at process._tickCallback (internal/process/next_tick.js:180:9) Nov 01 04:40:33 volumio volumio[920]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 04:40:36 volumio sudo[9547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-01 04:39 Nov 01 04:40:36 volumio sudo[9547]: 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="2f09878fca434492a3a1c8d64c992c38a304bdcb" VOLUMIO_FE_VERSION="81c7100e9c7342b16fc9e0ca5908a26771e08c4f" VOLUMIO_BE_VERSION="9ddaa4edade219b4424aaf553d8a153e2d73143a" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Jun 15 20:45:03 CEST 2018" VOLUMIO_VERSION="2.411" VOLUMIO_HARDWARE="x86"