-- Logs begin at Thu 2025-05-08 19:31:19 UTC, end at Thu 2025-05-08 20:35:03 UTC. -- May 08 20:34:00 volumio volumio[1209]: info: May 08 20:34:00 volumio volumio[1209]: ---------------------------- MPD announces state update: player May 08 20:34:00 volumio volumio[1209]: info: ControllerMpd::getState May 08 20:34:00 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand status May 08 20:34:00 volumio volumio[1209]: info: May 08 20:34:00 volumio volumio[1209]: ---------------------------- MPD announces state update: player May 08 20:34:00 volumio volumio[1209]: info: sendMpdCommand status took 182 milliseconds May 08 20:34:00 volumio volumio[1209]: info: ControllerMpd::getState May 08 20:34:00 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand status May 08 20:34:00 volumio volumio[1209]: verbose: ControllerMpd::parseState May 08 20:34:00 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 08 20:34:00 volumio volumio[1209]: info: May 08 20:34:00 volumio volumio[1209]: ---------------------------- MPD announces system playlist update May 08 20:34:00 volumio volumio[1209]: info: Ignoring MPD Status Update May 08 20:34:00 volumio volumio[1209]: info: sendMpdCommand status took 2 milliseconds May 08 20:34:00 volumio volumio[1209]: info: sendMpdCommand playlistinfo took 1 milliseconds May 08 20:34:00 volumio volumio[1209]: verbose: ControllerMpd::parseState May 08 20:34:00 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 08 20:34:00 volumio volumio[1209]: verbose: ControllerMpd::parseTrackInfo May 08 20:34:00 volumio volumio[1209]: info: ControllerMpd::pushState May 08 20:34:00 volumio volumio[1209]: info: CoreCommandRouter::servicePushState May 08 20:34:00 volumio volumio[1209]: info: CorePlayQueue::getTrack 0 May 08 20:34:00 volumio volumio[1209]: 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":"192 Kbps","isStreaming":false,"title":"Frankie Boy & The Blues Express - Guitar JR","artist":"1.FM - Blues Radio","album":null,"uri":"http://185.33.21.112:80/blues_64","trackType":""} May 08 20:34:00 volumio volumio[1209]: verbose: CURRENT POSITION 0 May 08 20:34:00 volumio volumio[1209]: info: CoreStateMachine::syncState stateService play May 08 20:34:00 volumio volumio[1209]: info: CoreStateMachine::syncState currentStatus stop May 08 20:34:00 volumio volumio[1209]: info: CoreStateMachine::pushState May 08 20:34:00 volumio volumio[1209]: info: CoreCommandRouter::volumioPushState May 08 20:34:00 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 08 20:34:00 volumio volumio[1209]: info: ------------------------------ 191ms May 08 20:34:00 volumio volumio[1209]: info: ------------------------------ 7ms May 08 20:34:00 volumio volumio[1209]: info: sendMpdCommand playlistinfo took 6 milliseconds May 08 20:34:00 volumio volumio[1209]: verbose: ControllerMpd::parseTrackInfo May 08 20:34:00 volumio volumio[1209]: info: ControllerMpd::pushState May 08 20:34:00 volumio volumio[1209]: info: CoreCommandRouter::servicePushState May 08 20:34:00 volumio volumio[1209]: info: CorePlayQueue::getTrack 0 May 08 20:34:00 volumio volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":481,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Frankie Boy & The Blues Express - Guitar JR","artist":"1.FM - Blues Radio","album":null,"uri":"http://185.33.21.112:80/blues_64","trackType":""} May 08 20:34:00 volumio volumio[1209]: verbose: CURRENT POSITION 0 May 08 20:34:00 volumio volumio[1209]: info: CoreStateMachine::syncState stateService play May 08 20:34:00 volumio volumio[1209]: info: CoreStateMachine::syncState currentStatus play May 08 20:34:00 volumio volumio[1209]: info: Received an update from plugin. extracting info from payload May 08 20:34:00 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 08 20:34:00 volumio volumio[1209]: info: CoreStateMachine::pushState May 08 20:34:00 volumio volumio[1209]: info: CoreCommandRouter::volumioPushState May 08 20:34:00 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 08 20:34:00 volumio volumio[1209]: info: CoreStateMachine::pushState May 08 20:34:00 volumio volumio[1209]: info: CoreCommandRouter::volumioPushState May 08 20:34:00 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 08 20:34:00 volumio volumio[1209]: info: ------------------------------ 16ms May 08 20:34:05 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 08 20:34:05 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 08 20:34:05 volumio volumio[1209]: info: Discovery: Getting this device information May 08 20:34:05 volumio volumio[1209]: info: CoreCommandRouter::volumioGetState May 08 20:34:05 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 08 20:34:05 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 08 20:34:05 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 08 20:34:05 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 08 20:34:05 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 08 20:34:05 volumio volumio[1209]: info: Discovery: Getting this device information May 08 20:34:05 volumio volumio[1209]: info: CoreCommandRouter::volumioGetState May 08 20:34:05 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 08 20:34:05 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 08 20:34:05 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 08 20:34:28 volumio volumio[1209]: info: CoreCommandRouter::volumioReplaceandPlayItems May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::ClearQueue May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::stop May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined May 08 20:34:28 volumio volumio[1209]: UNSET VOLATILE May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::stPlaybackTimer May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::updateTrackBlock May 08 20:34:28 volumio volumio[1209]: info: CorePlayQueue::getTrackBlock May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::pushState May 08 20:34:28 volumio volumio[1209]: info: CorePlayQueue::getTrack 0 May 08 20:34:28 volumio volumio[1209]: info: CoreCommandRouter::volumioPushState May 08 20:34:28 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::serviceStop May 08 20:34:28 volumio volumio[1209]: info: CorePlayQueue::getTrack 0 May 08 20:34:28 volumio volumio[1209]: info: CoreCommandRouter::serviceStop May 08 20:34:28 volumio volumio[1209]: info: [1746736468885] ControllerWebradio::stop May 08 20:34:28 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand stop May 08 20:34:28 volumio volumio[1209]: info: CorePlayQueue::clearPlayQueue May 08 20:34:28 volumio volumio[1209]: info: CorePlayQueue::saveQueue May 08 20:34:28 volumio volumio[1209]: info: CoreCommandRouter::volumioPushState May 08 20:34:28 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 08 20:34:28 volumio volumio[1209]: info: CoreCommandRouter::volumioPushQueue May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::addQueueItems May 08 20:34:28 volumio volumio[1209]: info: CorePlayQueue::addQueueItems May 08 20:34:28 volumio volumio[1209]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99516456 May 08 20:34:28 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 08 20:34:28 volumio volumio[1209]: info: CorePlayQueue::saveQueue May 08 20:34:28 volumio volumio[1209]: info: CoreCommandRouter::volumioPushQueue May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::updateTrackBlock May 08 20:34:28 volumio volumio[1209]: info: CorePlayQueue::getTrackBlock May 08 20:34:28 volumio volumio[1209]: info: CoreCommandRouter::volumioPlay May 08 20:34:28 volumio volumio[1209]: UNSET VOLATILE May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::play index 0 May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::stop May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined May 08 20:34:28 volumio volumio[1209]: UNSET VOLATILE May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::play index undefined May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined May 08 20:34:28 volumio volumio[1209]: info: CorePlayQueue::getTrack 0 May 08 20:34:28 volumio volumio[1209]: info: CoreStateMachine::startPlaybackTimer May 08 20:34:28 volumio volumio[1209]: info: CorePlayQueue::getTrack 0 May 08 20:34:28 volumio volumio[1209]: info: [1746736468897] ControllerWebradio::clearAddPlayTrack May 08 20:34:28 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand stop May 08 20:34:29 volumio volumio[1209]: info: May 08 20:34:29 volumio volumio[1209]: ---------------------------- MPD announces state update: player May 08 20:34:29 volumio volumio[1209]: info: sendMpdCommand stop took 177 milliseconds May 08 20:34:29 volumio volumio[1209]: info: ControllerMpd::getState May 08 20:34:29 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand status May 08 20:34:29 volumio volumio[1209]: info: sendMpdCommand stop took 167 milliseconds May 08 20:34:29 volumio volumio[1209]: info: sendMpdCommand status took 1 milliseconds May 08 20:34:29 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand clear May 08 20:34:29 volumio volumio[1209]: verbose: ControllerMpd::parseState May 08 20:34:29 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 08 20:34:29 volumio volumio[1209]: info: May 08 20:34:29 volumio volumio[1209]: ---------------------------- MPD announces system playlist update May 08 20:34:29 volumio volumio[1209]: info: Ignoring MPD Status Update May 08 20:34:29 volumio volumio[1209]: info: sendMpdCommand clear took 1 milliseconds May 08 20:34:29 volumio volumio[1209]: info: sendMpdCommand playlistinfo took 1 milliseconds May 08 20:34:29 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99516456" May 08 20:34:29 volumio volumio[1209]: verbose: ControllerMpd::parseTrackInfo May 08 20:34:29 volumio volumio[1209]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 08 20:34:29 volumio volumio[1209]: info: ------------------------------ 4ms May 08 20:34:29 volumio volumio[1209]: error: updateQueue error: null May 08 20:34:29 volumio volumio[1209]: info: ------------------------------ 2ms May 08 20:34:29 volumio volumio[1209]: info: May 08 20:34:29 volumio volumio[1209]: ---------------------------- MPD announces system playlist update May 08 20:34:29 volumio volumio[1209]: info: Ignoring MPD Status Update May 08 20:34:29 volumio volumio[1209]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99516456" took 158 milliseconds May 08 20:34:29 volumio volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd May 08 20:34:29 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand play May 08 20:34:29 volumio volumio[1209]: info: ------------------------------ 1ms May 08 20:34:29 volumio volumio[1209]: info: sendMpdCommand play took 1 milliseconds May 08 20:34:35 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 08 20:34:35 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 08 20:34:35 volumio volumio[1209]: info: Discovery: Getting this device information May 08 20:34:35 volumio volumio[1209]: info: CoreCommandRouter::volumioGetState May 08 20:34:35 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 08 20:34:35 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 08 20:34:35 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 08 20:34:35 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 08 20:34:35 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 08 20:34:35 volumio volumio[1209]: info: Discovery: Getting this device information May 08 20:34:35 volumio volumio[1209]: info: CoreCommandRouter::volumioGetState May 08 20:34:35 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 08 20:34:35 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 08 20:34:35 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 08 20:34:39 volumio volumio[1209]: info: May 08 20:34:39 volumio volumio[1209]: ---------------------------- MPD announces state update: player May 08 20:34:39 volumio volumio[1209]: info: ControllerMpd::getState May 08 20:34:39 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand status May 08 20:34:39 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand clearerror May 08 20:34:39 volumio volumio[1209]: info: sendMpdCommand status took 2 milliseconds May 08 20:34:39 volumio volumio[1209]: verbose: ControllerMpd::parseState May 08 20:34:39 volumio volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 08 20:34:39 volumio volumio[1209]: info: sendMpdCommand clearerror took 1 milliseconds May 08 20:34:39 volumio volumio[1209]: info: sendMpdCommand playlistinfo took 0 milliseconds May 08 20:34:39 volumio volumio[1209]: verbose: ControllerMpd::parseTrackInfo May 08 20:34:39 volumio volumio[1209]: info: ControllerMpd::pushState May 08 20:34:39 volumio volumio[1209]: info: CoreCommandRouter::servicePushState May 08 20:34:39 volumio volumio[1209]: info: CoreStateMachine::pushState May 08 20:34:39 volumio volumio[1209]: info: CoreCommandRouter::volumioPushState May 08 20:34:39 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 08 20:34:39 volumio volumio[1209]: info: CorePlayQueue::getTrack 0 May 08 20:34:39 volumio volumio[1209]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 6/300) BLUE RADIO - Greece - www.blueradio.gr","album":null,"uri":"http://94.23.30.114:8033/stream","trackType":""} May 08 20:34:39 volumio volumio[1209]: verbose: CURRENT POSITION 0 May 08 20:34:39 volumio volumio[1209]: info: CoreStateMachine::syncState stateService stop May 08 20:34:39 volumio volumio[1209]: info: CoreStateMachine::syncState currentStatus stop May 08 20:34:39 volumio volumio[1209]: info: CoreStateMachine::pushState May 08 20:34:39 volumio volumio[1209]: info: CoreCommandRouter::volumioPushState May 08 20:34:39 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 08 20:34:39 volumio volumio[1209]: info: No code May 08 20:34:39 volumio volumio[1209]: info: CoreStateMachine::pushState May 08 20:34:39 volumio volumio[1209]: info: CoreCommandRouter::volumioPushState May 08 20:34:39 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 08 20:34:39 volumio volumio[1209]: info: ------------------------------ 14ms May 08 20:34:48 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri May 08 20:34:53 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri May 08 20:35:02 volumio volumio[1209]: info: CoreCommandRouter::volumioReplaceandPlayItems May 08 20:35:02 volumio volumio[1209]: info: CoreStateMachine::ClearQueue May 08 20:35:02 volumio volumio[1209]: info: CoreStateMachine::stop May 08 20:35:02 volumio volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined May 08 20:35:02 volumio volumio[1209]: UNSET VOLATILE May 08 20:35:02 volumio volumio[1209]: info: CorePlayQueue::clearPlayQueue May 08 20:35:02 volumio volumio[1209]: info: CorePlayQueue::saveQueue May 08 20:35:02 volumio volumio[1209]: info: CoreCommandRouter::volumioPushState May 08 20:35:02 volumio volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 08 20:35:02 volumio volumio[1209]: info: CoreCommandRouter::volumioPushQueue May 08 20:35:02 volumio volumio[1209]: info: CoreStateMachine::addQueueItems May 08 20:35:02 volumio volumio[1209]: info: CorePlayQueue::addQueueItems May 08 20:35:02 volumio volumio[1209]: info: Adding Item to queue: webkbs/5 May 08 20:35:02 volumio volumio[1209]: info: Exploding uri webkbs/5 in service personal_radio May 08 20:35:03 volumio volumio[1209]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 08 20:35:03 volumio volumio[1209]: ReferenceError: self is not defined May 08 20:35:03 volumio volumio[1209]: at ControllerPersonalRadio.errorToast (/data/plugins/music_service/personal_radio/index.js:575:22) May 08 20:35:03 volumio volumio[1209]: at /data/plugins/music_service/personal_radio/index.js:487:12 May 08 20:35:03 volumio volumio[1209]: at Request.handleRequestResponse [as _callback] (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:355:15) May 08 20:35:03 volumio volumio[1209]: at self.callback (/data/plugins/music_service/personal_radio/node_modules/request/request.js:187:22) May 08 20:35:03 volumio volumio[1209]: at emitOne (events.js:116:13) May 08 20:35:03 volumio volumio[1209]: at Request.emit (events.js:211:7) May 08 20:35:03 volumio volumio[1209]: at Request.onRequestError (/data/plugins/music_service/personal_radio/node_modules/request/request.js:813:8) May 08 20:35:03 volumio volumio[1209]: at emitOne (events.js:116:13) May 08 20:35:03 volumio volumio[1209]: at ClientRequest.emit (events.js:211:7) May 08 20:35:03 volumio volumio[1209]: at Socket.socketErrorListener (_http_client.js:387:9) May 08 20:35:03 volumio volumio[1209]: at emitOne (events.js:116:13) May 08 20:35:03 volumio volumio[1209]: at Socket.emit (events.js:211:7) May 08 20:35:03 volumio volumio[1209]: at emitErrorNT (internal/streams/destroy.js:64:8) May 08 20:35:03 volumio volumio[1209]: at _combinedTickCallback (internal/process/next_tick.js:138:11) May 08 20:35:03 volumio volumio[1209]: at process._tickCallback (internal/process/next_tick.js:180:9) May 08 20:35:03 volumio volumio[1209]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 08 20:35:03 volumio sudo[10360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-08 20:34 May 08 20:35:03 volumio sudo[10360]: 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="14acf028cf46278bd3fd3dd02523424a9bc825bf" VOLUMIO_FE_VERSION="74f64fbba9dc8053dc27ed7125863d6ad6533965" VOLUMIO_BE_VERSION="0a6008ded215bf284d5d4cd9c4df3333cb320899" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Apr 24 17:39:58 CEST 2021" VOLUMIO_VERSION="2.882" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="1a98a01eef5aa5927a5874c2d3c1b0dc"