-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sun 2022-12-04 20:39:36 UTC. -- Dec 04 20:38:20 volumio volumio[822]: verbose: New Socket.io Connection to 192.168.1.19 from 192.168.1.15 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 3 Dec 04 20:38:20 volumio volumio[822]: info: Received Get System Info Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 04 20:38:20 volumio volumio[822]: info: Discovery: Getting this device information Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::volumioGetState Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::volumioGetState Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::volumioGetVisibleSources Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::volumioGetState Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 04 20:38:20 volumio volumio[822]: info: Received Get System Info Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 04 20:38:20 volumio volumio[822]: info: Discovery: Getting this device information Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::volumioGetState Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::volumioGetState Dec 04 20:38:20 volumio volumio[822]: info: Listing playlists Dec 04 20:38:20 volumio volumio[822]: info: CoreCommandRouter::volumioGetQueue Dec 04 20:38:20 volumio volumio[822]: info: CoreStateMachine::getQueue Dec 04 20:38:20 volumio volumio[822]: info: CorePlayQueue::getQueue Dec 04 20:38:24 volumio volumio[822]: info: CoreCommandRouter::volumioPlay Dec 04 20:38:24 volumio volumio[822]: info: CoreStateMachine::play index 0 Dec 04 20:38:24 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:24 volumio volumio[822]: info: CoreStateMachine::stop Dec 04 20:38:24 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:24 volumio volumio[822]: info: CoreStateMachine::pushState Dec 04 20:38:24 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:24 volumio volumio[822]: info: CoreCommandRouter::volumioPushState Dec 04 20:38:24 volumio volumio[822]: info: CoreStateMachine::stPlaybackTimer Dec 04 20:38:24 volumio volumio[822]: info: CoreStateMachine::updateTrackBlock Dec 04 20:38:24 volumio volumio[822]: info: CorePlayQueue::getTrackBlock Dec 04 20:38:24 volumio volumio[822]: info: CoreStateMachine::serviceStop Dec 04 20:38:24 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:24 volumio volumio[822]: info: CoreCommandRouter::serviceStop Dec 04 20:38:24 volumio volumio[822]: info: [1670186304511] ControllerWebradio::stop Dec 04 20:38:24 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand stop Dec 04 20:38:24 volumio volumio[822]: info: sendMpdCommand stop took 75 milliseconds Dec 04 20:38:24 volumio volumio[822]: info: CoreStateMachine::play index undefined Dec 04 20:38:24 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:24 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:24 volumio volumio[822]: info: CoreStateMachine::startPlaybackTimer Dec 04 20:38:24 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:24 volumio volumio[822]: info: [1670186304588] ControllerWebradio::clearAddPlayTrack Dec 04 20:38:24 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand stop Dec 04 20:38:24 volumio volumio[822]: info: Dec 04 20:38:24 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:24 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:24 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:24 volumio volumio[822]: info: sendMpdCommand stop took 2 milliseconds Dec 04 20:38:24 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand clear Dec 04 20:38:24 volumio volumio[822]: info: Dec 04 20:38:24 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:24 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:24 volumio volumio[822]: info: sendMpdCommand status took 3 milliseconds Dec 04 20:38:24 volumio volumio[822]: info: sendMpdCommand clear took 2 milliseconds Dec 04 20:38:24 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:24 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:24 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Dec 04 20:38:24 volumio volumio[822]: error: updateQueue error: null Dec 04 20:38:24 volumio volumio[822]: info: ------------------------------ 6ms Dec 04 20:38:24 volumio volumio[822]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 04 20:38:24 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:24 volumio volumio[822]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 04 20:38:24 volumio volumio[822]: info: ------------------------------ 12ms Dec 04 20:38:25 volumio volumio[822]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 698 milliseconds Dec 04 20:38:25 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 04 20:38:25 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand play Dec 04 20:38:25 volumio volumio[822]: info: Dec 04 20:38:25 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:25 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:25 volumio volumio[822]: info: sendMpdCommand play took 2 milliseconds Dec 04 20:38:25 volumio volumio[822]: info: ------------------------------ 3ms Dec 04 20:38:25 volumio volumio[822]: info: CoreCommandRouter::volumioPlay Dec 04 20:38:25 volumio volumio[822]: info: CoreStateMachine::play index 0 Dec 04 20:38:25 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:25 volumio volumio[822]: info: CoreStateMachine::stop Dec 04 20:38:25 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:25 volumio volumio[822]: info: CoreStateMachine::play index undefined Dec 04 20:38:25 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:25 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:25 volumio volumio[822]: info: CoreStateMachine::startPlaybackTimer Dec 04 20:38:25 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:25 volumio volumio[822]: info: [1670186305506] ControllerWebradio::clearAddPlayTrack Dec 04 20:38:25 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand stop Dec 04 20:38:25 volumio volumio[822]: info: Dec 04 20:38:25 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:25 volumio volumio[822]: info: sendMpdCommand stop took 2 milliseconds Dec 04 20:38:25 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:25 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:25 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand clear Dec 04 20:38:25 volumio volumio[822]: info: Dec 04 20:38:25 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:25 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:25 volumio volumio[822]: info: sendMpdCommand status took 2 milliseconds Dec 04 20:38:25 volumio volumio[822]: info: sendMpdCommand clear took 2 milliseconds Dec 04 20:38:25 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:25 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:25 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Dec 04 20:38:25 volumio volumio[822]: error: updateQueue error: null Dec 04 20:38:25 volumio volumio[822]: info: ------------------------------ 4ms Dec 04 20:38:25 volumio volumio[822]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 04 20:38:25 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:25 volumio volumio[822]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 04 20:38:25 volumio volumio[822]: info: ------------------------------ 9ms Dec 04 20:38:25 volumio volumio[822]: info: Dec 04 20:38:25 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:25 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:25 volumio volumio[822]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 271 milliseconds Dec 04 20:38:25 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 04 20:38:25 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand play Dec 04 20:38:25 volumio volumio[822]: info: ------------------------------ 3ms Dec 04 20:38:25 volumio volumio[822]: info: sendMpdCommand play took 2 milliseconds Dec 04 20:38:27 volumio volumio[822]: info: CoreCommandRouter::volumioPlay Dec 04 20:38:27 volumio volumio[822]: info: CoreStateMachine::play index 0 Dec 04 20:38:27 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:27 volumio volumio[822]: info: CoreStateMachine::stop Dec 04 20:38:27 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:27 volumio volumio[822]: info: CoreStateMachine::play index undefined Dec 04 20:38:27 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:27 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:27 volumio volumio[822]: info: CoreStateMachine::startPlaybackTimer Dec 04 20:38:27 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:27 volumio volumio[822]: info: [1670186307082] ControllerWebradio::clearAddPlayTrack Dec 04 20:38:27 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand stop Dec 04 20:38:27 volumio volumio[822]: info: Dec 04 20:38:27 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:27 volumio volumio[822]: info: sendMpdCommand stop took 238 milliseconds Dec 04 20:38:27 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:27 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:27 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand clear Dec 04 20:38:27 volumio volumio[822]: info: Dec 04 20:38:27 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:27 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:27 volumio volumio[822]: info: sendMpdCommand status took 3 milliseconds Dec 04 20:38:27 volumio volumio[822]: info: sendMpdCommand clear took 3 milliseconds Dec 04 20:38:27 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:27 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:27 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Dec 04 20:38:27 volumio volumio[822]: error: updateQueue error: null Dec 04 20:38:27 volumio volumio[822]: info: ------------------------------ 5ms Dec 04 20:38:27 volumio volumio[822]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 04 20:38:27 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:27 volumio volumio[822]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 04 20:38:27 volumio volumio[822]: info: ------------------------------ 10ms Dec 04 20:38:27 volumio volumio[822]: info: Dec 04 20:38:27 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:27 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:27 volumio volumio[822]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 268 milliseconds Dec 04 20:38:27 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 04 20:38:27 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand play Dec 04 20:38:27 volumio volumio[822]: info: ------------------------------ 4ms Dec 04 20:38:27 volumio volumio[822]: info: sendMpdCommand play took 2 milliseconds Dec 04 20:38:27 volumio volumio[822]: info: CoreCommandRouter::volumioPlay Dec 04 20:38:27 volumio volumio[822]: info: CoreStateMachine::play index 0 Dec 04 20:38:27 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:27 volumio volumio[822]: info: CoreStateMachine::stop Dec 04 20:38:27 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:27 volumio volumio[822]: info: CoreStateMachine::play index undefined Dec 04 20:38:27 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:27 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:27 volumio volumio[822]: info: CoreStateMachine::startPlaybackTimer Dec 04 20:38:27 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:27 volumio volumio[822]: info: [1670186307909] ControllerWebradio::clearAddPlayTrack Dec 04 20:38:27 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand stop Dec 04 20:38:28 volumio volumio[822]: info: Dec 04 20:38:28 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:28 volumio volumio[822]: info: sendMpdCommand stop took 733 milliseconds Dec 04 20:38:28 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:28 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:28 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand clear Dec 04 20:38:28 volumio volumio[822]: info: Dec 04 20:38:28 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:28 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:28 volumio volumio[822]: info: sendMpdCommand status took 9 milliseconds Dec 04 20:38:28 volumio volumio[822]: info: sendMpdCommand clear took 9 milliseconds Dec 04 20:38:28 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:28 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:28 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Dec 04 20:38:28 volumio volumio[822]: error: updateQueue error: null Dec 04 20:38:28 volumio volumio[822]: info: ------------------------------ 5ms Dec 04 20:38:28 volumio volumio[822]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 04 20:38:28 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:28 volumio volumio[822]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 04 20:38:28 volumio volumio[822]: info: ------------------------------ 18ms Dec 04 20:38:28 volumio volumio[822]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 269 milliseconds Dec 04 20:38:28 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 04 20:38:28 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand play Dec 04 20:38:28 volumio volumio[822]: info: Dec 04 20:38:28 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:28 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:28 volumio volumio[822]: info: sendMpdCommand play took 2 milliseconds Dec 04 20:38:28 volumio volumio[822]: info: ------------------------------ 3ms Dec 04 20:38:28 volumio volumio[822]: info: CoreCommandRouter::volumioPlay Dec 04 20:38:28 volumio volumio[822]: info: CoreStateMachine::play index undefined Dec 04 20:38:28 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:28 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:28 volumio volumio[822]: info: CoreStateMachine::startPlaybackTimer Dec 04 20:38:28 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:28 volumio volumio[822]: info: [1670186308988] ControllerWebradio::clearAddPlayTrack Dec 04 20:38:28 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand stop Dec 04 20:38:28 volumio volumio[822]: info: sendMpdCommand stop took 2 milliseconds Dec 04 20:38:28 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand clear Dec 04 20:38:28 volumio volumio[822]: info: Dec 04 20:38:28 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:28 volumio volumio[822]: info: Dec 04 20:38:28 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:28 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:28 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:28 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:28 volumio volumio[822]: info: sendMpdCommand clear took 3 milliseconds Dec 04 20:38:28 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Dec 04 20:38:28 volumio volumio[822]: error: updateQueue error: null Dec 04 20:38:28 volumio volumio[822]: info: sendMpdCommand status took 3 milliseconds Dec 04 20:38:28 volumio volumio[822]: info: ------------------------------ 4ms Dec 04 20:38:28 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:28 volumio volumio[822]: info: ControllerMpd::pushState Dec 04 20:38:28 volumio volumio[822]: info: CoreCommandRouter::servicePushState Dec 04 20:38:28 volumio volumio[822]: info: CoreStateMachine::pushState Dec 04 20:38:28 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:28 volumio volumio[822]: info: CoreCommandRouter::volumioPushState Dec 04 20:38:29 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:29 volumio volumio[822]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Dec 04 20:38:29 volumio volumio[822]: info: ------------------------------ 15ms Dec 04 20:38:29 volumio volumio[822]: info: Dec 04 20:38:29 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:29 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:29 volumio volumio[822]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 269 milliseconds Dec 04 20:38:29 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 04 20:38:29 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand play Dec 04 20:38:29 volumio volumio[822]: info: ------------------------------ 3ms Dec 04 20:38:29 volumio volumio[822]: info: sendMpdCommand play took 2 milliseconds Dec 04 20:38:30 volumio volumio[822]: info: Dec 04 20:38:30 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:30 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:30 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:30 volumio volumio[822]: info: sendMpdCommand status took 24 milliseconds Dec 04 20:38:30 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:30 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:30 volumio volumio[822]: info: Dec 04 20:38:30 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:30 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:30 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:30 volumio volumio[822]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 04 20:38:30 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:30 volumio volumio[822]: info: ControllerMpd::pushState Dec 04 20:38:30 volumio volumio[822]: info: CoreCommandRouter::servicePushState Dec 04 20:38:30 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:30 volumio volumio[822]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 12081/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Dec 04 20:38:30 volumio volumio[822]: verbose: CURRENT POSITION 0 Dec 04 20:38:30 volumio volumio[822]: info: CoreStateMachine::syncState stateService play Dec 04 20:38:30 volumio volumio[822]: info: CoreStateMachine::syncState currentStatus stop Dec 04 20:38:30 volumio volumio[822]: info: ------------------------------ 31ms Dec 04 20:38:30 volumio volumio[822]: info: sendMpdCommand status took 7 milliseconds Dec 04 20:38:30 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:30 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:30 volumio volumio[822]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 04 20:38:30 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:30 volumio volumio[822]: info: ControllerMpd::pushState Dec 04 20:38:30 volumio volumio[822]: info: CoreCommandRouter::servicePushState Dec 04 20:38:30 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:30 volumio volumio[822]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 12081/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Dec 04 20:38:30 volumio volumio[822]: verbose: CURRENT POSITION 0 Dec 04 20:38:30 volumio volumio[822]: info: CoreStateMachine::syncState stateService play Dec 04 20:38:30 volumio volumio[822]: info: CoreStateMachine::syncState currentStatus play Dec 04 20:38:30 volumio volumio[822]: info: Received an update from plugin. extracting info from payload Dec 04 20:38:30 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 04 20:38:30 volumio volumio[822]: info: CoreStateMachine::pushState Dec 04 20:38:30 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:30 volumio volumio[822]: info: CoreCommandRouter::volumioPushState Dec 04 20:38:30 volumio volumio[822]: info: ------------------------------ 25ms Dec 04 20:38:31 volumio volumio[822]: info: Dec 04 20:38:31 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:31 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:31 volumio volumio[822]: info: Dec 04 20:38:31 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:31 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:31 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:31 volumio volumio[822]: info: Dec 04 20:38:31 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:31 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:31 volumio volumio[822]: info: Dec 04 20:38:31 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:31 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:31 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:31 volumio volumio[822]: info: ------------------------------ 6ms Dec 04 20:38:31 volumio volumio[822]: info: sendMpdCommand status took 6 milliseconds Dec 04 20:38:31 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:31 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:31 volumio volumio[822]: info: ------------------------------ 7ms Dec 04 20:38:31 volumio volumio[822]: info: sendMpdCommand status took 6 milliseconds Dec 04 20:38:31 volumio volumio[822]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 04 20:38:31 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:31 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:31 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:31 volumio volumio[822]: info: ControllerMpd::pushState Dec 04 20:38:31 volumio volumio[822]: info: CoreCommandRouter::servicePushState Dec 04 20:38:31 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:31 volumio volumio[822]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClockClock - Someone Else","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Dec 04 20:38:31 volumio volumio[822]: verbose: CURRENT POSITION 0 Dec 04 20:38:31 volumio volumio[822]: info: CoreStateMachine::syncState stateService play Dec 04 20:38:31 volumio volumio[822]: info: CoreStateMachine::syncState currentStatus play Dec 04 20:38:31 volumio volumio[822]: info: Received an update from plugin. extracting info from payload Dec 04 20:38:31 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 04 20:38:31 volumio volumio[822]: info: CoreStateMachine::pushState Dec 04 20:38:31 volumio volumio[822]: info: CoreCommandRouter::volumioPushState Dec 04 20:38:31 volumio volumio[822]: info: ------------------------------ 34ms Dec 04 20:38:31 volumio volumio[822]: info: sendMpdCommand playlistinfo took 24 milliseconds Dec 04 20:38:31 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:31 volumio volumio[822]: info: ControllerMpd::pushState Dec 04 20:38:31 volumio volumio[822]: info: CoreCommandRouter::servicePushState Dec 04 20:38:31 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:31 volumio volumio[822]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClockClock - Someone Else","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Dec 04 20:38:31 volumio volumio[822]: verbose: CURRENT POSITION 0 Dec 04 20:38:31 volumio volumio[822]: info: CoreStateMachine::syncState stateService play Dec 04 20:38:31 volumio volumio[822]: info: CoreStateMachine::syncState currentStatus play Dec 04 20:38:31 volumio volumio[822]: info: Received an update from plugin. extracting info from payload Dec 04 20:38:31 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 04 20:38:31 volumio volumio[822]: info: CoreStateMachine::pushState Dec 04 20:38:31 volumio volumio[822]: info: CoreCommandRouter::volumioPushState Dec 04 20:38:31 volumio volumio[822]: info: ------------------------------ 47ms Dec 04 20:38:32 volumio volumio[822]: info: Dec 04 20:38:32 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:32 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:32 volumio volumio[822]: info: Dec 04 20:38:32 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:32 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:32 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:32 volumio volumio[822]: info: Dec 04 20:38:32 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:32 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:32 volumio volumio[822]: info: Dec 04 20:38:32 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:32 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:32 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:32 volumio volumio[822]: info: ------------------------------ 5ms Dec 04 20:38:32 volumio volumio[822]: info: sendMpdCommand status took 3 milliseconds Dec 04 20:38:32 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:32 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:32 volumio volumio[822]: info: ------------------------------ 9ms Dec 04 20:38:32 volumio volumio[822]: info: sendMpdCommand status took 8 milliseconds Dec 04 20:38:32 volumio volumio[822]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 04 20:38:32 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:32 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:32 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:32 volumio volumio[822]: info: ControllerMpd::pushState Dec 04 20:38:32 volumio volumio[822]: info: CoreCommandRouter::servicePushState Dec 04 20:38:32 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:32 volumio volumio[822]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2587,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClockClock - Someone Else","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Dec 04 20:38:32 volumio volumio[822]: verbose: CURRENT POSITION 0 Dec 04 20:38:32 volumio volumio[822]: info: CoreStateMachine::syncState stateService play Dec 04 20:38:32 volumio volumio[822]: info: CoreStateMachine::syncState currentStatus play Dec 04 20:38:32 volumio volumio[822]: info: Received an update from plugin. extracting info from payload Dec 04 20:38:32 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 04 20:38:32 volumio volumio[822]: info: CoreStateMachine::pushState Dec 04 20:38:32 volumio volumio[822]: info: CoreCommandRouter::volumioPushState Dec 04 20:38:32 volumio volumio[822]: info: ------------------------------ 30ms Dec 04 20:38:32 volumio volumio[822]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 04 20:38:32 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:32 volumio volumio[822]: info: ControllerMpd::pushState Dec 04 20:38:32 volumio volumio[822]: info: CoreCommandRouter::servicePushState Dec 04 20:38:32 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:32 volumio volumio[822]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2587,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClockClock - Someone Else","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Dec 04 20:38:32 volumio volumio[822]: verbose: CURRENT POSITION 0 Dec 04 20:38:32 volumio volumio[822]: info: CoreStateMachine::syncState stateService play Dec 04 20:38:32 volumio volumio[822]: info: CoreStateMachine::syncState currentStatus play Dec 04 20:38:32 volumio volumio[822]: info: Received an update from plugin. extracting info from payload Dec 04 20:38:32 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 04 20:38:32 volumio volumio[822]: info: CoreStateMachine::pushState Dec 04 20:38:32 volumio volumio[822]: info: CoreCommandRouter::volumioPushState Dec 04 20:38:32 volumio volumio[822]: info: ------------------------------ 40ms Dec 04 20:38:36 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Dec 04 20:38:37 volumio volumio[822]: info: READ Dec 04 20:38:37 volumio volumio[822]: info: Preload queue cleared Dec 04 20:38:38 volumio volumio[822]: info: Dec 04 20:38:38 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:38 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:38 volumio volumio[822]: info: Dec 04 20:38:38 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:38 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:38 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:38 volumio volumio[822]: info: ------------------------------ 4ms Dec 04 20:38:38 volumio volumio[822]: info: sendMpdCommand status took 3 milliseconds Dec 04 20:38:38 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:38 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:38 volumio volumio[822]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 04 20:38:38 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:38 volumio volumio[822]: info: ControllerMpd::pushState Dec 04 20:38:38 volumio volumio[822]: info: CoreCommandRouter::servicePushState Dec 04 20:38:38 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:38 volumio volumio[822]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7781,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Dec 04 20:38:38 volumio volumio[822]: verbose: CURRENT POSITION 0 Dec 04 20:38:38 volumio volumio[822]: info: CoreStateMachine::syncState stateService play Dec 04 20:38:38 volumio volumio[822]: info: CoreStateMachine::syncState currentStatus play Dec 04 20:38:38 volumio volumio[822]: info: Received an update from plugin. extracting info from payload Dec 04 20:38:38 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 04 20:38:38 volumio volumio[822]: info: CoreStateMachine::pushState Dec 04 20:38:38 volumio volumio[822]: info: CoreCommandRouter::volumioPushState Dec 04 20:38:38 volumio volumio[822]: info: ------------------------------ 20ms Dec 04 20:38:39 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Dec 04 20:38:40 volumio volumio[822]: info: Dec 04 20:38:40 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:40 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:40 volumio volumio[822]: info: Dec 04 20:38:40 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:40 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:40 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:40 volumio volumio[822]: info: ------------------------------ 3ms Dec 04 20:38:40 volumio volumio[822]: info: sendMpdCommand status took 2 milliseconds Dec 04 20:38:40 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:40 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:40 volumio volumio[822]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 04 20:38:40 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:40 volumio volumio[822]: info: ControllerMpd::pushState Dec 04 20:38:40 volumio volumio[822]: info: CoreCommandRouter::servicePushState Dec 04 20:38:40 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:40 volumio volumio[822]: verbose: STATE SERVICE {"status":"play","position":0,"seek":10684,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Bayerns bester Musikmix","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Dec 04 20:38:40 volumio volumio[822]: verbose: CURRENT POSITION 0 Dec 04 20:38:40 volumio volumio[822]: info: CoreStateMachine::syncState stateService play Dec 04 20:38:40 volumio volumio[822]: info: CoreStateMachine::syncState currentStatus play Dec 04 20:38:40 volumio volumio[822]: info: Received an update from plugin. extracting info from payload Dec 04 20:38:40 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 04 20:38:40 volumio volumio[822]: info: CoreStateMachine::pushState Dec 04 20:38:41 volumio volumio[822]: info: CoreCommandRouter::volumioPushState Dec 04 20:38:41 volumio volumio[822]: info: ------------------------------ 21ms Dec 04 20:38:41 volumio volumio[822]: info: Preload queue cleared Dec 04 20:38:42 volumio volumio[822]: info: Preload queue cleared Dec 04 20:38:42 volumio volumio[822]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::ClearQueue Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::stop Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::pushState Dec 04 20:38:42 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:42 volumio volumio[822]: info: CoreCommandRouter::volumioPushState Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::stPlaybackTimer Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::updateTrackBlock Dec 04 20:38:42 volumio volumio[822]: info: CorePlayQueue::getTrackBlock Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::serviceStop Dec 04 20:38:42 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:42 volumio volumio[822]: info: CoreCommandRouter::serviceStop Dec 04 20:38:42 volumio volumio[822]: info: [1670186322575] ControllerWebradio::stop Dec 04 20:38:42 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand stop Dec 04 20:38:42 volumio volumio[822]: info: CorePlayQueue::clearPlayQueue Dec 04 20:38:42 volumio volumio[822]: info: CorePlayQueue::saveQueue Dec 04 20:38:42 volumio volumio[822]: info: CoreCommandRouter::volumioPushQueue Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::addQueueItems Dec 04 20:38:42 volumio volumio[822]: info: CorePlayQueue::addQueueItems Dec 04 20:38:42 volumio volumio[822]: info: Preload queue cleared Dec 04 20:38:42 volumio volumio[822]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1729607 Dec 04 20:38:42 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 04 20:38:42 volumio volumio[822]: info: CoreCommandRouter::volumioPushQueue Dec 04 20:38:42 volumio volumio[822]: info: CorePlayQueue::saveQueue Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::updateTrackBlock Dec 04 20:38:42 volumio volumio[822]: info: CorePlayQueue::getTrackBlock Dec 04 20:38:42 volumio volumio[822]: info: CoreCommandRouter::volumioPlay Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::play index 0 Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::stop Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::play index undefined Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 04 20:38:42 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::startPlaybackTimer Dec 04 20:38:42 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:42 volumio volumio[822]: info: [1670186322607] ControllerWebradio::clearAddPlayTrack Dec 04 20:38:42 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand stop Dec 04 20:38:42 volumio volumio[822]: info: sendMpdCommand stop took 108 milliseconds Dec 04 20:38:42 volumio volumio[822]: info: Dec 04 20:38:42 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:42 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:42 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:42 volumio volumio[822]: info: sendMpdCommand stop took 79 milliseconds Dec 04 20:38:42 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand clear Dec 04 20:38:42 volumio volumio[822]: info: Dec 04 20:38:42 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:42 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:42 volumio volumio[822]: info: sendMpdCommand status took 4 milliseconds Dec 04 20:38:42 volumio volumio[822]: info: sendMpdCommand clear took 3 milliseconds Dec 04 20:38:42 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:42 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:42 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1729607" Dec 04 20:38:42 volumio volumio[822]: error: updateQueue error: null Dec 04 20:38:42 volumio volumio[822]: info: ------------------------------ 7ms Dec 04 20:38:42 volumio volumio[822]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 04 20:38:42 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:42 volumio volumio[822]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 04 20:38:42 volumio volumio[822]: info: ------------------------------ 14ms Dec 04 20:38:42 volumio volumio[822]: info: Dec 04 20:38:42 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:42 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:42 volumio volumio[822]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1729607" took 282 milliseconds Dec 04 20:38:42 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 04 20:38:42 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand play Dec 04 20:38:42 volumio volumio[822]: info: ------------------------------ 5ms Dec 04 20:38:42 volumio volumio[822]: info: sendMpdCommand play took 3 milliseconds Dec 04 20:38:44 volumio volumio[822]: info: Dec 04 20:38:44 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:44 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:44 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:44 volumio volumio[822]: info: Dec 04 20:38:44 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:44 volumio volumio[822]: info: sendMpdCommand status took 24 milliseconds Dec 04 20:38:44 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:44 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:44 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:44 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:44 volumio volumio[822]: info: sendMpdCommand status took 3 milliseconds Dec 04 20:38:44 volumio volumio[822]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 04 20:38:44 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:44 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:44 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:44 volumio volumio[822]: info: ControllerMpd::pushState Dec 04 20:38:44 volumio volumio[822]: info: CoreCommandRouter::servicePushState Dec 04 20:38:44 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:44 volumio volumio[822]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"70s_128","artist":"1.FM - Absolute 70's Pop (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/70s_128","trackType":""} Dec 04 20:38:44 volumio volumio[822]: verbose: CURRENT POSITION 0 Dec 04 20:38:44 volumio volumio[822]: info: CoreStateMachine::syncState stateService play Dec 04 20:38:44 volumio volumio[822]: info: CoreStateMachine::syncState currentStatus stop Dec 04 20:38:44 volumio volumio[822]: info: ------------------------------ 39ms Dec 04 20:38:44 volumio volumio[822]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 04 20:38:44 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:44 volumio volumio[822]: info: ControllerMpd::pushState Dec 04 20:38:44 volumio volumio[822]: info: CoreCommandRouter::servicePushState Dec 04 20:38:44 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:44 volumio volumio[822]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"70s_128","artist":"1.FM - Absolute 70's Pop (www.1.fm)","album":null,"uri":"http://185.33.21.112:80/70s_128","trackType":""} Dec 04 20:38:44 volumio volumio[822]: verbose: CURRENT POSITION 0 Dec 04 20:38:44 volumio volumio[822]: info: CoreStateMachine::syncState stateService play Dec 04 20:38:44 volumio volumio[822]: info: CoreStateMachine::syncState currentStatus play Dec 04 20:38:44 volumio volumio[822]: info: Received an update from plugin. extracting info from payload Dec 04 20:38:44 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 04 20:38:44 volumio volumio[822]: info: CoreStateMachine::pushState Dec 04 20:38:44 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:44 volumio volumio[822]: info: CoreCommandRouter::volumioPushState Dec 04 20:38:44 volumio volumio[822]: info: ------------------------------ 34ms Dec 04 20:38:44 volumio volumio[822]: info: Dec 04 20:38:44 volumio volumio[822]: ---------------------------- MPD announces system playlist update Dec 04 20:38:44 volumio volumio[822]: info: Ignoring MPD Status Update Dec 04 20:38:44 volumio volumio[822]: info: Dec 04 20:38:44 volumio volumio[822]: ---------------------------- MPD announces state update: player Dec 04 20:38:44 volumio volumio[822]: info: ControllerMpd::getState Dec 04 20:38:44 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status Dec 04 20:38:44 volumio volumio[822]: info: ------------------------------ 6ms Dec 04 20:38:44 volumio volumio[822]: info: sendMpdCommand status took 2 milliseconds Dec 04 20:38:44 volumio volumio[822]: verbose: ControllerMpd::parseState Dec 04 20:38:44 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 04 20:38:44 volumio volumio[822]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 04 20:38:44 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo Dec 04 20:38:44 volumio volumio[822]: info: ControllerMpd::pushState Dec 04 20:38:44 volumio volumio[822]: info: CoreCommandRouter::servicePushState Dec 04 20:38:44 volumio volumio[822]: info: CorePlayQueue::getTrack 0 Dec 04 20:38:44 volumio volumio[822]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Gerry Rafferty - Right Down The Line","artist":"1.FM - Absolute 70's Pop Radio","album":null,"uri":"http://185.33.21.112:80/70s_128","trackType":""} Dec 04 20:38:44 volumio volumio[822]: verbose: CURRENT POSITION 0 Dec 04 20:38:44 volumio volumio[822]: info: CoreStateMachine::syncState stateService play Dec 04 20:38:44 volumio volumio[822]: info: CoreStateMachine::syncState currentStatus play Dec 04 20:38:44 volumio volumio[822]: info: Received an update from plugin. extracting info from payload Dec 04 20:38:44 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 04 20:38:44 volumio volumio[822]: info: CoreStateMachine::pushState Dec 04 20:38:44 volumio volumio[822]: info: CoreCommandRouter::volumioPushState Dec 04 20:38:44 volumio volumio[822]: info: ------------------------------ 23ms Dec 04 20:38:50 volumio ntpd[629]: Soliciting pool server 115.165.161.155 Dec 04 20:38:53 volumio ntpd[629]: Soliciting pool server 103.130.217.41 Dec 04 20:38:53 volumio ntpd[629]: Soliciting pool server 27.71.27.209 Dec 04 20:38:56 volumio volumio[822]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 04 20:38:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 04 20:38:56 volumio volumio[822]: info: Received Get System Version Dec 04 20:38:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 04 20:38:56 volumio ntpd[629]: Soliciting pool server 2400:6760:0:3::23 Dec 04 20:39:02 volumio volumio-remote-updater[494]: No test mode Dec 04 20:39:02 volumio volumio-remote-updater[494]: No alpha test mode Dec 04 20:39:02 volumio volumio[822]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

 

