-- Logs begin at Fri 2024-10-11 13:28:44 UTC, end at Sat 2024-10-12 02:17:17 UTC. -- Oct 12 02:16:08 volumio volumio[4848]: info: CoreCommandRouter::volumioPlay Oct 12 02:16:08 volumio volumio[4848]: UNSET VOLATILE Oct 12 02:16:08 volumio volumio[4848]: info: CoreStateMachine::play index undefined Oct 12 02:16:08 volumio volumio[4848]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 02:16:08 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:08 volumio volumio[4848]: info: CoreStateMachine::startPlaybackTimer Oct 12 02:16:08 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:08 volumio volumio[4848]: verbose: ControllerMpd::sendMpdCommand play Oct 12 02:16:08 volumio volumio[4848]: info: Oct 12 02:16:08 volumio volumio[4848]: ---------------------------- MPD announces state update: player Oct 12 02:16:08 volumio volumio[4848]: info: ControllerMpd::getState Oct 12 02:16:08 volumio volumio[4848]: verbose: ControllerMpd::sendMpdCommand status Oct 12 02:16:08 volumio volumio[4848]: info: CoreCommandRouter::servicePushState Oct 12 02:16:08 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:08 volumio volumio[4848]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B002NUUCOO.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"Where Is My Mind","title":"Where Is My Mind","artist":"Maxence Cyrin","album":"Novö Piano","streaming":true,"disableUiControls":true,"duration":86,"seek":8443,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Oct 12 02:16:08 volumio volumio[4848]: verbose: CURRENT POSITION 0 Oct 12 02:16:08 volumio volumio[4848]: info: CoreStateMachine::syncState stateService play Oct 12 02:16:08 volumio volumio[4848]: info: CoreStateMachine::syncState currentStatus pause Oct 12 02:16:08 volumio volumio[4848]: info: CoreStateMachine::pushState Oct 12 02:16:08 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:08 volumio volumio[4848]: info: CoreCommandRouter::volumioPushState Oct 12 02:16:08 volumio volumio[4848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 02:16:08 volumio volumio[4848]: info: CoreStateMachine::pushState Oct 12 02:16:08 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:08 volumio volumio[4848]: info: CoreCommandRouter::volumioPushState Oct 12 02:16:08 volumio volumio[4848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 02:16:08 volumio volumio[4848]: info: [1728699368635] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=1 Oct 12 02:16:08 volumio volumio[4848]: verbose: ControllerMpd::parseState Oct 12 02:16:08 volumio volumio[4848]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 02:16:08 volumio volumio[4848]: verbose: ControllerMpd::parseTrackInfo Oct 12 02:16:08 volumio volumio[4848]: info: ControllerMpd::pushState Oct 12 02:16:08 volumio volumio[4848]: info: CoreCommandRouter::servicePushState Oct 12 02:16:08 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:08 volumio volumio[4848]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 12 02:16:08 volumio volumio[4848]: info: ------------------------------ 75ms Oct 12 02:16:09 volumio volumio[4848]: info: [1728699369336] [RadioParadise] received new metadata: {"time":60,"artist":"Maxence Cyrin","title":"Where Is My Mind","album":"Novö Piano","year":"2009","cover":"https://img.radioparadise.com/covers/l/B002NUUCOO.jpg","cover_med":"https://img.radioparadise.com/covers/m/B002NUUCOO.jpg","cover_small":"https://img.radioparadise.com/covers/s/B002NUUCOO.jpg"} Oct 12 02:16:09 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:09 volumio volumio[4848]: info: CoreCommandRouter::servicePushState Oct 12 02:16:09 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:09 volumio volumio[4848]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B002NUUCOO.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"Where Is My Mind","title":"Where Is My Mind","artist":"Maxence Cyrin","album":"Novö Piano","streaming":true,"disableUiControls":true,"duration":65,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Oct 12 02:16:09 volumio volumio[4848]: verbose: CURRENT POSITION 0 Oct 12 02:16:09 volumio volumio[4848]: info: CoreStateMachine::syncState stateService play Oct 12 02:16:09 volumio volumio[4848]: info: CoreStateMachine::syncState currentStatus play Oct 12 02:16:09 volumio volumio[4848]: info: Received an update from plugin. extracting info from payload Oct 12 02:16:09 volumio volumio[4848]: info: CoreStateMachine::pushState Oct 12 02:16:09 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:09 volumio volumio[4848]: info: CoreCommandRouter::volumioPushState Oct 12 02:16:09 volumio volumio[4848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 02:16:09 volumio volumio[4848]: info: CoreStateMachine::pushState Oct 12 02:16:09 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:09 volumio volumio[4848]: info: CoreCommandRouter::volumioPushState Oct 12 02:16:09 volumio volumio[4848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 02:16:09 volumio volumio[4848]: info: [1728699369370] [RadioParadise] setting new timer with duration of 65000 seconds. Oct 12 02:16:09 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:09 volumio volumio[4848]: info: CorePlayQueue::getTrack 1 Oct 12 02:16:09 volumio volumio[4848]: info: CoreCommandRouter::volumioSeek Oct 12 02:16:09 volumio volumio[4848]: info: CoreStateMachine::seek Oct 12 02:16:09 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:09 volumio volumio[4848]: info: TRACKBLOCK {"service":"radio_paradise","type":"track","trackType":"Rparadise Mellow","radioType":"rp","albumart":"https://img.radioparadise.com/covers/l/B002NUUCOO.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"Where Is My Mind","artist":"Maxence Cyrin","album":"Novö Piano","duration":65,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Oct 12 02:16:09 volumio volumio[4848]: info: CoreStateMachine::startPlaybackTimer Oct 12 02:16:09 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:09 volumio volumio[4848]: info: [1728699369840] [RadioParadise] seek to 0 Oct 12 02:16:09 volumio volumio[4848]: info: CoreStateMachine::pushState Oct 12 02:16:09 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:09 volumio volumio[4848]: info: CoreCommandRouter::volumioPushState Oct 12 02:16:09 volumio volumio[4848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 02:16:40 volumio volumio[4848]: info: CoreCommandRouter::volumioSeek Oct 12 02:16:40 volumio volumio[4848]: info: CoreStateMachine::seek Oct 12 02:16:40 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:40 volumio volumio[4848]: info: TRACKBLOCK {"service":"radio_paradise","type":"track","trackType":"Rparadise Mellow","radioType":"rp","albumart":"https://img.radioparadise.com/covers/l/B002NUUCOO.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"Where Is My Mind","artist":"Maxence Cyrin","album":"Novö Piano","duration":65,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Oct 12 02:16:40 volumio volumio[4848]: info: CoreStateMachine::startPlaybackTimer Oct 12 02:16:40 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:40 volumio volumio[4848]: info: [1728699400956] [RadioParadise] seek to 1000 Oct 12 02:16:40 volumio volumio[4848]: info: CoreStateMachine::pushState Oct 12 02:16:40 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:40 volumio volumio[4848]: info: CoreCommandRouter::volumioPushState Oct 12 02:16:40 volumio volumio[4848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 02:16:49 volumio volumio[4848]: info: CoreCommandRouter::volumioPause Oct 12 02:16:49 volumio volumio[4848]: info: CoreStateMachine::pause Oct 12 02:16:49 volumio volumio[4848]: info: CoreStateMachine::stPlaybackTimer Oct 12 02:16:49 volumio volumio[4848]: info: CoreStateMachine::servicePause Oct 12 02:16:49 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:49 volumio volumio[4848]: info: CoreCommandRouter::servicePause Oct 12 02:16:49 volumio volumio[4848]: verbose: ControllerMpd::sendMpdCommand pause Oct 12 02:16:49 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:49 volumio volumio[4848]: info: CoreCommandRouter::servicePushState Oct 12 02:16:49 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:49 volumio volumio[4848]: verbose: STATE SERVICE {"status":"pause","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B002NUUCOO.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"Where Is My Mind","title":"Where Is My Mind","artist":"Maxence Cyrin","album":"Novö Piano","streaming":true,"disableUiControls":true,"duration":65,"seek":9759,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Oct 12 02:16:49 volumio volumio[4848]: verbose: CURRENT POSITION 0 Oct 12 02:16:49 volumio volumio[4848]: info: CoreStateMachine::syncState stateService pause Oct 12 02:16:49 volumio volumio[4848]: info: CoreStateMachine::syncState currentStatus pause Oct 12 02:16:49 volumio volumio[4848]: info: CoreStateMachine::pushState Oct 12 02:16:49 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:49 volumio volumio[4848]: info: CoreCommandRouter::volumioPushState Oct 12 02:16:49 volumio volumio[4848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 02:16:49 volumio volumio[4848]: info: CoreStateMachine::stPlaybackTimer Oct 12 02:16:49 volumio volumio[4848]: info: Oct 12 02:16:49 volumio volumio[4848]: ---------------------------- MPD announces state update: player Oct 12 02:16:49 volumio volumio[4848]: info: ControllerMpd::getState Oct 12 02:16:49 volumio volumio[4848]: verbose: ControllerMpd::sendMpdCommand status Oct 12 02:16:49 volumio volumio[4848]: verbose: ControllerMpd::parseState Oct 12 02:16:49 volumio volumio[4848]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 02:16:49 volumio volumio[4848]: verbose: ControllerMpd::parseTrackInfo Oct 12 02:16:49 volumio volumio[4848]: info: ControllerMpd::pushState Oct 12 02:16:49 volumio volumio[4848]: info: CoreCommandRouter::servicePushState Oct 12 02:16:49 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:16:49 volumio volumio[4848]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 12 02:16:49 volumio volumio[4848]: info: ------------------------------ 17ms Oct 12 02:17:00 volumio volumio[4848]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri Oct 12 02:17:13 volumio volumio[4848]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Madam/Gone%20Before%20Morning/25816b4c-ee59-40db-8c84-8230d1635a9f.jpg' Oct 12 02:17:16 volumio volumio[4848]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 12 02:17:16 volumio volumio[4848]: info: CoreStateMachine::ClearQueue Oct 12 02:17:16 volumio volumio[4848]: info: CoreStateMachine::stop Oct 12 02:17:16 volumio volumio[4848]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 02:17:16 volumio volumio[4848]: UNSET VOLATILE Oct 12 02:17:16 volumio volumio[4848]: info: CoreStateMachine::updateTrackBlock Oct 12 02:17:16 volumio volumio[4848]: info: CorePlayQueue::getTrackBlock Oct 12 02:17:16 volumio volumio[4848]: info: CoreStateMachine::stPlaybackTimer Oct 12 02:17:16 volumio volumio[4848]: info: CoreStateMachine::pushState Oct 12 02:17:16 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:17:16 volumio volumio[4848]: info: CoreCommandRouter::volumioPushState Oct 12 02:17:16 volumio volumio[4848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 02:17:16 volumio volumio[4848]: info: CoreStateMachine::serviceStop Oct 12 02:17:16 volumio volumio[4848]: info: CorePlayQueue::getTrack 0 Oct 12 02:17:16 volumio volumio[4848]: info: CoreCommandRouter::serviceStop Oct 12 02:17:16 volumio volumio[4848]: info: ControllerMpd::stop Oct 12 02:17:16 volumio volumio[4848]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 02:17:16 volumio volumio[4848]: info: CorePlayQueue::clearPlayQueue Oct 12 02:17:16 volumio volumio[4848]: info: CorePlayQueue::saveQueue Oct 12 02:17:16 volumio volumio[4848]: info: CoreCommandRouter::volumioPushState Oct 12 02:17:16 volumio volumio[4848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 02:17:16 volumio volumio[4848]: info: CoreCommandRouter::volumioPushQueue Oct 12 02:17:16 volumio volumio[4848]: info: CoreStateMachine::addQueueItems Oct 12 02:17:16 volumio volumio[4848]: info: CorePlayQueue::addQueueItems Oct 12 02:17:16 volumio volumio[4848]: info: Adding Item to queue: https://stream.radioparadise.com/mellow-flac Oct 12 02:17:16 volumio volumio[4848]: info: Exploding uri https://stream.radioparadise.com/mellow-flac in service radio_paradise Oct 12 02:17:16 volumio volumio[4848]: info: Adding Item to queue: https://stream.radioparadise.com/flac Oct 12 02:17:16 volumio volumio[4848]: info: Exploding uri https://stream.radioparadise.com/flac in service radio_paradise Oct 12 02:17:16 volumio volumio[4848]: info: Adding Item to queue: cue://USB/3C37-BE59/MUSIC/NO62：贝多芬第六交响曲“田园” Bruno.Walter.-.[Beethoven.Pastorale.Symphony.No.6]/NO62：贝多芬第六交响曲“田园” Bruno.Walter.-.[Beethoven.Pastorale.Symphony.No.6]/CDImage.cue@1 Oct 12 02:17:16 volumio volumio[4848]: info: Exploding uri cue://USB/3C37-BE59/MUSIC/NO62：贝多芬第六交响曲“田园” Bruno.Walter.-.[Beethoven.Pastorale.Symphony.No.6]/NO62：贝多芬第六交响曲“田园” Bruno.Walter.-.[Beethoven.Pastorale.Symphony.No.6]/CDImage.cue@1 in service mpd Oct 12 02:17:16 volumio volumio[4848]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 02:17:16 volumio volumio[4848]: Error: file /mnt/USB/3C37-BE59/MUSIC/NO62：贝多芬第六交响曲“田园” Bruno.Walter.-.[Beethoven.Pastorale.Symphony.No.6]/NO62：贝多芬第六交响曲“田园” Bruno.Walter.-.[Beethoven.Pastorale.Symphony.No.6]/CDImage.cue does not exist Oct 12 02:17:16 volumio volumio[4848]: at Object.parse (/volumio/node_modules/cue-parser/lib/cue.js:37:15) Oct 12 02:17:16 volumio volumio[4848]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:1872:27) Oct 12 02:17:16 volumio volumio[4848]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1283:16) Oct 12 02:17:16 volumio volumio[4848]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:144:48) Oct 12 02:17:16 volumio volumio[4848]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:234:25) Oct 12 02:17:16 volumio volumio[4848]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:476:23) Oct 12 02:17:16 volumio volumio[4848]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:452:17) Oct 12 02:17:16 volumio volumio[4848]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:106:35) Oct 12 02:17:16 volumio volumio[4848]: at emitTwo (events.js:126:13) Oct 12 02:17:16 volumio volumio[4848]: at Socket.emit (events.js:214:7) Oct 12 02:17:16 volumio volumio[4848]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 12 02:17:16 volumio volumio[4848]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Oct 12 02:17:16 volumio volumio[4848]: at process._tickCallback (internal/process/next_tick.js:180:9) Oct 12 02:17:16 volumio volumio[4848]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 02:17:17 volumio sudo[5618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-12 02:16 Oct 12 02:17:17 volumio sudo[5618]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="99dfb342fe07851f1e26bd1d8046d0234eda91dd" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 11 15:53:56 CET 2020" VOLUMIO_VERSION="2.857" VOLUMIO_HARDWARE="aml9xxxarmv7" VOLUMIO_HASH="5e595833ee6075a27fef1ba35f928abb"