May 10 18:12:02 volumio-4 volumio[1034]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] May 10 18:12:02 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions May 10 18:12:02 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 10 18:12:02 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 10 18:12:02 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 10 18:12:02 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 10 18:12:02 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 10 18:12:02 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 10 18:12:02 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 10 18:12:02 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 10 18:12:02 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 10 18:12:02 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 10 18:12:02 volumio-4 sudo[4220]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 10 18:12:02 volumio-4 sudo[4222]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 10 18:12:02 volumio-4 sudo[4222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 10 18:12:02 volumio-4 sudo[4220]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 10 18:12:02 volumio-4 sudo[4220]: pam_unix(sudo:session): session closed for user root May 10 18:12:02 volumio-4 volumio[1034]: info: MPD Permissions set May 10 18:12:02 volumio-4 systemd[1]: Stopping mpd.service - Music Player Daemon... May 10 18:12:02 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioGetState May 10 18:12:02 volumio-4 systemd[1]: mpd.service: Deactivated successfully. May 10 18:12:02 volumio-4 systemd[1]: Stopped mpd.service - Music Player Daemon. May 10 18:12:02 volumio-4 systemd[1]: mpd.service: Consumed 8.102s CPU time. May 10 18:12:02 volumio-4 systemd[1]: mpd.socket: Deactivated successfully. May 10 18:12:02 volumio-4 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. May 10 18:12:02 volumio-4 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... May 10 18:12:02 volumio-4 volumio[1034]: error: [ytcr] Error connecting MPD: May 10 18:12:02 volumio-4 volumio[1034]: (Error) read ECONNRESET May 10 18:12:02 volumio-4 volumio[1034]: Error: read ECONNRESET May 10 18:12:02 volumio-4 volumio[1034]: at Pipe.onStreamRead (node:internal/stream_base_commons:217:20) May 10 18:12:02 volumio-4 volumio[1034]: Retrying in 5 seconds... May 10 18:12:02 volumio-4 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 10 18:12:02 volumio-4 systemd[1]: Starting mpd.service - Music Player Daemon... May 10 18:12:02 volumio-4 sudo[4231]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 10 18:12:02 volumio-4 sudo[4231]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 10 18:12:02 volumio-4 sudo[4231]: pam_unix(sudo:session): session closed for user root May 10 18:12:05 volumio-4 mpd[4233]: 2025-05-10T18:12:05 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 10 18:12:05 volumio-4 systemd[1]: Started mpd.service - Music Player Daemon. May 10 18:12:05 volumio-4 sudo[4222]: pam_unix(sudo:session): session closed for user root May 10 18:12:05 volumio-4 volumio[1034]: error: updateQueue error: null May 10 18:12:09 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioGetState May 10 18:12:13 volumio-4 volumio[1034]: info: Preload queue cleared May 10 18:12:13 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioAddQueueItems May 10 18:12:13 volumio-4 volumio[1034]: info: CoreStateMachine::addQueueItems May 10 18:12:13 volumio-4 volumio[1034]: info: CorePlayQueue::addQueueItems May 10 18:12:13 volumio-4 volumio[1034]: info: Preload queue cleared May 10 18:12:13 volumio-4 volumio[1034]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s84107 May 10 18:12:13 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 10 18:12:13 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushQueue May 10 18:12:13 volumio-4 volumio[1034]: info: CorePlayQueue::saveQueue May 10 18:12:13 volumio-4 volumio[1034]: info: CoreStateMachine::updateTrackBlock May 10 18:12:13 volumio-4 volumio[1034]: info: CorePlayQueue::getTrackBlock May 10 18:12:13 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPlay May 10 18:12:13 volumio-4 volumio[1034]: info: CoreStateMachine::play index 0 May 10 18:12:13 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 10 18:12:13 volumio-4 volumio[1034]: info: CoreStateMachine::stop May 10 18:12:13 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 10 18:12:13 volumio-4 volumio[1034]: info: CoreStateMachine::stPlaybackTimer May 10 18:12:13 volumio-4 volumio[1034]: info: CoreStateMachine::updateTrackBlock May 10 18:12:13 volumio-4 volumio[1034]: info: CorePlayQueue::getTrackBlock May 10 18:12:13 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:13 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 10 18:12:13 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 10 18:12:13 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:13 volumio-4 volumio[1034]: info: CoreStateMachine::serviceStop May 10 18:12:13 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 10 18:12:13 volumio-4 volumio[1034]: info: CoreCommandRouter::serviceStop May 10 18:12:13 volumio-4 volumio[1034]: info: [1746893533464] ControllerWebradio::stop May 10 18:12:13 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand stop May 10 18:12:13 volumio-4 volumio[1034]: info: sendMpdCommand stop took 15 milliseconds May 10 18:12:13 volumio-4 volumio[1034]: info: CoreStateMachine::play index undefined May 10 18:12:13 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 10 18:12:13 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 10 18:12:13 volumio-4 volumio[1034]: info: CoreStateMachine::startPlaybackTimer May 10 18:12:13 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 10 18:12:13 volumio-4 volumio[1034]: info: [1746893533480] ControllerWebradio::clearAddPlayTrack May 10 18:12:13 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand stop May 10 18:12:13 volumio-4 volumio[1034]: info: sendMpdCommand stop took 1 milliseconds May 10 18:12:13 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand clear May 10 18:12:13 volumio-4 volumio[1034]: info: May 10 18:12:13 volumio-4 volumio[1034]: ---------------------------- MPD announces system playlist update May 10 18:12:13 volumio-4 volumio[1034]: info: Ignoring MPD Status Update May 10 18:12:13 volumio-4 volumio[1034]: info: sendMpdCommand clear took 2 milliseconds May 10 18:12:13 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand load "https://stream.100p.nl" May 10 18:12:14 volumio-4 volumio[1034]: error: updateQueue error: null May 10 18:12:14 volumio-4 volumio[1034]: info: ------------------------------ 1392ms May 10 18:12:14 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand add "https://stream.100p.nl" May 10 18:12:14 volumio-4 volumio[1034]: info: May 10 18:12:14 volumio-4 volumio[1034]: ---------------------------- MPD announces system playlist update May 10 18:12:14 volumio-4 volumio[1034]: info: Ignoring MPD Status Update May 10 18:12:14 volumio-4 volumio[1034]: info: sendMpdCommand add "https://stream.100p.nl" took 1 milliseconds May 10 18:12:14 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService mpd May 10 18:12:14 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand play May 10 18:12:14 volumio-4 volumio[1034]: info: ------------------------------ 4ms May 10 18:12:14 volumio-4 volumio[1034]: info: sendMpdCommand play took 3 milliseconds May 10 18:12:16 volumio-4 volumio[1034]: info: May 10 18:12:16 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:16 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:16 volumio-4 volumio[1034]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 10 18:12:16 volumio-4 volumio[1034]: info: FusionDsp - ---- read samplerate from file: 44100 May 10 18:12:16 volumio-4 volumio[1034]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 10 18:12:16 volumio-4 volumio[1034]: info: May 10 18:12:16 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:16 volumio-4 volumio[1034]: info: sendMpdCommand status took 18 milliseconds May 10 18:12:16 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:16 volumio-4 volumio[1034]: info: sendMpdCommand status took 4 milliseconds May 10 18:12:16 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 3 milliseconds May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:16 volumio-4 kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error! May 10 18:12:16 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:16 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:16 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 10 18:12:16 volumio-4 volumio[1034]: 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":"stream.100p.nl","artist":null,"album":null,"uri":"https://stream.100p.nl","trackType":"nl"} May 10 18:12:16 volumio-4 volumio[1034]: verbose: CURRENT POSITION 0 May 10 18:12:16 volumio-4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 10 18:12:16 volumio-4 volumio[1034]: info: CoreStateMachine::syncState currentStatus stop May 10 18:12:16 volumio-4 volumio[1034]: info: ------------------------------ 25ms May 10 18:12:16 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 2 milliseconds May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:16 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:16 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:16 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 10 18:12:16 volumio-4 volumio[1034]: 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":"stream.100p.nl","artist":null,"album":null,"uri":"https://stream.100p.nl","trackType":"nl"} May 10 18:12:16 volumio-4 volumio[1034]: verbose: CURRENT POSITION 0 May 10 18:12:16 volumio-4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 10 18:12:16 volumio-4 volumio[1034]: info: CoreStateMachine::syncState currentStatus play May 10 18:12:16 volumio-4 volumio[1034]: info: Received an update from plugin. extracting info from payload May 10 18:12:16 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:16 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 10 18:12:16 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 10 18:12:16 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:16 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:16 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:16 volumio-4 volumio[1034]: info: ------------------------------ 42ms May 10 18:12:16 volumio-4 volumio[1034]: info: May 10 18:12:16 volumio-4 volumio[1034]: ---------------------------- MPD announces system playlist update May 10 18:12:16 volumio-4 volumio[1034]: info: Ignoring MPD Status Update May 10 18:12:16 volumio-4 volumio[1034]: info: May 10 18:12:16 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:16 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:16 volumio-4 volumio[1034]: info: May 10 18:12:16 volumio-4 volumio[1034]: ---------------------------- MPD announces system playlist update May 10 18:12:16 volumio-4 volumio[1034]: info: Ignoring MPD Status Update May 10 18:12:16 volumio-4 volumio[1034]: info: May 10 18:12:16 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:16 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:16 volumio-4 volumio[1034]: info: ------------------------------ 22ms May 10 18:12:16 volumio-4 volumio[1034]: info: sendMpdCommand status took 20 milliseconds May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:16 volumio-4 volumio[1034]: info: ------------------------------ 8ms May 10 18:12:16 volumio-4 volumio[1034]: info: sendMpdCommand status took 7 milliseconds May 10 18:12:16 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 6 milliseconds May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:16 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:16 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:16 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 10 18:12:16 volumio-4 volumio[1034]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Nate Smith - Fix What You Didn't Break","artist":"100%NL FM Stream","album":null,"uri":"https://stream.100p.nl","trackType":"nl"} May 10 18:12:16 volumio-4 volumio[1034]: verbose: CURRENT POSITION 0 May 10 18:12:16 volumio-4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 10 18:12:16 volumio-4 volumio[1034]: info: CoreStateMachine::syncState currentStatus play May 10 18:12:16 volumio-4 volumio[1034]: info: Received an update from plugin. extracting info from payload May 10 18:12:16 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:16 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 10 18:12:16 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:16 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:16 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:16 volumio-4 volumio[1034]: info: ------------------------------ 53ms May 10 18:12:16 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 26 milliseconds May 10 18:12:16 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:16 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:16 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:16 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 10 18:12:16 volumio-4 volumio[1034]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1854,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Nate Smith - Fix What You Didn't Break","artist":"100%NL FM Stream","album":null,"uri":"https://stream.100p.nl","trackType":"nl"} May 10 18:12:16 volumio-4 volumio[1034]: verbose: CURRENT POSITION 0 May 10 18:12:16 volumio-4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 10 18:12:16 volumio-4 volumio[1034]: info: CoreStateMachine::syncState currentStatus play May 10 18:12:16 volumio-4 volumio[1034]: info: Received an update from plugin. extracting info from payload May 10 18:12:16 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:16 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:16 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:16 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:16 volumio-4 volumio[1034]: info: ------------------------------ 61ms May 10 18:12:20 volumio-4 ntpd[849]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 May 10 18:12:20 volumio-4 ntpd[849]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 May 10 18:12:20 volumio-4 ntpd[849]: DNS: Pool skipping: 213.239.154.12 May 10 18:12:20 volumio-4 ntpd[849]: DNS: Pool skipping: 162.159.200.123 May 10 18:12:20 volumio-4 ntpd[849]: DNS: Pool taking: 83.98.155.30 May 10 18:12:20 volumio-4 ntpd[849]: DNS: Pool taking: 83.137.149.135 May 10 18:12:20 volumio-4 ntpd[849]: DNS: Pool taking: 2a02:a46d:7ac:1:213:95ff:fe0d:76ee May 10 18:12:20 volumio-4 ntpd[849]: DNS: Pool taking: 2001:bc8:1640:111:: May 10 18:12:20 volumio-4 ntpd[849]: DNS: Pool taking: 2a14:3f87:f002:2::123 May 10 18:12:20 volumio-4 ntpd[849]: DNS: Pool taking: 2a02:a464:cfa5::1 May 10 18:12:20 volumio-4 ntpd[849]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 May 10 18:12:21 volumio-4 volumio[1034]: info: Preload queue cleared May 10 18:12:21 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioAddQueueItems May 10 18:12:21 volumio-4 volumio[1034]: info: CoreStateMachine::addQueueItems May 10 18:12:21 volumio-4 volumio[1034]: info: CorePlayQueue::addQueueItems May 10 18:12:21 volumio-4 volumio[1034]: info: Preload queue cleared May 10 18:12:21 volumio-4 volumio[1034]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s67013 May 10 18:12:21 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 10 18:12:21 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushQueue May 10 18:12:21 volumio-4 volumio[1034]: info: CorePlayQueue::saveQueue May 10 18:12:21 volumio-4 volumio[1034]: info: CoreStateMachine::updateTrackBlock May 10 18:12:21 volumio-4 volumio[1034]: info: CorePlayQueue::getTrackBlock May 10 18:12:21 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPlay May 10 18:12:21 volumio-4 volumio[1034]: info: CoreStateMachine::play index 1 May 10 18:12:21 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 10 18:12:21 volumio-4 volumio[1034]: info: CoreStateMachine::stop May 10 18:12:21 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 10 18:12:21 volumio-4 volumio[1034]: info: CoreStateMachine::stPlaybackTimer May 10 18:12:21 volumio-4 volumio[1034]: info: CoreStateMachine::updateTrackBlock May 10 18:12:21 volumio-4 volumio[1034]: info: CorePlayQueue::getTrackBlock May 10 18:12:21 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:21 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 10 18:12:21 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 10 18:12:21 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:21 volumio-4 volumio[1034]: info: CoreStateMachine::serviceStop May 10 18:12:21 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 10 18:12:21 volumio-4 volumio[1034]: info: CoreCommandRouter::serviceStop May 10 18:12:21 volumio-4 volumio[1034]: info: [1746893541619] ControllerWebradio::stop May 10 18:12:21 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand stop May 10 18:12:21 volumio-4 volumio[1034]: info: May 10 18:12:21 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:21 volumio-4 volumio[1034]: info: sendMpdCommand stop took 19 milliseconds May 10 18:12:21 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:21 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:21 volumio-4 volumio[1034]: info: CoreStateMachine::play index undefined May 10 18:12:21 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 10 18:12:21 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 1 May 10 18:12:21 volumio-4 volumio[1034]: info: CoreStateMachine::startPlaybackTimer May 10 18:12:21 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 1 May 10 18:12:21 volumio-4 volumio[1034]: info: [1746893541640] ControllerWebradio::clearAddPlayTrack May 10 18:12:21 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand stop May 10 18:12:21 volumio-4 volumio[1034]: info: sendMpdCommand status took 2 milliseconds May 10 18:12:21 volumio-4 volumio[1034]: info: sendMpdCommand stop took 1 milliseconds May 10 18:12:21 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:21 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:21 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand clear May 10 18:12:21 volumio-4 volumio[1034]: info: May 10 18:12:21 volumio-4 volumio[1034]: ---------------------------- MPD announces system playlist update May 10 18:12:21 volumio-4 volumio[1034]: info: Ignoring MPD Status Update May 10 18:12:21 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 2 milliseconds May 10 18:12:21 volumio-4 volumio[1034]: info: sendMpdCommand clear took 2 milliseconds May 10 18:12:21 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:21 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand load "http://icecast.omroep.nl/radio4-bb-mp3" May 10 18:12:21 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:21 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:21 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:21 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 1 May 10 18:12:21 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 10 18:12:21 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:21 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 1 May 10 18:12:21 volumio-4 volumio[1034]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd May 10 18:12:21 volumio-4 volumio[1034]: info: ------------------------------ 18ms May 10 18:12:21 volumio-4 volumio[1034]: error: updateQueue error: null May 10 18:12:21 volumio-4 volumio[1034]: info: ------------------------------ 15ms May 10 18:12:21 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand add "http://icecast.omroep.nl/radio4-bb-mp3" May 10 18:12:21 volumio-4 volumio[1034]: info: May 10 18:12:21 volumio-4 volumio[1034]: ---------------------------- MPD announces system playlist update May 10 18:12:21 volumio-4 volumio[1034]: info: Ignoring MPD Status Update May 10 18:12:21 volumio-4 volumio[1034]: info: sendMpdCommand add "http://icecast.omroep.nl/radio4-bb-mp3" took 1 milliseconds May 10 18:12:21 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService mpd May 10 18:12:21 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand play May 10 18:12:21 volumio-4 volumio[1034]: info: ------------------------------ 2ms May 10 18:12:21 volumio-4 volumio[1034]: info: sendMpdCommand play took 1 milliseconds May 10 18:12:21 volumio-4 volumio[1034]: info: May 10 18:12:21 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:21 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:21 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:21 volumio-4 volumio[1034]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 May 10 18:12:21 volumio-4 volumio[1034]: info: FusionDsp - ---- read samplerate from file: 48000 May 10 18:12:21 volumio-4 volumio[1034]: info: camilladsp stopping service pid 4234... May 10 18:12:22 volumio-4 volumio[1034]: grep: /proc/4234/cmdline: binary file matches May 10 18:12:22 volumio-4 volumio[1034]: grep: /proc/4234/cmdline: binary file matches May 10 18:12:22 volumio-4 volumio[1034]: grep: /proc/4234/cmdline: binary file matches May 10 18:12:22 volumio-4 volumio[1034]: grep: /proc/4234/cmdline: binary file matches May 10 18:12:22 volumio-4 volumio[1034]: grep: /proc/4234/cmdline: binary file matches May 10 18:12:22 volumio-4 volumio[1034]: info: camilladsp service terminated, instance 1 May 10 18:12:22 volumio-4 volumio[1034]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 10 18:12:22 volumio-4 volumio[1034]: info: camilladsp service started and running in background, instance 1 May 10 18:12:22 volumio-4 volumio[1034]: info: May 10 18:12:22 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:22 volumio-4 volumio[1034]: info: sendMpdCommand status took 560 milliseconds May 10 18:12:22 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:22 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:22 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:22 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:22 volumio-4 volumio[1034]: info: May 10 18:12:22 volumio-4 volumio[1034]: ---------------------------- MPD announces system playlist update May 10 18:12:22 volumio-4 volumio[1034]: info: Ignoring MPD Status Update May 10 18:12:22 volumio-4 volumio[1034]: info: May 10 18:12:22 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:22 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:22 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:22 volumio-4 volumio[1034]: info: sendMpdCommand status took 7 milliseconds May 10 18:12:22 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 7 milliseconds May 10 18:12:22 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:22 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:22 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:22 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:22 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:22 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 1 May 10 18:12:22 volumio-4 volumio[1034]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Mahler, Gustav - Symfonie nr.5 in cis kl.t. - deel IV, \"Adagietto. Sehr langsam\"","artist":"NPO Klassiek","album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} May 10 18:12:22 volumio-4 volumio[1034]: verbose: CURRENT POSITION 1 May 10 18:12:22 volumio-4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 10 18:12:22 volumio-4 volumio[1034]: info: CoreStateMachine::syncState currentStatus stop May 10 18:12:22 volumio-4 volumio[1034]: info: ------------------------------ 570ms May 10 18:12:22 volumio-4 volumio[1034]: info: ------------------------------ 16ms May 10 18:12:22 volumio-4 volumio[1034]: info: sendMpdCommand status took 17 milliseconds May 10 18:12:22 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 16 milliseconds May 10 18:12:22 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:22 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:22 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:22 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:22 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:22 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 1 May 10 18:12:22 volumio-4 volumio[1034]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Mahler, Gustav - Symfonie nr.5 in cis kl.t. - deel IV, \"Adagietto. Sehr langsam\"","artist":"NPO Klassiek","album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} May 10 18:12:22 volumio-4 volumio[1034]: verbose: CURRENT POSITION 1 May 10 18:12:22 volumio-4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 10 18:12:22 volumio-4 volumio[1034]: info: CoreStateMachine::syncState currentStatus play May 10 18:12:22 volumio-4 volumio[1034]: info: Received an update from plugin. extracting info from payload May 10 18:12:22 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:22 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 10 18:12:22 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:22 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:22 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:22 volumio-4 kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error! May 10 18:12:22 volumio-4 volumio[1034]: info: ------------------------------ 56ms May 10 18:12:22 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 32 milliseconds May 10 18:12:22 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:22 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:22 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:22 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 1 May 10 18:12:22 volumio-4 volumio[1034]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Mahler, Gustav - Symfonie nr.5 in cis kl.t. - deel IV, \"Adagietto. Sehr langsam\"","artist":"NPO Klassiek","album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} May 10 18:12:22 volumio-4 volumio[1034]: verbose: CURRENT POSITION 1 May 10 18:12:22 volumio-4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 10 18:12:22 volumio-4 volumio[1034]: info: CoreStateMachine::syncState currentStatus play May 10 18:12:22 volumio-4 volumio[1034]: info: Received an update from plugin. extracting info from payload May 10 18:12:22 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:22 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:22 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:22 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:22 volumio-4 volumio[1034]: info: ------------------------------ 82ms May 10 18:12:36 volumio-4 volumio[1034]: info: Preload queue cleared May 10 18:12:36 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioAddQueueItems May 10 18:12:36 volumio-4 volumio[1034]: info: CoreStateMachine::addQueueItems May 10 18:12:36 volumio-4 volumio[1034]: info: CorePlayQueue::addQueueItems May 10 18:12:36 volumio-4 volumio[1034]: info: Preload queue cleared May 10 18:12:36 volumio-4 volumio[1034]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s98586 May 10 18:12:36 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 10 18:12:36 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushQueue May 10 18:12:36 volumio-4 volumio[1034]: info: CorePlayQueue::saveQueue May 10 18:12:36 volumio-4 volumio[1034]: info: CoreStateMachine::updateTrackBlock May 10 18:12:36 volumio-4 volumio[1034]: info: CorePlayQueue::getTrackBlock May 10 18:12:36 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPlay May 10 18:12:36 volumio-4 volumio[1034]: info: CoreStateMachine::play index 2 May 10 18:12:36 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 10 18:12:36 volumio-4 volumio[1034]: info: CoreStateMachine::stop May 10 18:12:36 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 10 18:12:36 volumio-4 volumio[1034]: info: CoreStateMachine::stPlaybackTimer May 10 18:12:36 volumio-4 volumio[1034]: info: CoreStateMachine::updateTrackBlock May 10 18:12:36 volumio-4 volumio[1034]: info: CorePlayQueue::getTrackBlock May 10 18:12:36 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:36 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 1 May 10 18:12:36 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 10 18:12:36 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:36 volumio-4 volumio[1034]: info: CoreStateMachine::serviceStop May 10 18:12:36 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 1 May 10 18:12:36 volumio-4 volumio[1034]: info: CoreCommandRouter::serviceStop May 10 18:12:36 volumio-4 volumio[1034]: info: [1746893556442] ControllerWebradio::stop May 10 18:12:36 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand stop May 10 18:12:36 volumio-4 volumio[1034]: info: May 10 18:12:36 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:36 volumio-4 volumio[1034]: info: sendMpdCommand stop took 11 milliseconds May 10 18:12:36 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:36 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:36 volumio-4 volumio[1034]: info: CoreStateMachine::play index undefined May 10 18:12:36 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 10 18:12:36 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 2 May 10 18:12:36 volumio-4 volumio[1034]: info: CoreStateMachine::startPlaybackTimer May 10 18:12:36 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 2 May 10 18:12:36 volumio-4 volumio[1034]: info: [1746893556456] ControllerWebradio::clearAddPlayTrack May 10 18:12:36 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand stop May 10 18:12:36 volumio-4 volumio[1034]: info: sendMpdCommand status took 3 milliseconds May 10 18:12:36 volumio-4 volumio[1034]: info: sendMpdCommand stop took 3 milliseconds May 10 18:12:36 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:36 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:36 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand clear May 10 18:12:36 volumio-4 volumio[1034]: info: May 10 18:12:36 volumio-4 volumio[1034]: ---------------------------- MPD announces system playlist update May 10 18:12:36 volumio-4 volumio[1034]: info: Ignoring MPD Status Update May 10 18:12:36 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 2 milliseconds May 10 18:12:36 volumio-4 volumio[1034]: info: sendMpdCommand clear took 2 milliseconds May 10 18:12:36 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:36 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand load "https://stream.slam.nl?dist=tunein" May 10 18:12:36 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:36 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:36 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:36 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 2 May 10 18:12:36 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 10 18:12:36 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:36 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 2 May 10 18:12:36 volumio-4 volumio[1034]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd May 10 18:12:36 volumio-4 volumio[1034]: info: ------------------------------ 22ms May 10 18:12:36 volumio-4 volumio[1034]: error: updateQueue error: null May 10 18:12:36 volumio-4 volumio[1034]: info: ------------------------------ 17ms May 10 18:12:38 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand add "https://stream.slam.nl?dist=tunein" May 10 18:12:38 volumio-4 volumio[1034]: info: May 10 18:12:38 volumio-4 volumio[1034]: ---------------------------- MPD announces system playlist update May 10 18:12:38 volumio-4 volumio[1034]: info: Ignoring MPD Status Update May 10 18:12:38 volumio-4 volumio[1034]: info: sendMpdCommand add "https://stream.slam.nl?dist=tunein" took 1 milliseconds May 10 18:12:38 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService mpd May 10 18:12:38 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand play May 10 18:12:38 volumio-4 volumio[1034]: info: ------------------------------ 3ms May 10 18:12:38 volumio-4 volumio[1034]: info: sendMpdCommand play took 3 milliseconds May 10 18:12:39 volumio-4 volumio[1034]: info: May 10 18:12:39 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:39 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:39 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:39 volumio-4 volumio[1034]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 10 18:12:39 volumio-4 volumio[1034]: info: FusionDsp - ---- read samplerate from file: 44100 May 10 18:12:39 volumio-4 volumio[1034]: info: camilladsp stopping service pid 4382... May 10 18:12:39 volumio-4 volumio[1034]: grep: /proc/4382/cmdline: binary file matches May 10 18:12:39 volumio-4 volumio[1034]: info: camilladsp service terminated, instance 1 May 10 18:12:39 volumio-4 volumio[1034]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 10 18:12:39 volumio-4 volumio[1034]: info: camilladsp service started and running in background, instance 1 May 10 18:12:39 volumio-4 volumio[1034]: info: May 10 18:12:39 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:39 volumio-4 volumio[1034]: info: sendMpdCommand status took 142 milliseconds May 10 18:12:39 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:39 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:39 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:39 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:39 volumio-4 volumio[1034]: info: May 10 18:12:39 volumio-4 volumio[1034]: ---------------------------- MPD announces system playlist update May 10 18:12:39 volumio-4 volumio[1034]: info: Ignoring MPD Status Update May 10 18:12:39 volumio-4 volumio[1034]: info: May 10 18:12:39 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:39 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:39 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:39 volumio-4 volumio[1034]: info: sendMpdCommand status took 3 milliseconds May 10 18:12:39 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 3 milliseconds May 10 18:12:39 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:39 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:39 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:39 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:39 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:39 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 2 May 10 18:12:39 volumio-4 volumio[1034]: 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":"2Pac & Dr. Dre - California Love","artist":"SLAM! FM Stream","album":null,"uri":"https://stream.slam.nl?dist=tunein","trackType":""} May 10 18:12:39 volumio-4 volumio[1034]: verbose: CURRENT POSITION 2 May 10 18:12:39 volumio-4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 10 18:12:39 volumio-4 volumio[1034]: info: CoreStateMachine::syncState currentStatus stop May 10 18:12:39 volumio-4 volumio[1034]: info: ------------------------------ 150ms May 10 18:12:39 volumio-4 volumio[1034]: info: ------------------------------ 14ms May 10 18:12:39 volumio-4 volumio[1034]: info: sendMpdCommand status took 14 milliseconds May 10 18:12:39 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 13 milliseconds May 10 18:12:39 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:39 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:39 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:39 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:39 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:39 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 2 May 10 18:12:39 volumio-4 volumio[1034]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"2Pac & Dr. Dre - California Love","artist":"SLAM! FM Stream","album":null,"uri":"https://stream.slam.nl?dist=tunein","trackType":""} May 10 18:12:39 volumio-4 volumio[1034]: verbose: CURRENT POSITION 2 May 10 18:12:39 volumio-4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 10 18:12:39 volumio-4 volumio[1034]: info: CoreStateMachine::syncState currentStatus play May 10 18:12:39 volumio-4 volumio[1034]: info: Received an update from plugin. extracting info from payload May 10 18:12:39 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:39 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 10 18:12:39 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:39 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:39 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:39 volumio-4 kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error! May 10 18:12:39 volumio-4 volumio[1034]: info: ------------------------------ 47ms May 10 18:12:39 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 30 milliseconds May 10 18:12:39 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:39 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:39 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:39 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 2 May 10 18:12:39 volumio-4 volumio[1034]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"2Pac & Dr. Dre - California Love","artist":"SLAM! FM Stream","album":null,"uri":"https://stream.slam.nl?dist=tunein","trackType":""} May 10 18:12:39 volumio-4 volumio[1034]: verbose: CURRENT POSITION 2 May 10 18:12:39 volumio-4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 10 18:12:39 volumio-4 volumio[1034]: info: CoreStateMachine::syncState currentStatus play May 10 18:12:39 volumio-4 volumio[1034]: info: Received an update from plugin. extracting info from payload May 10 18:12:39 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:39 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:39 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:39 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:39 volumio-4 volumio[1034]: info: ------------------------------ 71ms May 10 18:12:45 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 10 18:12:45 volumio-4 volumio[1034]: info: TuneIn handleBrowseUri: tunein/browse/?id=r100385 May 10 18:12:45 volumio-4 volumio[1034]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r100385 May 10 18:12:45 volumio-4 volumio[1034]: info: Preload queue cleared May 10 18:12:45 volumio-4 volumio[1034]: info: Preload queue cleared May 10 18:12:48 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 10 18:12:48 volumio-4 volumio[1034]: info: TuneIn handleBrowseUri: tunein/browse/?id=r100385&filter=s:popular May 10 18:12:48 volumio-4 volumio[1034]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r100385&filter=s:popular May 10 18:12:49 volumio-4 volumio[1034]: info: Preload queue cleared May 10 18:12:51 volumio-4 volumio[1034]: info: Preload queue cleared May 10 18:12:51 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioAddQueueItems May 10 18:12:51 volumio-4 volumio[1034]: info: CoreStateMachine::addQueueItems May 10 18:12:51 volumio-4 volumio[1034]: info: CorePlayQueue::addQueueItems May 10 18:12:51 volumio-4 volumio[1034]: info: Preload queue cleared May 10 18:12:51 volumio-4 volumio[1034]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s9483&filter=s:popular May 10 18:12:51 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 10 18:12:51 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushQueue May 10 18:12:51 volumio-4 volumio[1034]: info: CorePlayQueue::saveQueue May 10 18:12:51 volumio-4 volumio[1034]: info: CoreStateMachine::updateTrackBlock May 10 18:12:51 volumio-4 volumio[1034]: info: CorePlayQueue::getTrackBlock May 10 18:12:51 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPlay May 10 18:12:51 volumio-4 volumio[1034]: info: CoreStateMachine::play index 3 May 10 18:12:51 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 10 18:12:51 volumio-4 volumio[1034]: info: CoreStateMachine::stop May 10 18:12:51 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 10 18:12:51 volumio-4 volumio[1034]: info: CoreStateMachine::stPlaybackTimer May 10 18:12:51 volumio-4 volumio[1034]: info: CoreStateMachine::updateTrackBlock May 10 18:12:51 volumio-4 volumio[1034]: info: CorePlayQueue::getTrackBlock May 10 18:12:51 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:51 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 2 May 10 18:12:51 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 10 18:12:51 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:51 volumio-4 volumio[1034]: info: CoreStateMachine::serviceStop May 10 18:12:51 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 2 May 10 18:12:51 volumio-4 volumio[1034]: info: CoreCommandRouter::serviceStop May 10 18:12:51 volumio-4 volumio[1034]: info: [1746893571691] ControllerWebradio::stop May 10 18:12:51 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand stop May 10 18:12:51 volumio-4 volumio[1034]: info: May 10 18:12:51 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:51 volumio-4 volumio[1034]: info: sendMpdCommand stop took 20 milliseconds May 10 18:12:51 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:51 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:51 volumio-4 volumio[1034]: info: CoreStateMachine::play index undefined May 10 18:12:51 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 10 18:12:51 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 3 May 10 18:12:51 volumio-4 volumio[1034]: info: CoreStateMachine::startPlaybackTimer May 10 18:12:51 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 3 May 10 18:12:51 volumio-4 volumio[1034]: info: [1746893571712] ControllerWebradio::clearAddPlayTrack May 10 18:12:51 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand stop May 10 18:12:51 volumio-4 volumio[1034]: info: sendMpdCommand status took 3 milliseconds May 10 18:12:51 volumio-4 volumio[1034]: info: sendMpdCommand stop took 2 milliseconds May 10 18:12:51 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:51 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:51 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand clear May 10 18:12:51 volumio-4 volumio[1034]: info: May 10 18:12:51 volumio-4 volumio[1034]: ---------------------------- MPD announces system playlist update May 10 18:12:51 volumio-4 volumio[1034]: info: Ignoring MPD Status Update May 10 18:12:51 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 6 milliseconds May 10 18:12:51 volumio-4 volumio[1034]: info: sendMpdCommand clear took 6 milliseconds May 10 18:12:51 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:51 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand load "http://icecast.omroep.nl/radio2-bb-mp3" May 10 18:12:51 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:51 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:51 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:51 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 3 May 10 18:12:51 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 10 18:12:51 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:51 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 3 May 10 18:12:51 volumio-4 volumio[1034]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd May 10 18:12:51 volumio-4 volumio[1034]: info: ------------------------------ 23ms May 10 18:12:51 volumio-4 volumio[1034]: error: updateQueue error: null May 10 18:12:51 volumio-4 volumio[1034]: info: ------------------------------ 16ms May 10 18:12:51 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand add "http://icecast.omroep.nl/radio2-bb-mp3" May 10 18:12:51 volumio-4 volumio[1034]: info: sendMpdCommand add "http://icecast.omroep.nl/radio2-bb-mp3" took 1 milliseconds May 10 18:12:51 volumio-4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService mpd May 10 18:12:51 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand play May 10 18:12:51 volumio-4 volumio[1034]: info: May 10 18:12:51 volumio-4 volumio[1034]: ---------------------------- MPD announces system playlist update May 10 18:12:51 volumio-4 volumio[1034]: info: Ignoring MPD Status Update May 10 18:12:51 volumio-4 volumio[1034]: info: sendMpdCommand play took 2 milliseconds May 10 18:12:51 volumio-4 volumio[1034]: info: ------------------------------ 2ms May 10 18:12:51 volumio-4 volumio[1034]: info: May 10 18:12:51 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:51 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:51 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:51 volumio-4 volumio[1034]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 May 10 18:12:51 volumio-4 volumio[1034]: info: FusionDsp - ---- read samplerate from file: 48000 May 10 18:12:51 volumio-4 volumio[1034]: info: camilladsp stopping service pid 4416... May 10 18:12:52 volumio-4 volumio[1034]: grep: /proc/4416/cmdline: binary file matches May 10 18:12:52 volumio-4 volumio[1034]: grep: /proc/4416/cmdline: binary file matches May 10 18:12:52 volumio-4 volumio[1034]: grep: /proc/4416/cmdline: binary file matches May 10 18:12:52 volumio-4 volumio[1034]: grep: /proc/4416/cmdline: binary file matches May 10 18:12:52 volumio-4 volumio[1034]: info: camilladsp service terminated, instance 1 May 10 18:12:52 volumio-4 volumio[1034]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 10 18:12:52 volumio-4 volumio[1034]: info: camilladsp service started and running in background, instance 1 May 10 18:12:52 volumio-4 volumio[1034]: info: May 10 18:12:52 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:52 volumio-4 volumio[1034]: info: sendMpdCommand status took 450 milliseconds May 10 18:12:52 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:52 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:52 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:52 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:52 volumio-4 volumio[1034]: info: May 10 18:12:52 volumio-4 volumio[1034]: ---------------------------- MPD announces system playlist update May 10 18:12:52 volumio-4 volumio[1034]: info: Ignoring MPD Status Update May 10 18:12:52 volumio-4 volumio[1034]: info: May 10 18:12:52 volumio-4 volumio[1034]: ---------------------------- MPD announces state update: player May 10 18:12:52 volumio-4 volumio[1034]: info: ControllerMpd::getState May 10 18:12:52 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 10 18:12:52 volumio-4 volumio[1034]: info: sendMpdCommand status took 4 milliseconds May 10 18:12:52 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 4 milliseconds May 10 18:12:52 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:52 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:52 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:52 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:52 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:52 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 3 May 10 18:12:52 volumio-4 volumio[1034]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Inxs - New sensation","artist":"NPO Radio2","album":null,"uri":"http://icecast.omroep.nl/radio2-bb-mp3","trackType":""} May 10 18:12:52 volumio-4 volumio[1034]: verbose: CURRENT POSITION 3 May 10 18:12:52 volumio-4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 10 18:12:52 volumio-4 volumio[1034]: info: CoreStateMachine::syncState currentStatus stop May 10 18:12:52 volumio-4 volumio[1034]: info: ------------------------------ 457ms May 10 18:12:52 volumio-4 volumio[1034]: info: ------------------------------ 14ms May 10 18:12:52 volumio-4 volumio[1034]: info: sendMpdCommand status took 14 milliseconds May 10 18:12:52 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 13 milliseconds May 10 18:12:52 volumio-4 volumio[1034]: verbose: ControllerMpd::parseState May 10 18:12:52 volumio-4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 10 18:12:52 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:52 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:52 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:52 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 3 May 10 18:12:52 volumio-4 volumio[1034]: verbose: STATE SERVICE {"status":"play","position":0,"seek":483,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Inxs - New sensation","artist":"NPO Radio2","album":null,"uri":"http://icecast.omroep.nl/radio2-bb-mp3","trackType":""} May 10 18:12:52 volumio-4 volumio[1034]: verbose: CURRENT POSITION 3 May 10 18:12:52 volumio-4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 10 18:12:52 volumio-4 volumio[1034]: info: CoreStateMachine::syncState currentStatus play May 10 18:12:52 volumio-4 volumio[1034]: info: Received an update from plugin. extracting info from payload May 10 18:12:52 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:52 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 10 18:12:52 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:52 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:52 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:52 volumio-4 kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error! May 10 18:12:52 volumio-4 volumio[1034]: info: ------------------------------ 50ms May 10 18:12:52 volumio-4 volumio[1034]: info: sendMpdCommand playlistinfo took 35 milliseconds May 10 18:12:52 volumio-4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 10 18:12:52 volumio-4 volumio[1034]: info: ControllerMpd::pushState May 10 18:12:52 volumio-4 volumio[1034]: info: CoreCommandRouter::servicePushState May 10 18:12:52 volumio-4 volumio[1034]: info: CorePlayQueue::getTrack 3 May 10 18:12:52 volumio-4 volumio[1034]: verbose: STATE SERVICE {"status":"play","position":0,"seek":483,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Inxs - New sensation","artist":"NPO Radio2","album":null,"uri":"http://icecast.omroep.nl/radio2-bb-mp3","trackType":""} May 10 18:12:52 volumio-4 volumio[1034]: verbose: CURRENT POSITION 3 May 10 18:12:52 volumio-4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 10 18:12:52 volumio-4 volumio[1034]: info: CoreStateMachine::syncState currentStatus play May 10 18:12:52 volumio-4 volumio[1034]: info: Received an update from plugin. extracting info from payload May 10 18:12:52 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:52 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:52 volumio-4 volumio[1034]: info: CoreStateMachine::pushState May 10 18:12:52 volumio-4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 10 18:12:52 volumio-4 volumio[1034]: info: ------------------------------ 78ms May 10 18:13:02 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 10 18:13:02 volumio-4 volumio[1034]: info: TuneIn handleBrowseUri: tunein/browse/?offset=26&id=r100385&filter=s:popular May 10 18:13:02 volumio-4 volumio[1034]: info: [TuneIn] Fetching (browse) results For tunein/browse/?offset=26&id=r100385&filter=s:popular May 10 18:13:03 volumio-4 volumio[1034]: info: Preload queue cleared May 10 18:13:09 volumio-4 volumio[1034]: Searching plugin music_service/webradio May 10 18:13:09 volumio-4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: webradio , search May 10 18:13:09 volumio-4 volumio[1034]: Use XMLElement.setAttribute instead May 10 18:13:09 volumio-4 volumio[1034]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 10 18:13:09 volumio-4 volumio[1034]: TypeError: children[i].attr(...).value is not a function May 10 18:13:09 volumio-4 volumio[1034]: at /volumio/app/plugins/music_service/webradio/index.js:956:46 May 10 18:13:09 volumio-4 volumio[1034]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) May 10 18:13:09 volumio-4 volumio[1034]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 10 18:13:10 volumio-4 sudo[4563]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-10 18:12' May 10 18:13:10 volumio-4 sudo[4563]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="10fe97f56e977d23bd5c31bb51c11a06f700d721" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat May 10 21:45:05 UTC 2025" VOLUMIO_VERSION="0.065" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="9d0e0ad86d94167193da8e63f62f5e4e"