-- Logs begin at Sun 2025-01-19 10:28:33 UTC, end at Sun 2025-01-19 11:56:41 UTC. -- Jan 19 11:55:06 volumio kernel: usb 1-1.3: new high-speed USB device number 7 using dwc_otg Jan 19 11:55:06 volumio kernel: usb 1-1.3: New USB device found, idVendor=0718, idProduct=0628, bcdDevice= 1.10 Jan 19 11:55:06 volumio kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jan 19 11:55:06 volumio kernel: usb 1-1.3: Product: Trans-It Drive Jan 19 11:55:06 volumio kernel: usb 1-1.3: Manufacturer: TDKMedia Jan 19 11:55:06 volumio kernel: usb 1-1.3: SerialNumber: 079A1603EC8EBA8E Jan 19 11:55:06 volumio kernel: usb-storage 1-1.3:1.0: USB Mass Storage device detected Jan 19 11:55:06 volumio kernel: scsi host2: usb-storage 1-1.3:1.0 Jan 19 11:55:07 volumio kernel: scsi 2:0:0:0: Direct-Access TDKMedia Trans-It Drive PMAP PQ: 0 ANSI: 0 CCS Jan 19 11:55:07 volumio kernel: sd 2:0:0:0: Attached scsi generic sg2 type 0 Jan 19 11:55:09 volumio kernel: sd 2:0:0:0: [sdc] 7806976 512-byte logical blocks: (4.00 GB/3.72 GiB) Jan 19 11:55:09 volumio kernel: sd 2:0:0:0: [sdc] Write Protect is off Jan 19 11:55:09 volumio kernel: sd 2:0:0:0: [sdc] Mode Sense: 23 00 00 00 Jan 19 11:55:09 volumio kernel: sd 2:0:0:0: [sdc] No Caching mode page found Jan 19 11:55:09 volumio kernel: sd 2:0:0:0: [sdc] Assuming drive cache: write through Jan 19 11:55:09 volumio kernel: sdc: sdc1 Jan 19 11:55:09 volumio kernel: sd 2:0:0:0: [sdc] Attached SCSI removable disk Jan 19 11:55:09 volumio udisks-glue[612]: Device file /dev/sdc inserted Jan 19 11:55:09 volumio udisks-glue[612]: Device file /dev/sdc1 inserted Jan 19 11:55:09 volumio udisks-glue[612]: Trying to automount /dev/sdc1... Jan 19 11:55:09 volumio kernel: FAT-fs (sdc1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jan 19 11:55:09 volumio udisks-glue[612]: Successfully automounted /dev/sdc1 at /media/SDCARD Jan 19 11:55:09 volumio udisks-glue[612]: Device file /dev/sdc1 mounted at /media/SDCARD Jan 19 11:55:09 volumio udisks-glue[612]: /radioclassique-high: Evans Bill - Make Someone happy - Album "Alone" : Bill Evans, piano Jan 19 11:55:09 volumio udisks-glue[612]: [playing] #1/1 5:00/0:00 (0%) Jan 19 11:55:09 volumio udisks-glue[612]: Updating DB (#1) ... Jan 19 11:55:09 volumio udisks-glue[612]: volume: 40% repeat: off random: off single: off consume: off Jan 19 11:55:16 volumio volumio[1096]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 19 11:55:16 volumio volumio[1096]: info: CoreStateMachine::ClearQueue Jan 19 11:55:16 volumio volumio[1096]: info: CoreStateMachine::stop Jan 19 11:55:16 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:55:16 volumio volumio[1096]: verbose: UNSET VOLATILE Jan 19 11:55:16 volumio volumio[1096]: info: CoreStateMachine::stPlaybackTimer Jan 19 11:55:16 volumio volumio[1096]: info: CoreStateMachine::updateTrackBlock Jan 19 11:55:16 volumio volumio[1096]: info: CorePlayQueue::getTrackBlock Jan 19 11:55:16 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:55:16 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:16 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:55:16 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:55:16 volumio volumio[1096]: info: CoreStateMachine::serviceStop Jan 19 11:55:16 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:16 volumio volumio[1096]: info: CoreCommandRouter::serviceStop Jan 19 11:55:16 volumio volumio[1096]: info: [1737287716879] ControllerWebradio::stop Jan 19 11:55:16 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Jan 19 11:55:16 volumio volumio[1096]: info: CorePlayQueue::clearPlayQueue Jan 19 11:55:16 volumio volumio[1096]: info: CorePlayQueue::saveQueue Jan 19 11:55:16 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:55:16 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:55:16 volumio volumio[1096]: info: CoreCommandRouter::volumioPushQueue Jan 19 11:55:16 volumio volumio[1096]: info: CoreStateMachine::addQueueItems Jan 19 11:55:16 volumio volumio[1096]: info: CorePlayQueue::addQueueItems Jan 19 11:55:16 volumio volumio[1096]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s16492 Jan 19 11:55:16 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 19 11:55:16 volumio volumio[1096]: info: sendMpdCommand stop took 101 milliseconds Jan 19 11:55:16 volumio volumio[1096]: info: Jan 19 11:55:16 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:55:16 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:55:16 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:55:16 volumio volumio[1096]: info: sendMpdCommand status took 10 milliseconds Jan 19 11:55:16 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:55:17 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:55:17 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 19 11:55:17 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:55:17 volumio volumio[1096]: info: ControllerMpd::pushState Jan 19 11:55:17 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Jan 19 11:55:17 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:55:17 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:17 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:55:17 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:55:17 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:17 volumio volumio[1096]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Evans Bill - Make Someone happy - Album \"Alone\" : Bill Evans, piano","artist":"/radioclassique-high","album":null,"uri":"http://radioclassique.ice.infomaniak.ch/radioclassique-high.mp3","trackType":"mp3"} Jan 19 11:55:17 volumio volumio[1096]: verbose: CURRENT POSITION 0 Jan 19 11:55:17 volumio volumio[1096]: info: CoreStateMachine::syncState stateService stop Jan 19 11:55:17 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Jan 19 11:55:17 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:55:17 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:17 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:55:17 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:55:17 volumio volumio[1096]: info: No code Jan 19 11:55:17 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:55:17 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:17 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:55:17 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:55:17 volumio volumio[1096]: info: ------------------------------ 58ms Jan 19 11:55:17 volumio volumio[1096]: info: CorePlayQueue::saveQueue Jan 19 11:55:17 volumio volumio[1096]: info: CoreCommandRouter::volumioPushQueue Jan 19 11:55:17 volumio volumio[1096]: info: CoreStateMachine::updateTrackBlock Jan 19 11:55:17 volumio volumio[1096]: info: CorePlayQueue::getTrackBlock Jan 19 11:55:17 volumio volumio[1096]: info: CoreCommandRouter::volumioPlay Jan 19 11:55:17 volumio volumio[1096]: verbose: UNSET VOLATILE Jan 19 11:55:17 volumio volumio[1096]: info: CoreStateMachine::play index 0 Jan 19 11:55:17 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:55:17 volumio volumio[1096]: info: CoreStateMachine::stop Jan 19 11:55:17 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:55:17 volumio volumio[1096]: verbose: UNSET VOLATILE Jan 19 11:55:17 volumio volumio[1096]: info: CoreStateMachine::play index undefined Jan 19 11:55:17 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:55:17 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:17 volumio volumio[1096]: info: CoreStateMachine::startPlaybackTimer Jan 19 11:55:17 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:17 volumio volumio[1096]: info: [1737287717338] ControllerWebradio::clearAddPlayTrack Jan 19 11:55:17 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Jan 19 11:55:17 volumio volumio[1096]: info: sendMpdCommand stop took 17 milliseconds Jan 19 11:55:17 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand clear Jan 19 11:55:17 volumio volumio[1096]: info: Jan 19 11:55:17 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Jan 19 11:55:17 volumio volumio[1096]: info: Ignoring MPD Status Update Jan 19 11:55:17 volumio volumio[1096]: info: sendMpdCommand clear took 5 milliseconds Jan 19 11:55:17 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand load "http://tsfjazz.ice.infomaniak.ch/tsfjazz-high.mp3" Jan 19 11:55:17 volumio volumio[1096]: error: updateQueue error: null Jan 19 11:55:17 volumio volumio[1096]: info: ------------------------------ 7ms Jan 19 11:55:17 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand add "http://tsfjazz.ice.infomaniak.ch/tsfjazz-high.mp3" Jan 19 11:55:17 volumio volumio[1096]: info: Jan 19 11:55:17 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Jan 19 11:55:17 volumio volumio[1096]: info: Ignoring MPD Status Update Jan 19 11:55:17 volumio volumio[1096]: info: sendMpdCommand add "http://tsfjazz.ice.infomaniak.ch/tsfjazz-high.mp3" took 7 milliseconds Jan 19 11:55:17 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 19 11:55:17 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand play Jan 19 11:55:17 volumio volumio[1096]: info: ------------------------------ 6ms Jan 19 11:55:17 volumio volumio[1096]: info: sendMpdCommand play took 5 milliseconds Jan 19 11:55:18 volumio volumio[1096]: info: Jan 19 11:55:18 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:55:18 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:55:18 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:55:18 volumio volumio[1096]: info: Jan 19 11:55:18 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Jan 19 11:55:18 volumio volumio[1096]: info: Ignoring MPD Status Update Jan 19 11:55:18 volumio volumio[1096]: info: Jan 19 11:55:18 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:55:18 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:55:18 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:55:18 volumio volumio[1096]: info: sendMpdCommand status took 14 milliseconds Jan 19 11:55:18 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:55:18 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:55:18 volumio volumio[1096]: info: ------------------------------ 19ms Jan 19 11:55:18 volumio volumio[1096]: info: sendMpdCommand status took 17 milliseconds Jan 19 11:55:18 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 13 milliseconds Jan 19 11:55:18 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:55:18 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:55:18 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:55:18 volumio volumio[1096]: info: ControllerMpd::pushState Jan 19 11:55:18 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Jan 19 11:55:18 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:18 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"tsfjazz-high.mp3","artist":"TSF Jazz","album":null,"uri":"http://tsfjazz.ice.infomaniak.ch/tsfjazz-high.mp3","trackType":"mp3"} Jan 19 11:55:18 volumio volumio[1096]: verbose: CURRENT POSITION 0 Jan 19 11:55:18 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Jan 19 11:55:18 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Jan 19 11:55:18 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:55:18 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:55:18 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:55:18 volumio volumio[1096]: info: ------------------------------ 66ms Jan 19 11:55:18 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 30 milliseconds Jan 19 11:55:18 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:55:18 volumio volumio[1096]: info: ControllerMpd::pushState Jan 19 11:55:18 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Jan 19 11:55:18 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:18 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"tsfjazz-high.mp3","artist":"TSF Jazz","album":null,"uri":"http://tsfjazz.ice.infomaniak.ch/tsfjazz-high.mp3","trackType":"mp3"} Jan 19 11:55:18 volumio volumio[1096]: verbose: CURRENT POSITION 0 Jan 19 11:55:18 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Jan 19 11:55:18 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Jan 19 11:55:18 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Jan 19 11:55:18 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:55:18 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:55:18 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:55:18 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:55:18 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:55:18 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:55:18 volumio volumio[1096]: info: ------------------------------ 99ms Jan 19 11:55:22 volumio volumio[1096]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::ClearQueue Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::stop Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:55:22 volumio volumio[1096]: verbose: UNSET VOLATILE Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::stPlaybackTimer Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::updateTrackBlock Jan 19 11:55:22 volumio volumio[1096]: info: CorePlayQueue::getTrackBlock Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:55:22 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:22 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:55:22 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::serviceStop Jan 19 11:55:22 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:22 volumio volumio[1096]: info: CoreCommandRouter::serviceStop Jan 19 11:55:22 volumio volumio[1096]: info: [1737287722518] ControllerWebradio::stop Jan 19 11:55:22 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Jan 19 11:55:22 volumio volumio[1096]: info: CorePlayQueue::clearPlayQueue Jan 19 11:55:22 volumio volumio[1096]: info: CorePlayQueue::saveQueue Jan 19 11:55:22 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:55:22 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:55:22 volumio volumio[1096]: info: CoreCommandRouter::volumioPushQueue Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::addQueueItems Jan 19 11:55:22 volumio volumio[1096]: info: CorePlayQueue::addQueueItems Jan 19 11:55:22 volumio volumio[1096]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1419651 Jan 19 11:55:22 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 19 11:55:22 volumio volumio[1096]: info: CorePlayQueue::saveQueue Jan 19 11:55:22 volumio volumio[1096]: info: CoreCommandRouter::volumioPushQueue Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::updateTrackBlock Jan 19 11:55:22 volumio volumio[1096]: info: CorePlayQueue::getTrackBlock Jan 19 11:55:22 volumio volumio[1096]: info: CoreCommandRouter::volumioPlay Jan 19 11:55:22 volumio volumio[1096]: verbose: UNSET VOLATILE Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::play index 0 Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::stop Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:55:22 volumio volumio[1096]: verbose: UNSET VOLATILE Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::play index undefined Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:55:22 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:22 volumio volumio[1096]: info: CoreStateMachine::startPlaybackTimer Jan 19 11:55:22 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:22 volumio volumio[1096]: info: [1737287722557] ControllerWebradio::clearAddPlayTrack Jan 19 11:55:22 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Jan 19 11:55:22 volumio volumio[1096]: info: sendMpdCommand stop took 130 milliseconds Jan 19 11:55:22 volumio volumio[1096]: info: Jan 19 11:55:22 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:55:22 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:55:22 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:55:22 volumio volumio[1096]: info: sendMpdCommand stop took 95 milliseconds Jan 19 11:55:22 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand clear Jan 19 11:55:22 volumio volumio[1096]: info: Jan 19 11:55:22 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Jan 19 11:55:22 volumio volumio[1096]: info: Ignoring MPD Status Update Jan 19 11:55:22 volumio volumio[1096]: info: sendMpdCommand status took 7 milliseconds Jan 19 11:55:22 volumio volumio[1096]: info: sendMpdCommand clear took 5 milliseconds Jan 19 11:55:22 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:55:22 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:55:22 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1419651" Jan 19 11:55:22 volumio volumio[1096]: error: updateQueue error: null Jan 19 11:55:22 volumio volumio[1096]: info: ------------------------------ 11ms Jan 19 11:55:22 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 19 11:55:22 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:55:22 volumio volumio[1096]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 19 11:55:22 volumio volumio[1096]: info: ------------------------------ 21ms Jan 19 11:55:23 volumio volumio[1096]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1419651" took 342 milliseconds Jan 19 11:55:23 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 19 11:55:23 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand play Jan 19 11:55:23 volumio volumio[1096]: info: Jan 19 11:55:23 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Jan 19 11:55:23 volumio volumio[1096]: info: Ignoring MPD Status Update Jan 19 11:55:23 volumio volumio[1096]: info: sendMpdCommand play took 3 milliseconds Jan 19 11:55:23 volumio volumio[1096]: info: ------------------------------ 9ms Jan 19 11:55:24 volumio volumio[1096]: info: Jan 19 11:55:24 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:55:24 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:55:24 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:55:24 volumio volumio[1096]: info: Jan 19 11:55:24 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Jan 19 11:55:24 volumio volumio[1096]: info: Ignoring MPD Status Update Jan 19 11:55:24 volumio volumio[1096]: info: Jan 19 11:55:24 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:55:24 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:55:24 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:55:24 volumio volumio[1096]: info: sendMpdCommand status took 38 milliseconds Jan 19 11:55:24 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:55:24 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:55:24 volumio volumio[1096]: info: ------------------------------ 47ms Jan 19 11:55:24 volumio volumio[1096]: info: sendMpdCommand status took 12 milliseconds Jan 19 11:55:24 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 19 11:55:24 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:55:24 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:55:24 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:55:24 volumio volumio[1096]: info: ControllerMpd::pushState Jan 19 11:55:24 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Jan 19 11:55:24 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:24 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"29 Kbps","isStreaming":false,"title":"alexjonesshow","artist":"Alex Jones - Infowars.com","album":null,"uri":"https://streams1.infowars.com:80/alexjonesshow","trackType":""} Jan 19 11:55:24 volumio volumio[1096]: verbose: CURRENT POSITION 0 Jan 19 11:55:24 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Jan 19 11:55:24 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Jan 19 11:55:24 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:55:24 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:55:24 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:55:24 volumio volumio[1096]: info: ------------------------------ 84ms Jan 19 11:55:24 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 27 milliseconds Jan 19 11:55:24 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:55:24 volumio volumio[1096]: info: ControllerMpd::pushState Jan 19 11:55:24 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Jan 19 11:55:24 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:24 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"31 Kbps","isStreaming":false,"title":"alexjonesshow","artist":"Alex Jones - Infowars.com","album":null,"uri":"https://streams1.infowars.com:80/alexjonesshow","trackType":""} Jan 19 11:55:24 volumio volumio[1096]: verbose: CURRENT POSITION 0 Jan 19 11:55:24 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Jan 19 11:55:24 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Jan 19 11:55:24 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Jan 19 11:55:24 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 19 11:55:24 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:55:24 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:55:24 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:55:24 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:55:24 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:55:24 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:55:24 volumio volumio[1096]: info: ------------------------------ 104ms Jan 19 11:55:27 volumio volumio[1096]: info: Jan 19 11:55:27 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Jan 19 11:55:27 volumio volumio[1096]: info: Ignoring MPD Status Update Jan 19 11:55:27 volumio volumio[1096]: info: Jan 19 11:55:27 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:55:27 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:55:27 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:55:27 volumio volumio[1096]: info: ------------------------------ 13ms Jan 19 11:55:27 volumio volumio[1096]: info: sendMpdCommand status took 10 milliseconds Jan 19 11:55:27 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:55:27 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:55:27 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 19 11:55:27 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:55:27 volumio volumio[1096]: info: ControllerMpd::pushState Jan 19 11:55:27 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Jan 19 11:55:27 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:55:27 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2972,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"37 Kbps","isStreaming":false,"title":"Alex Jones Show - REPLAY","artist":"Alex Jones - Infowars.com","album":null,"uri":"https://streams1.infowars.com:80/alexjonesshow","trackType":""} Jan 19 11:55:27 volumio volumio[1096]: verbose: CURRENT POSITION 0 Jan 19 11:55:27 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Jan 19 11:55:27 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Jan 19 11:55:27 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Jan 19 11:55:27 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 19 11:55:27 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:55:27 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:55:27 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:55:27 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:55:27 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:55:27 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:55:27 volumio volumio[1096]: info: ------------------------------ 45ms Jan 19 11:55:28 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 19 11:55:28 volumio volumio[1096]: info: CURURI: music-library Jan 19 11:55:30 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 19 11:55:30 volumio volumio[1096]: info: CURURI: music-library/USB Jan 19 11:55:37 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jan 19 11:55:42 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jan 19 11:56:05 volumio volumio[1096]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::ClearQueue Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::stop Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:56:05 volumio volumio[1096]: verbose: UNSET VOLATILE Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::stPlaybackTimer Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::updateTrackBlock Jan 19 11:56:05 volumio volumio[1096]: info: CorePlayQueue::getTrackBlock Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:05 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::serviceStop Jan 19 11:56:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:05 volumio volumio[1096]: info: CoreCommandRouter::serviceStop Jan 19 11:56:05 volumio volumio[1096]: info: [1737287765064] ControllerWebradio::stop Jan 19 11:56:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Jan 19 11:56:05 volumio volumio[1096]: info: CorePlayQueue::clearPlayQueue Jan 19 11:56:05 volumio volumio[1096]: info: CorePlayQueue::saveQueue Jan 19 11:56:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:05 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushQueue Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::addQueueItems Jan 19 11:56:05 volumio volumio[1096]: info: CorePlayQueue::addQueueItems Jan 19 11:56:05 volumio volumio[1096]: info: Adding Item to queue: http://lstn.lv/bbcradio.m3u8?station=bbc_radio_fourfm&bitrate=96000 Jan 19 11:56:05 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 19 11:56:05 volumio volumio[1096]: info: CorePlayQueue::saveQueue Jan 19 11:56:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushQueue Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::updateTrackBlock Jan 19 11:56:05 volumio volumio[1096]: info: CorePlayQueue::getTrackBlock Jan 19 11:56:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPlay Jan 19 11:56:05 volumio volumio[1096]: verbose: UNSET VOLATILE Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::play index 0 Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::stop Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:56:05 volumio volumio[1096]: verbose: UNSET VOLATILE Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::play index undefined Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:56:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::startPlaybackTimer Jan 19 11:56:05 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:05 volumio volumio[1096]: info: [1737287765138] ControllerWebradio::clearAddPlayTrack Jan 19 11:56:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Jan 19 11:56:05 volumio volumio[1096]: info: Jan 19 11:56:05 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:56:05 volumio volumio[1096]: info: sendMpdCommand stop took 99 milliseconds Jan 19 11:56:05 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:56:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:56:05 volumio volumio[1096]: info: sendMpdCommand stop took 26 milliseconds Jan 19 11:56:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand clear Jan 19 11:56:05 volumio volumio[1096]: info: Jan 19 11:56:05 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Jan 19 11:56:05 volumio volumio[1096]: info: Ignoring MPD Status Update Jan 19 11:56:05 volumio volumio[1096]: info: sendMpdCommand status took 4 milliseconds Jan 19 11:56:05 volumio volumio[1096]: info: sendMpdCommand clear took 3 milliseconds Jan 19 11:56:05 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:56:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:56:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand load "http://lstn.lv/bbcradio.m3u8?station=bbc_radio_fourfm&bitrate=96000" Jan 19 11:56:05 volumio volumio[1096]: error: updateQueue error: null Jan 19 11:56:05 volumio volumio[1096]: info: ------------------------------ 16ms Jan 19 11:56:05 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 13 milliseconds Jan 19 11:56:05 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:56:05 volumio volumio[1096]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 19 11:56:05 volumio volumio[1096]: info: ------------------------------ 22ms Jan 19 11:56:05 volumio volumio[1096]: info: Jan 19 11:56:05 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Jan 19 11:56:05 volumio volumio[1096]: info: Ignoring MPD Status Update Jan 19 11:56:05 volumio volumio[1096]: info: sendMpdCommand load "http://lstn.lv/bbcradio.m3u8?station=bbc_radio_fourfm&bitrate=96000" took 346 milliseconds Jan 19 11:56:05 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 19 11:56:05 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand play Jan 19 11:56:05 volumio volumio[1096]: info: ------------------------------ 23ms Jan 19 11:56:05 volumio volumio[1096]: info: sendMpdCommand play took 21 milliseconds Jan 19 11:56:06 volumio volumio[1096]: info: Jan 19 11:56:06 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:56:06 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:56:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:56:06 volumio volumio[1096]: info: Jan 19 11:56:06 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:56:06 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:56:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:56:06 volumio volumio[1096]: info: sendMpdCommand status took 6 milliseconds Jan 19 11:56:06 volumio volumio[1096]: info: sendMpdCommand status took 3 milliseconds Jan 19 11:56:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:56:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:56:06 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:56:06 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:56:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 19 11:56:06 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 19 11:56:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:56:06 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:56:06 volumio volumio[1096]: info: ControllerMpd::pushState Jan 19 11:56:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Jan 19 11:56:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":363,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"104 Kbps","isStreaming":false,"title":"bbc_radio_fourfm-audio%3d96000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_904/live/ww/bbc_radio_fourfm/bbc_radio_fourfm.isml/bbc_radio_fourfm-audio%3d96000.norewind.m3u8","trackType":"m3u8"} Jan 19 11:56:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Jan 19 11:56:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Jan 19 11:56:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Jan 19 11:56:06 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:06 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:06 volumio volumio[1096]: info: ControllerMpd::pushState Jan 19 11:56:06 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Jan 19 11:56:06 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:06 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"104 Kbps","isStreaming":false,"title":"bbc_radio_fourfm-audio%3d96000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_904/live/ww/bbc_radio_fourfm/bbc_radio_fourfm.isml/bbc_radio_fourfm-audio%3d96000.norewind.m3u8","trackType":"m3u8"} Jan 19 11:56:06 volumio volumio[1096]: verbose: CURRENT POSITION 0 Jan 19 11:56:06 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Jan 19 11:56:06 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Jan 19 11:56:06 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Jan 19 11:56:06 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:06 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:06 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:06 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:06 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:06 volumio volumio[1096]: info: ------------------------------ 86ms Jan 19 11:56:06 volumio volumio[1096]: info: ------------------------------ 79ms Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::ClearQueue Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::stop Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:56:12 volumio volumio[1096]: verbose: UNSET VOLATILE Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::stPlaybackTimer Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::updateTrackBlock Jan 19 11:56:12 volumio volumio[1096]: info: CorePlayQueue::getTrackBlock Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::serviceStop Jan 19 11:56:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::serviceStop Jan 19 11:56:12 volumio volumio[1096]: info: [1737287772064] ControllerWebradio::stop Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Jan 19 11:56:12 volumio volumio[1096]: info: CorePlayQueue::clearPlayQueue Jan 19 11:56:12 volumio volumio[1096]: info: CorePlayQueue::saveQueue Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushQueue Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::addQueueItems Jan 19 11:56:12 volumio volumio[1096]: info: CorePlayQueue::addQueueItems Jan 19 11:56:12 volumio volumio[1096]: info: Adding Item to queue: http://lstn.lv/bbcradio.m3u8?station=bbc_radio_three&bitrate=96000 Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 19 11:56:12 volumio volumio[1096]: info: CorePlayQueue::saveQueue Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushQueue Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::updateTrackBlock Jan 19 11:56:12 volumio volumio[1096]: info: CorePlayQueue::getTrackBlock Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPlay Jan 19 11:56:12 volumio volumio[1096]: verbose: UNSET VOLATILE Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::play index 0 Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::stop Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:56:12 volumio volumio[1096]: verbose: UNSET VOLATILE Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::play index undefined Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:56:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::startPlaybackTimer Jan 19 11:56:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:12 volumio volumio[1096]: info: [1737287772103] ControllerWebradio::clearAddPlayTrack Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Jan 19 11:56:12 volumio volumio[1096]: info: Jan 19 11:56:12 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:56:12 volumio volumio[1096]: info: sendMpdCommand stop took 145 milliseconds Jan 19 11:56:12 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:56:12 volumio volumio[1096]: info: sendMpdCommand stop took 108 milliseconds Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand clear Jan 19 11:56:12 volumio volumio[1096]: info: Jan 19 11:56:12 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Jan 19 11:56:12 volumio volumio[1096]: info: Ignoring MPD Status Update Jan 19 11:56:12 volumio volumio[1096]: info: sendMpdCommand status took 23 milliseconds Jan 19 11:56:12 volumio volumio[1096]: info: sendMpdCommand clear took 21 milliseconds Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand load "http://lstn.lv/bbcradio.m3u8?station=bbc_radio_three&bitrate=96000" Jan 19 11:56:12 volumio volumio[1096]: error: updateQueue error: null Jan 19 11:56:12 volumio volumio[1096]: info: ------------------------------ 11ms Jan 19 11:56:12 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:56:12 volumio volumio[1096]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 19 11:56:12 volumio volumio[1096]: info: ------------------------------ 38ms Jan 19 11:56:12 volumio volumio[1096]: info: Jan 19 11:56:12 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Jan 19 11:56:12 volumio volumio[1096]: info: Ignoring MPD Status Update Jan 19 11:56:12 volumio volumio[1096]: info: sendMpdCommand load "http://lstn.lv/bbcradio.m3u8?station=bbc_radio_three&bitrate=96000" took 84 milliseconds Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand play Jan 19 11:56:12 volumio volumio[1096]: info: ------------------------------ 8ms Jan 19 11:56:12 volumio volumio[1096]: info: sendMpdCommand play took 5 milliseconds Jan 19 11:56:12 volumio volumio[1096]: info: Jan 19 11:56:12 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:56:12 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:56:12 volumio volumio[1096]: info: Jan 19 11:56:12 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:56:12 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:56:12 volumio volumio[1096]: info: sendMpdCommand status took 7 milliseconds Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:56:12 volumio volumio[1096]: info: sendMpdCommand status took 6 milliseconds Jan 19 11:56:12 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:56:12 volumio volumio[1096]: info: ControllerMpd::pushState Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Jan 19 11:56:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:12 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":116,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"94 Kbps","isStreaming":false,"title":"bbc_radio_three-audio%3d96000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_904/live/ww/bbc_radio_three/bbc_radio_three.isml/bbc_radio_three-audio%3d96000.norewind.m3u8","trackType":"m3u8"} Jan 19 11:56:12 volumio volumio[1096]: verbose: CURRENT POSITION 0 Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:12 volumio volumio[1096]: info: ------------------------------ 40ms Jan 19 11:56:12 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 24 milliseconds Jan 19 11:56:12 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:56:12 volumio volumio[1096]: info: ControllerMpd::pushState Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Jan 19 11:56:12 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:12 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"94 Kbps","isStreaming":false,"title":"bbc_radio_three-audio%3d96000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_904/live/ww/bbc_radio_three/bbc_radio_three.isml/bbc_radio_three-audio%3d96000.norewind.m3u8","trackType":"m3u8"} Jan 19 11:56:12 volumio volumio[1096]: verbose: CURRENT POSITION 0 Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Jan 19 11:56:12 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:12 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:12 volumio volumio[1096]: info: ------------------------------ 72ms Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::ClearQueue Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::stop Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:56:17 volumio volumio[1096]: verbose: UNSET VOLATILE Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::stPlaybackTimer Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::updateTrackBlock Jan 19 11:56:17 volumio volumio[1096]: info: CorePlayQueue::getTrackBlock Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:17 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::serviceStop Jan 19 11:56:17 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::serviceStop Jan 19 11:56:17 volumio volumio[1096]: info: [1737287777412] ControllerWebradio::stop Jan 19 11:56:17 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Jan 19 11:56:17 volumio volumio[1096]: info: CorePlayQueue::clearPlayQueue Jan 19 11:56:17 volumio volumio[1096]: info: CorePlayQueue::saveQueue Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::volumioPushQueue Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::addQueueItems Jan 19 11:56:17 volumio volumio[1096]: info: CorePlayQueue::addQueueItems Jan 19 11:56:17 volumio volumio[1096]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s142801 Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 19 11:56:17 volumio volumio[1096]: info: Jan 19 11:56:17 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:56:17 volumio volumio[1096]: info: sendMpdCommand stop took 118 milliseconds Jan 19 11:56:17 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:56:17 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:56:17 volumio volumio[1096]: info: sendMpdCommand status took 2 milliseconds Jan 19 11:56:17 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:56:17 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:56:17 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 19 11:56:17 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:56:17 volumio volumio[1096]: info: ControllerMpd::pushState Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:17 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:17 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:17 volumio volumio[1096]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_three-audio%3d96000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_904/live/ww/bbc_radio_three/bbc_radio_three.isml/bbc_radio_three-audio%3d96000.norewind.m3u8","trackType":"m3u8"} Jan 19 11:56:17 volumio volumio[1096]: verbose: CURRENT POSITION 0 Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::syncState stateService stop Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:17 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:17 volumio volumio[1096]: info: No code Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:17 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:17 volumio volumio[1096]: info: ------------------------------ 46ms Jan 19 11:56:17 volumio volumio[1096]: info: CorePlayQueue::saveQueue Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::volumioPushQueue Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::updateTrackBlock Jan 19 11:56:17 volumio volumio[1096]: info: CorePlayQueue::getTrackBlock Jan 19 11:56:17 volumio volumio[1096]: info: CoreCommandRouter::volumioPlay Jan 19 11:56:17 volumio volumio[1096]: verbose: UNSET VOLATILE Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::play index 0 Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::stop Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:56:17 volumio volumio[1096]: verbose: UNSET VOLATILE Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::play index undefined Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 11:56:17 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:17 volumio volumio[1096]: info: CoreStateMachine::startPlaybackTimer Jan 19 11:56:17 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:17 volumio volumio[1096]: info: [1737287777845] ControllerWebradio::clearAddPlayTrack Jan 19 11:56:17 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand stop Jan 19 11:56:17 volumio volumio[1096]: info: sendMpdCommand stop took 18 milliseconds Jan 19 11:56:17 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand clear Jan 19 11:56:17 volumio volumio[1096]: info: Jan 19 11:56:17 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Jan 19 11:56:17 volumio volumio[1096]: info: Ignoring MPD Status Update Jan 19 11:56:17 volumio volumio[1096]: info: sendMpdCommand clear took 4 milliseconds Jan 19 11:56:17 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand load "http://stream.anotherplanet.fm:8000/stream.mp3" Jan 19 11:56:17 volumio volumio[1096]: error: updateQueue error: null Jan 19 11:56:17 volumio volumio[1096]: info: ------------------------------ 5ms Jan 19 11:56:18 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand add "http://stream.anotherplanet.fm:8000/stream.mp3" Jan 19 11:56:18 volumio volumio[1096]: info: Jan 19 11:56:18 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Jan 19 11:56:18 volumio volumio[1096]: info: Ignoring MPD Status Update Jan 19 11:56:18 volumio volumio[1096]: info: sendMpdCommand add "http://stream.anotherplanet.fm:8000/stream.mp3" took 4 milliseconds Jan 19 11:56:18 volumio volumio[1096]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 19 11:56:18 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand play Jan 19 11:56:18 volumio volumio[1096]: info: ------------------------------ 23ms Jan 19 11:56:18 volumio volumio[1096]: info: sendMpdCommand play took 6 milliseconds Jan 19 11:56:18 volumio volumio[1096]: info: Jan 19 11:56:18 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:56:18 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:56:18 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:56:18 volumio volumio[1096]: info: Jan 19 11:56:18 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Jan 19 11:56:18 volumio volumio[1096]: info: Ignoring MPD Status Update Jan 19 11:56:18 volumio volumio[1096]: info: Jan 19 11:56:18 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:56:18 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:56:18 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:56:18 volumio volumio[1096]: info: sendMpdCommand status took 2 milliseconds Jan 19 11:56:18 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:56:18 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:56:18 volumio volumio[1096]: info: ------------------------------ 4ms Jan 19 11:56:18 volumio volumio[1096]: info: sendMpdCommand status took 4 milliseconds Jan 19 11:56:18 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 19 11:56:18 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:56:18 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:56:18 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:56:18 volumio volumio[1096]: info: ControllerMpd::pushState Jan 19 11:56:18 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Jan 19 11:56:18 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:18 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":116,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream.mp3","artist":"anotherplanet.fm ambient chillout radio","album":null,"uri":"http://stream.anotherplanet.fm:8000/stream.mp3","trackType":"mp3"} Jan 19 11:56:18 volumio volumio[1096]: verbose: CURRENT POSITION 0 Jan 19 11:56:18 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Jan 19 11:56:18 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus stop Jan 19 11:56:18 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:18 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:18 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:18 volumio volumio[1096]: info: ------------------------------ 22ms Jan 19 11:56:18 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 12 milliseconds Jan 19 11:56:18 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:56:18 volumio volumio[1096]: info: ControllerMpd::pushState Jan 19 11:56:18 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Jan 19 11:56:18 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:18 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":162,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream.mp3","artist":"anotherplanet.fm ambient chillout radio","album":null,"uri":"http://stream.anotherplanet.fm:8000/stream.mp3","trackType":"mp3"} Jan 19 11:56:18 volumio volumio[1096]: verbose: CURRENT POSITION 0 Jan 19 11:56:18 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Jan 19 11:56:18 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Jan 19 11:56:18 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Jan 19 11:56:18 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:18 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:18 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:18 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:18 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:18 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:18 volumio volumio[1096]: info: ------------------------------ 38ms Jan 19 11:56:18 volumio volumio[1096]: info: Jan 19 11:56:18 volumio volumio[1096]: ---------------------------- MPD announces system playlist update Jan 19 11:56:18 volumio volumio[1096]: info: Ignoring MPD Status Update Jan 19 11:56:18 volumio volumio[1096]: info: Jan 19 11:56:18 volumio volumio[1096]: ---------------------------- MPD announces state update: player Jan 19 11:56:18 volumio volumio[1096]: info: ControllerMpd::getState Jan 19 11:56:18 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand status Jan 19 11:56:18 volumio volumio[1096]: info: ------------------------------ 6ms Jan 19 11:56:18 volumio volumio[1096]: info: sendMpdCommand status took 4 milliseconds Jan 19 11:56:18 volumio volumio[1096]: verbose: ControllerMpd::parseState Jan 19 11:56:18 volumio volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 11:56:18 volumio volumio[1096]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 19 11:56:18 volumio volumio[1096]: verbose: ControllerMpd::parseTrackInfo Jan 19 11:56:18 volumio volumio[1096]: info: ControllerMpd::pushState Jan 19 11:56:18 volumio volumio[1096]: info: CoreCommandRouter::servicePushState Jan 19 11:56:18 volumio volumio[1096]: info: CorePlayQueue::getTrack 0 Jan 19 11:56:18 volumio volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":510,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"08. Dezoncondor - Suspiro","artist":"anotherplanet.fm ambient chillout radio","album":null,"uri":"http://stream.anotherplanet.fm:8000/stream.mp3","trackType":"mp3"} Jan 19 11:56:18 volumio volumio[1096]: verbose: CURRENT POSITION 0 Jan 19 11:56:18 volumio volumio[1096]: info: CoreStateMachine::syncState stateService play Jan 19 11:56:18 volumio volumio[1096]: info: CoreStateMachine::syncState currentStatus play Jan 19 11:56:18 volumio volumio[1096]: info: Received an update from plugin. extracting info from payload Jan 19 11:56:18 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:18 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:18 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:18 volumio volumio[1096]: info: CoreStateMachine::pushState Jan 19 11:56:18 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState Jan 19 11:56:18 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 11:56:18 volumio volumio[1096]: info: ------------------------------ 41ms Jan 19 11:56:25 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: podcast , handleBrowseUri Jan 19 11:56:33 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: podcast , handleBrowseUri Jan 19 11:56:39 volumio volumio[1096]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 19 11:56:39 volumio volumio[1096]: TypeError: Cannot read property 'title' of undefined Jan 19 11:56:39 volumio volumio[1096]: at /data/plugins/music_service/podcast/index.js:421:51 Jan 19 11:56:39 volumio volumio[1096]: at Timeout.setTimeout [as _onTimeout] (/data/plugins/music_service/podcast/node_modules/rss-parser/lib/utils.js:63:29) Jan 19 11:56:39 volumio volumio[1096]: at ontimeout (timers.js:482:11) Jan 19 11:56:39 volumio volumio[1096]: at tryOnTimeout (timers.js:317:5) Jan 19 11:56:39 volumio volumio[1096]: at Timer.listOnTimeout (timers.js:277:5) Jan 19 11:56:39 volumio volumio[1096]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 19 11:56:41 volumio sudo[13394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-19 11:55 Jan 19 11:56:41 volumio sudo[13394]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"