NEW ADDITIONS



 

","title":"Update v3.757","updateavailable":true} Dec 04 20:39:04 volumio volumio[822]: info: CoreCommandRouter::Close All Modals sent Dec 04 20:39:12 volumio volumio[822]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 04 20:39:12 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 04 20:39:12 volumio volumio[822]: info: Received Get System Version Dec 04 20:39:12 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 04 20:39:17 volumio volumio[822]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 04 20:39:17 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 04 20:39:17 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 04 20:39:17 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 04 20:39:17 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 04 20:39:17 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 04 20:39:17 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 04 20:39:17 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 04 20:39:17 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 04 20:39:17 volumio volumio[822]: info: CoreCommandRouter::volumioGetBrowseSources Dec 04 20:39:17 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 04 20:39:17 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 04 20:39:21 volumio volumio[822]: info: Disabling MyMusic plugin upnp_browser Dec 04 20:39:21 volumio volumio[822]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesMedia Servers Dec 04 20:39:21 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 04 20:39:21 volumio volumio[822]: info: Disabling plugin upnp_browser Dec 04 20:39:21 volumio volumio[822]: info: Done. Dec 04 20:39:21 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 04 20:39:22 volumio volumio[822]: info: Disabling MyMusic plugin airplay_emulation Dec 04 20:39:22 volumio volumio[822]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Dec 04 20:39:22 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 04 20:39:22 volumio volumio[822]: info: Disabling plugin airplay_emulation Dec 04 20:39:22 volumio volumio[822]: info: Done. Dec 04 20:39:22 volumio sudo[1947]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Dec 04 20:39:22 volumio sudo[1947]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 04 20:39:22 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 04 20:39:22 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 04 20:39:22 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 04 20:39:22 volumio sudo[1947]: pam_unix(sudo:session): session closed for user root Dec 04 20:39:22 volumio volumio[822]: info: Shairport-Sync Stopped Dec 04 20:39:23 volumio volumio[822]: info: Disabling MyMusic plugin upnp Dec 04 20:39:24 volumio sudo[1952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Dec 04 20:39:24 volumio sudo[1952]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 04 20:39:24 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Dec 04 20:39:24 volumio volumio[822]: error: Upnp client error: Error: This socket has been ended by the other party Dec 04 20:39:25 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 04 20:39:29 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 04 20:39:33 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 04 20:39:36 volumio volumio[822]: info: Enabling MyMusic plugin upnp Dec 04 20:39:36 volumio volumio[822]: info: Enabling plugin upnp Dec 04 20:39:36 volumio volumio[822]: info: Loading plugin "upnp"... Dec 04 20:39:36 volumio volumio[822]: info: [1670186376009] Starting Upmpd Daemon Dec 04 20:39:36 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 04 20:39:36 volumio volumio[822]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 04 20:39:36 volumio volumio[822]: Error: listen EADDRINUSE: address already in use :::6599 Dec 04 20:39:36 volumio volumio[822]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Dec 04 20:39:36 volumio volumio[822]: at listenInCluster (net.js:1366:12) Dec 04 20:39:36 volumio volumio[822]: at Server.listen (net.js:1452:7) Dec 04 20:39:36 volumio volumio[822]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Dec 04 20:39:36 volumio volumio[822]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Dec 04 20:39:36 volumio volumio[822]: at Promise._successFn (/volumio/app/pluginmanager.js:1841:19) Dec 04 20:39:36 volumio volumio[822]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Dec 04 20:39:36 volumio volumio[822]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Dec 04 20:39:36 volumio volumio[822]: code: 'EADDRINUSE', Dec 04 20:39:36 volumio volumio[822]: errno: -98, Dec 04 20:39:36 volumio volumio[822]: syscall: 'listen', Dec 04 20:39:36 volumio volumio[822]: address: '::', Dec 04 20:39:36 volumio volumio[822]: port: 6599 Dec 04 20:39:36 volumio volumio[822]: } Dec 04 20:39:36 volumio volumio[822]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 04 20:39:36 volumio sudo[1987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2022-12-04 20:38 Dec 04 20:39:36 volumio sudo[1987]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="8e6823482d6af342172ec9fdc1c15b0dd02653d2" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 04 Dec 2022 08:41:29 PM CET" VOLUMIO_VERSION="3.396" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d460c75d04818d0f55c67627fa362668"