-- Logs begin at Sat 2024-05-04 12:52:08 UTC, end at Sat 2024-05-04 14:20:30 UTC. -- May 04 14:20:18 volumio volumio[822]: info: May 04 14:20:18 volumio volumio[822]: ---------------------------- MPD announces system playlist update May 04 14:20:18 volumio volumio[822]: info: Ignoring MPD Status Update May 04 14:20:18 volumio volumio[822]: info: May 04 14:20:18 volumio volumio[822]: ---------------------------- MPD announces state update: player May 04 14:20:18 volumio volumio[822]: info: ControllerMpd::getState May 04 14:20:18 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status May 04 14:20:18 volumio volumio[822]: info: ------------------------------ 2ms May 04 14:20:18 volumio volumio[822]: verbose: ControllerMpd::parseState May 04 14:20:18 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 14:20:18 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo May 04 14:20:18 volumio volumio[822]: info: ControllerMpd::pushState May 04 14:20:18 volumio volumio[822]: info: CoreCommandRouter::servicePushState May 04 14:20:18 volumio volumio[822]: info: CorePlayQueue::getTrack 11545 May 04 14:20:18 volumio volumio[822]: verbose: STATE SERVICE {"status":"play","position":9,"seek":46,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"674 Kbps","isStreaming":false,"title":"Rondo Barock","artist":"The O-Zone Percussion Group","album":"La Bamba","uri":"INTERNAL/1996 La Bamba/The O-Zone Percussion Group - La Bamba.flac","trackType":"flac"} May 04 14:20:18 volumio volumio[822]: verbose: CURRENT POSITION 11545 May 04 14:20:18 volumio volumio[822]: info: CoreStateMachine::syncState stateService play May 04 14:20:18 volumio volumio[822]: info: CoreStateMachine::syncState currentStatus play May 04 14:20:18 volumio volumio[822]: info: Received an update from plugin. extracting info from payload May 04 14:20:18 volumio volumio[822]: info: CoreStateMachine::pushState May 04 14:20:18 volumio volumio[822]: info: CorePlayQueue::getTrack 11545 May 04 14:20:18 volumio volumio[822]: info: CoreCommandRouter::volumioPushState May 04 14:20:18 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 14:20:18 volumio volumio[822]: info: CoreStateMachine::pushState May 04 14:20:18 volumio volumio[822]: info: CorePlayQueue::getTrack 11545 May 04 14:20:18 volumio volumio[822]: info: CoreCommandRouter::volumioPushState May 04 14:20:18 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 14:20:18 volumio volumio[822]: info: ------------------------------ 7ms May 04 14:20:22 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri May 04 14:20:22 volumio volumio[822]: info: [1714832422229] [80s80s] handleBrowseUri curUri: 80s80s May 04 14:20:23 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri May 04 14:20:23 volumio volumio[822]: info: [1714832423623] [80s80s] handleBrowseUri curUri: 80s80s/eighties May 04 14:20:23 volumio volumio[822]: info: [1714832423623] [80s80s] getRadioContent url: eighties May 04 14:20:26 volumio volumio[822]: info: CoreCommandRouter::volumioAddQueueItems May 04 14:20:26 volumio volumio[822]: info: CoreStateMachine::addQueueItems May 04 14:20:26 volumio volumio[822]: info: CorePlayQueue::addQueueItems May 04 14:20:26 volumio volumio[822]: info: Adding Item to queue: webeighties/3 May 04 14:20:26 volumio volumio[822]: info: Exploding uri webeighties/3 in service 80s80s May 04 14:20:26 volumio volumio[822]: info: [1714832426493] [80s80s] explodeUri: webeighties/3 May 04 14:20:26 volumio volumio[822]: info: CorePlayQueue::saveQueue May 04 14:20:26 volumio volumio[822]: info: CoreCommandRouter::volumioPushQueue May 04 14:20:27 volumio volumio[822]: info: CoreStateMachine::updateTrackBlock May 04 14:20:27 volumio volumio[822]: info: CorePlayQueue::getTrackBlock May 04 14:20:27 volumio volumio[822]: info: CoreCommandRouter::volumioPlay May 04 14:20:27 volumio volumio[822]: UNSET VOLATILE May 04 14:20:27 volumio volumio[822]: info: CoreStateMachine::play index 11546 May 04 14:20:27 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined May 04 14:20:27 volumio volumio[822]: info: CoreStateMachine::stop May 04 14:20:27 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined May 04 14:20:27 volumio volumio[822]: UNSET VOLATILE May 04 14:20:27 volumio volumio[822]: info: CoreStateMachine::stPlaybackTimer May 04 14:20:27 volumio volumio[822]: info: CoreStateMachine::updateTrackBlock May 04 14:20:27 volumio volumio[822]: info: CorePlayQueue::getTrackBlock May 04 14:20:27 volumio volumio[822]: info: CoreStateMachine::pushState May 04 14:20:27 volumio volumio[822]: info: CorePlayQueue::getTrack 11545 May 04 14:20:27 volumio volumio[822]: info: CoreCommandRouter::volumioPushState May 04 14:20:27 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 14:20:27 volumio volumio[822]: info: CoreStateMachine::serviceStop May 04 14:20:27 volumio volumio[822]: info: CorePlayQueue::getTrack 11545 May 04 14:20:27 volumio volumio[822]: info: CoreCommandRouter::serviceStop May 04 14:20:27 volumio volumio[822]: info: ControllerMpd::stop May 04 14:20:27 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand stop May 04 14:20:27 volumio volumio[822]: info: May 04 14:20:27 volumio volumio[822]: ---------------------------- MPD announces state update: player May 04 14:20:27 volumio volumio[822]: info: ControllerMpd::getState May 04 14:20:27 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status May 04 14:20:27 volumio volumio[822]: info: CoreStateMachine::play index undefined May 04 14:20:27 volumio volumio[822]: info: CoreStateMachine::setConsumeUpdateService undefined May 04 14:20:27 volumio volumio[822]: info: CorePlayQueue::getTrack 11546 May 04 14:20:27 volumio volumio[822]: info: CoreStateMachine::startPlaybackTimer May 04 14:20:27 volumio volumio[822]: info: CorePlayQueue::getTrack 11546 May 04 14:20:27 volumio volumio[822]: info: [1714832427693] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/party/mp3-192/volumio May 04 14:20:27 volumio volumio[822]: info: [1714832427693] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=252&count=2 May 04 14:20:27 volumio volumio[822]: verbose: ControllerMpd::parseState May 04 14:20:27 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 14:20:27 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo May 04 14:20:27 volumio volumio[822]: info: ControllerMpd::pushState May 04 14:20:27 volumio volumio[822]: info: CoreCommandRouter::servicePushState May 04 14:20:27 volumio volumio[822]: info: CoreStateMachine::pushState May 04 14:20:27 volumio volumio[822]: info: CorePlayQueue::getTrack 11546 May 04 14:20:27 volumio volumio[822]: info: CoreCommandRouter::volumioPushState May 04 14:20:27 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 14:20:27 volumio volumio[822]: info: CorePlayQueue::getTrack 11546 May 04 14:20:27 volumio volumio[822]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 04 14:20:27 volumio volumio[822]: info: ------------------------------ 32ms May 04 14:20:28 volumio volumio[822]: info: [1714832428012] [80s80s] received new event containing 2 songs. May 04 14:20:28 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand stop May 04 14:20:28 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand clear May 04 14:20:28 volumio volumio[822]: info: May 04 14:20:28 volumio volumio[822]: ---------------------------- MPD announces system playlist update May 04 14:20:28 volumio volumio[822]: info: Ignoring MPD Status Update May 04 14:20:28 volumio volumio[822]: info: [1714832428015] [80s80s] adding url: http://streams.80s80s.de/party/mp3-192/volumio May 04 14:20:28 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/party/mp3-192/volumio" May 04 14:20:28 volumio volumio[822]: error: updateQueue error: null May 04 14:20:28 volumio volumio[822]: info: May 04 14:20:28 volumio volumio[822]: ---------------------------- MPD announces system playlist update May 04 14:20:28 volumio volumio[822]: info: Ignoring MPD Status Update May 04 14:20:28 volumio volumio[822]: info: ------------------------------ 2ms May 04 14:20:28 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand play May 04 14:20:28 volumio volumio[822]: info: ------------------------------ 1ms May 04 14:20:28 volumio volumio[822]: info: [1714832428019] [80s80s] Pushing the next song state: Chaka Khan - I Feel for You May 04 14:20:28 volumio volumio[822]: info: CorePlayQueue::getTrack 11546 May 04 14:20:28 volumio volumio[822]: info: CoreCommandRouter::servicePushState May 04 14:20:28 volumio volumio[822]: info: CorePlayQueue::getTrack 11546 May 04 14:20:28 volumio volumio[822]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music125/v4/79/30/06/79300691-26b8-c014-2dc4-8e61764fb1ee/source/600x600bb.jpg","name":"Chaka Khan - I Feel for You","title":"I Feel for You","artist":"80s80s Party","album":"","streaming":true,"disableUiControls":true,"duration":"238","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} May 04 14:20:28 volumio volumio[822]: verbose: CURRENT POSITION 11546 May 04 14:20:28 volumio volumio[822]: info: CoreStateMachine::syncState stateService play May 04 14:20:28 volumio volumio[822]: info: CoreStateMachine::syncState currentStatus stop May 04 14:20:28 volumio volumio[822]: info: CoreStateMachine::pushState May 04 14:20:28 volumio volumio[822]: info: CorePlayQueue::getTrack 11546 May 04 14:20:28 volumio volumio[822]: info: CoreCommandRouter::volumioPushState May 04 14:20:28 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 14:20:28 volumio volumio[822]: info: [1714832428022] [80s80s] getContentOfUrl started with url http://ntp-a4.nict.go.jp/cgi-bin/json May 04 14:20:28 volumio volumio[822]: info: CorePlayQueue::getTrack 11546 May 04 14:20:28 volumio volumio[822]: info: CorePlayQueue::getTrack 11547 May 04 14:20:29 volumio volumio[822]: info: May 04 14:20:29 volumio volumio[822]: ---------------------------- MPD announces state update: player May 04 14:20:29 volumio volumio[822]: info: ControllerMpd::getState May 04 14:20:29 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status May 04 14:20:29 volumio volumio[822]: info: May 04 14:20:29 volumio volumio[822]: ---------------------------- MPD announces state update: player May 04 14:20:29 volumio volumio[822]: info: ControllerMpd::getState May 04 14:20:29 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand status May 04 14:20:29 volumio volumio[822]: verbose: ControllerMpd::parseState May 04 14:20:29 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 14:20:29 volumio volumio[822]: info: May 04 14:20:29 volumio volumio[822]: ---------------------------- MPD announces system playlist update May 04 14:20:29 volumio volumio[822]: info: Ignoring MPD Status Update May 04 14:20:29 volumio volumio[822]: verbose: ControllerMpd::parseState May 04 14:20:29 volumio volumio[822]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 14:20:29 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo May 04 14:20:29 volumio volumio[822]: info: ControllerMpd::pushState May 04 14:20:29 volumio volumio[822]: info: CoreCommandRouter::servicePushState May 04 14:20:29 volumio volumio[822]: info: CorePlayQueue::getTrack 11546 May 04 14:20:29 volumio volumio[822]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 04 14:20:29 volumio volumio[822]: info: ------------------------------ 14ms May 04 14:20:29 volumio volumio[822]: info: ------------------------------ 4ms May 04 14:20:29 volumio volumio[822]: verbose: ControllerMpd::parseTrackInfo May 04 14:20:29 volumio volumio[822]: info: ControllerMpd::pushState May 04 14:20:29 volumio volumio[822]: info: CoreCommandRouter::servicePushState May 04 14:20:29 volumio volumio[822]: info: CorePlayQueue::getTrack 11546 May 04 14:20:29 volumio volumio[822]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 04 14:20:29 volumio volumio[822]: info: ------------------------------ 7ms May 04 14:20:29 volumio volumio[822]: info: [1714832429607] [80s80s] Failed to query api, status code: 404 May 04 14:20:29 volumio volumio[822]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 14:20:29 volumio volumio[822]: ReferenceError: station is not defined May 04 14:20:29 volumio volumio[822]: at ClientRequest.http.get (/data/plugins/music_service/80s80s/index.js:478:26) May 04 14:20:29 volumio volumio[822]: at Object.onceWrapper (events.js:315:30) May 04 14:20:29 volumio volumio[822]: at emitOne (events.js:116:13) May 04 14:20:29 volumio volumio[822]: at ClientRequest.emit (events.js:211:7) May 04 14:20:29 volumio volumio[822]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:551:21) May 04 14:20:29 volumio volumio[822]: at HTTPParser.parserOnHeadersComplete (_http_common.js:115:23) May 04 14:20:29 volumio volumio[822]: at Socket.socketOnData (_http_client.js:440:20) May 04 14:20:29 volumio volumio[822]: at emitOne (events.js:116:13) May 04 14:20:29 volumio volumio[822]: at Socket.emit (events.js:211:7) May 04 14:20:29 volumio volumio[822]: at addChunk (_stream_readable.js:263:12) May 04 14:20:29 volumio volumio[822]: at readableAddChunk (_stream_readable.js:250:11) May 04 14:20:29 volumio volumio[822]: at Socket.Readable.push (_stream_readable.js:208:10) May 04 14:20:29 volumio volumio[822]: at TCP.onread (net.js:607:20) May 04 14:20:29 volumio volumio[822]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 14:20:30 volumio sudo[14266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-04 14:19 May 04 14:20:30 volumio sudo[14266]: 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="79c2e7e29d04526018e922852ec460ffc0707dd1" VOLUMIO_FE_VERSION="77c86e8a1bfb19b724ead35c47d417c4832cf290" VOLUMIO_BE_VERSION="f30dbcf35403287bd1b5d6a60fa82e3da7871c6c" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Jul 16 18:57:30 CEST 2020" VOLUMIO_VERSION="2.799" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="5c4ecf8094cc23791be364fa44700bc6"