-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sat 2024-05-11 06:17:02 UTC. --
May 11 06:16:00 volumio volumio[894]: info: ------------------------------ 6ms
May 11 06:16:00 volumio volumio[894]: info: sendMpdCommand play took 4 milliseconds
May 11 06:16:01 volumio volumio[894]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 11 06:16:01 volumio volumio[894]: info: CoreStateMachine::ClearQueue
May 11 06:16:01 volumio volumio[894]: info: CoreStateMachine::stop
May 11 06:16:01 volumio volumio[894]: info: CoreStateMachine::setConsumeUpdateService undefined
May 11 06:16:01 volumio volumio[894]: verbose: UNSET VOLATILE
May 11 06:16:01 volumio volumio[894]: info: CorePlayQueue::clearPlayQueue
May 11 06:16:01 volumio volumio[894]: info: CorePlayQueue::saveQueue
May 11 06:16:01 volumio volumio[894]: info: CoreCommandRouter::volumioPushState
May 11 06:16:01 volumio volumio[894]: info: CoreCommandRouter::volumioPushQueue
May 11 06:16:01 volumio volumio[894]: info: CoreStateMachine::addQueueItems
May 11 06:16:01 volumio volumio[894]: info: CorePlayQueue::addQueueItems
May 11 06:16:01 volumio volumio[894]: info: Adding Item to queue: http://serpent0.duckdns.org:8088/kbsfm.pls
May 11 06:16:01 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
May 11 06:16:01 volumio volumio[894]: info: CorePlayQueue::saveQueue
May 11 06:16:01 volumio volumio[894]: info: CoreCommandRouter::volumioPushQueue
May 11 06:16:01 volumio volumio[894]: info: CoreStateMachine::updateTrackBlock
May 11 06:16:01 volumio volumio[894]: info: CorePlayQueue::getTrackBlock
May 11 06:16:01 volumio volumio[894]: info: CoreCommandRouter::volumioPlay
May 11 06:16:01 volumio volumio[894]: verbose: UNSET VOLATILE
May 11 06:16:01 volumio volumio[894]: info: CoreStateMachine::play index 0
May 11 06:16:01 volumio volumio[894]: info: CoreStateMachine::setConsumeUpdateService undefined
May 11 06:16:01 volumio volumio[894]: info: CoreStateMachine::stop
May 11 06:16:01 volumio volumio[894]: info: CoreStateMachine::setConsumeUpdateService undefined
May 11 06:16:01 volumio volumio[894]: verbose: UNSET VOLATILE
May 11 06:16:01 volumio volumio[894]: info: CoreStateMachine::play index undefined
May 11 06:16:01 volumio volumio[894]: info: CoreStateMachine::setConsumeUpdateService undefined
May 11 06:16:01 volumio volumio[894]: info: CorePlayQueue::getTrack 0
May 11 06:16:01 volumio volumio[894]: info: CoreStateMachine::startPlaybackTimer
May 11 06:16:01 volumio volumio[894]: info: CorePlayQueue::getTrack 0
May 11 06:16:01 volumio volumio[894]: info: [1715408161341] ControllerWebradio::clearAddPlayTrack
May 11 06:16:01 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand stop
May 11 06:16:01 volumio volumio[894]: info:
May 11 06:16:01 volumio volumio[894]: ---------------------------- MPD announces state update: player
May 11 06:16:01 volumio volumio[894]: info: sendMpdCommand stop took 290 milliseconds
May 11 06:16:01 volumio volumio[894]: info: ControllerMpd::getState
May 11 06:16:01 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand status
May 11 06:16:01 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand clear
May 11 06:16:01 volumio volumio[894]: info:
May 11 06:16:01 volumio volumio[894]: ---------------------------- MPD announces system playlist update
May 11 06:16:01 volumio volumio[894]: info: Ignoring MPD Status Update
May 11 06:16:01 volumio volumio[894]: info: sendMpdCommand status took 4 milliseconds
May 11 06:16:01 volumio volumio[894]: info: sendMpdCommand clear took 3 milliseconds
May 11 06:16:01 volumio volumio[894]: verbose: ControllerMpd::parseState
May 11 06:16:01 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 11 06:16:01 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand load "http://serpent0.duckdns.org:8088/kbsfm.pls"
May 11 06:16:01 volumio volumio[894]: error: updateQueue error: null
May 11 06:16:01 volumio volumio[894]: info: ------------------------------ 8ms
May 11 06:16:01 volumio volumio[894]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 11 06:16:01 volumio volumio[894]: verbose: ControllerMpd::parseTrackInfo
May 11 06:16:01 volumio volumio[894]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 11 06:16:01 volumio volumio[894]: info: ------------------------------ 16ms
May 11 06:16:01 volumio volumio[894]: info:
May 11 06:16:01 volumio volumio[894]: ---------------------------- MPD announces system playlist update
May 11 06:16:01 volumio volumio[894]: info: Ignoring MPD Status Update
May 11 06:16:01 volumio volumio[894]: info: sendMpdCommand load "http://serpent0.duckdns.org:8088/kbsfm.pls" took 19 milliseconds
May 11 06:16:01 volumio volumio[894]: info: CoreStateMachine::setConsumeUpdateService mpd
May 11 06:16:01 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand play
May 11 06:16:01 volumio volumio[894]: info: ------------------------------ 4ms
May 11 06:16:01 volumio volumio[894]: info: sendMpdCommand play took 3 milliseconds
May 11 06:16:02 volumio volumio[894]: info:
May 11 06:16:02 volumio volumio[894]: ---------------------------- MPD announces state update: player
May 11 06:16:02 volumio volumio[894]: info: ControllerMpd::getState
May 11 06:16:02 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand status
May 11 06:16:02 volumio volumio[894]: info:
May 11 06:16:02 volumio volumio[894]: ---------------------------- MPD announces state update: player
May 11 06:16:02 volumio kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error!
May 11 06:16:02 volumio volumio[894]: info: sendMpdCommand status took 11 milliseconds
May 11 06:16:02 volumio volumio[894]: info: ControllerMpd::getState
May 11 06:16:02 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand status
May 11 06:16:02 volumio volumio[894]: verbose: ControllerMpd::parseState
May 11 06:16:02 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 11 06:16:02 volumio volumio[894]: info: sendMpdCommand status took 2 milliseconds
May 11 06:16:02 volumio volumio[894]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 11 06:16:02 volumio volumio[894]: verbose: ControllerMpd::parseState
May 11 06:16:02 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 11 06:16:02 volumio volumio[894]: verbose: ControllerMpd::parseTrackInfo
May 11 06:16:02 volumio volumio[894]: info: ControllerMpd::pushState
May 11 06:16:02 volumio volumio[894]: info: CoreCommandRouter::servicePushState
May 11 06:16:02 volumio volumio[894]: info: CorePlayQueue::getTrack 0
May 11 06:16:02 volumio volumio[894]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"KBS Classic FM","artist":null,"album":null,"uri":"https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Expires=1715579960&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1NTc5OTYwfX19XX0_&Signature=Qv-EYWfqncv5ycESHKUKYZbwzUw0p1pvf0982JtYwR~6yUtHmzDehzN2pil7vZRSr2gX1CqiNQRXH-03ex~t1FYnxMikTs5IcO21MdcOvXTKq0DZlVPtE6mS7dytDDFYSuh2iR5QUIgtywWy2aMr0xbfYnwEVAtGgloXoxpyv5CZ6EvOGHBLBv3~R6WFAjzODTKhGrUVQCGgrTU7ujNDTGw2VMp18Ri~eRjqz5caMF-aSmXB6haVO-mfUCnMpY~zhhlsuTH9caFEibw~8VHUc2ajIJhHcnPMQygkXTxl~PFedIQwN~GIe3kQMbnWBiuPPtAcBoRKNmlawL~bX52fYw__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA","trackType":""}
May 11 06:16:02 volumio volumio[894]: verbose: CURRENT POSITION 0
May 11 06:16:02 volumio volumio[894]: info: CoreStateMachine::syncState stateService play
May 11 06:16:02 volumio volumio[894]: info: CoreStateMachine::syncState currentStatus stop
May 11 06:16:02 volumio volumio[894]: info: CoreStateMachine::pushState
May 11 06:16:02 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 06:16:02 volumio volumio[894]: info: CoreCommandRouter::volumioPushState
May 11 06:16:02 volumio volumio[894]: info: ------------------------------ 44ms
May 11 06:16:02 volumio volumio[894]: info: sendMpdCommand playlistinfo took 26 milliseconds
May 11 06:16:02 volumio volumio[894]: verbose: ControllerMpd::parseTrackInfo
May 11 06:16:02 volumio volumio[894]: info: ControllerMpd::pushState
May 11 06:16:02 volumio volumio[894]: info: CoreCommandRouter::servicePushState
May 11 06:16:02 volumio volumio[894]: info: CorePlayQueue::getTrack 0
May 11 06:16:02 volumio volumio[894]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"190 Kbps","isStreaming":false,"title":"KBS Classic FM","artist":null,"album":null,"uri":"https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Expires=1715579960&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1NTc5OTYwfX19XX0_&Signature=Qv-EYWfqncv5ycESHKUKYZbwzUw0p1pvf0982JtYwR~6yUtHmzDehzN2pil7vZRSr2gX1CqiNQRXH-03ex~t1FYnxMikTs5IcO21MdcOvXTKq0DZlVPtE6mS7dytDDFYSuh2iR5QUIgtywWy2aMr0xbfYnwEVAtGgloXoxpyv5CZ6EvOGHBLBv3~R6WFAjzODTKhGrUVQCGgrTU7ujNDTGw2VMp18Ri~eRjqz5caMF-aSmXB6haVO-mfUCnMpY~zhhlsuTH9caFEibw~8VHUc2ajIJhHcnPMQygkXTxl~PFedIQwN~GIe3kQMbnWBiuPPtAcBoRKNmlawL~bX52fYw__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA","trackType":""}
May 11 06:16:02 volumio volumio[894]: verbose: CURRENT POSITION 0
May 11 06:16:02 volumio volumio[894]: info: CoreStateMachine::syncState stateService play
May 11 06:16:02 volumio volumio[894]: info: CoreStateMachine::syncState currentStatus play
May 11 06:16:02 volumio volumio[894]: info: Received an update from plugin. extracting info from payload
May 11 06:16:02 volumio volumio[894]: info: CoreStateMachine::pushState
May 11 06:16:02 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 06:16:02 volumio volumio[894]: info: CoreCommandRouter::volumioPushState
May 11 06:16:02 volumio volumio[894]: info: CoreStateMachine::pushState
May 11 06:16:02 volumio volumio[894]: info: CoreCommandRouter::volumioPushState
May 11 06:16:02 volumio volumio[894]: info: ------------------------------ 76ms
May 11 06:16:31 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 11 06:16:31 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 11 06:16:31 volumio volumio[894]: info: Discovery: Getting this device information
May 11 06:16:31 volumio volumio[894]: info: CoreCommandRouter::volumioGetState
May 11 06:16:31 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 11 06:16:40 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 11 06:16:40 volumio volumio[894]: info: CURURI: music-library
May 11 06:16:40 volumio volumio[894]: error: Failed LSINFO: null
May 11 06:16:52 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri
May 11 06:16:57 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri
May 11 06:17:01 volumio volumio[894]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 11 06:17:01 volumio volumio[894]: info: CoreStateMachine::ClearQueue
May 11 06:17:01 volumio volumio[894]: info: CoreStateMachine::stop
May 11 06:17:01 volumio volumio[894]: info: CoreStateMachine::setConsumeUpdateService undefined
May 11 06:17:01 volumio volumio[894]: verbose: UNSET VOLATILE
May 11 06:17:01 volumio volumio[894]: info: CoreStateMachine::stPlaybackTimer
May 11 06:17:01 volumio volumio[894]: info: CoreStateMachine::updateTrackBlock
May 11 06:17:01 volumio volumio[894]: info: CorePlayQueue::getTrackBlock
May 11 06:17:01 volumio volumio[894]: info: CoreStateMachine::pushState
May 11 06:17:01 volumio volumio[894]: info: CorePlayQueue::getTrack 0
May 11 06:17:01 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 06:17:01 volumio volumio[894]: info: CoreCommandRouter::volumioPushState
May 11 06:17:01 volumio volumio[894]: info: CoreStateMachine::serviceStop
May 11 06:17:01 volumio volumio[894]: info: CorePlayQueue::getTrack 0
May 11 06:17:01 volumio volumio[894]: info: CoreCommandRouter::serviceStop
May 11 06:17:01 volumio volumio[894]: info: [1715408221562] ControllerWebradio::stop
May 11 06:17:01 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand stop
May 11 06:17:01 volumio volumio[894]: info: CorePlayQueue::clearPlayQueue
May 11 06:17:01 volumio volumio[894]: info: CorePlayQueue::saveQueue
May 11 06:17:01 volumio volumio[894]: info: CoreCommandRouter::volumioPushState
May 11 06:17:01 volumio volumio[894]: info: CoreCommandRouter::volumioPushQueue
May 11 06:17:01 volumio volumio[894]: info: CoreStateMachine::addQueueItems
May 11 06:17:01 volumio volumio[894]: info: CorePlayQueue::addQueueItems
May 11 06:17:01 volumio volumio[894]: info: Adding Item to queue: webmbc/1
May 11 06:17:01 volumio volumio[894]: info: Exploding uri webmbc/1 in service personal_radio
May 11 06:17:01 volumio volumio[894]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 11 06:17:01 volumio volumio[894]: ReferenceError: self is not defined
May 11 06:17:01 volumio volumio[894]: at ControllerPersonalRadio.errorToast (/data/plugins/music_service/personal_radio/index.js:575:22)
May 11 06:17:01 volumio volumio[894]: at /data/plugins/music_service/personal_radio/index.js:487:12
May 11 06:17:01 volumio volumio[894]: at Request.handleRequestResponse [as _callback] (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:355:15)
May 11 06:17:01 volumio volumio[894]: at self.callback (/data/plugins/music_service/personal_radio/node_modules/request/request.js:187:22)
May 11 06:17:01 volumio volumio[894]: at Request.emit (events.js:315:20)
May 11 06:17:01 volumio volumio[894]: at Request.init (/data/plugins/music_service/personal_radio/node_modules/request/request.js:275:17)
May 11 06:17:01 volumio volumio[894]: at new Request (/data/plugins/music_service/personal_radio/node_modules/request/request.js:129:8)
May 11 06:17:01 volumio volumio[894]: at Function.request (/data/plugins/music_service/personal_radio/node_modules/request/index.js:55:10)
May 11 06:17:01 volumio volumio[894]: at Object.end (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:595:27)
May 11 06:17:01 volumio volumio[894]: at ControllerPersonalRadio.getStreamUrl (/data/plugins/music_service/personal_radio/index.js:482:4)
May 11 06:17:01 volumio volumio[894]: at ControllerPersonalRadio.explodeUri (/data/plugins/music_service/personal_radio/index.js:420:12)
May 11 06:17:01 volumio volumio[894]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1324:16)
May 11 06:17:01 volumio volumio[894]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:144:48)
May 11 06:17:01 volumio volumio[894]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:243:25)
May 11 06:17:01 volumio volumio[894]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:487:23)
May 11 06:17:01 volumio volumio[894]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:457:17)
May 11 06:17:01 volumio volumio[894]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 11 06:17:02 volumio sudo[1389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-11 06:16
May 11 06:17:02 volumio sudo[1389]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="e5f8795c07ba36ff2b02d7ba0a21c7a0f29b897e"
VOLUMIO_FE_VERSION="473d8facbed5f9754db84a81b093baace7aa4b64"
VOLUMIO_FE3_VERSION="934cddf6d46478e7a53a8d3664cd346f4de7cb34"
VOLUMIO_BE_VERSION="359b2717b79cfc72b7d1c918d0fc2885a93bca70"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 24 Jan 2022 10:51:57 AM CET"
VOLUMIO_VERSION="3.198"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="74e6a9ad035e912732893c8d6b060b17"