-- Logs begin at Sat 2025-01-11 15:19:01 UTC, end at Sat 2025-01-11 17:53:11 UTC. -- Jan 11 17:52:14 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 11 17:52:14 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 11 17:52:14 volumio volumio[1007]: info: Discovery: Getting this device information Jan 11 17:52:14 volumio volumio[1007]: info: CoreCommandRouter::volumioGetState Jan 11 17:52:14 volumio volumio[1007]: info: CorePlayQueue::getTrack 0 Jan 11 17:52:14 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jan 11 17:52:14 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 11 17:52:14 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 11 17:52:44 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 11 17:52:44 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 11 17:52:44 volumio volumio[1007]: info: Discovery: Getting this device information Jan 11 17:52:44 volumio volumio[1007]: info: CoreCommandRouter::volumioGetState Jan 11 17:52:44 volumio volumio[1007]: info: CorePlayQueue::getTrack 0 Jan 11 17:52:44 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jan 11 17:52:44 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 11 17:52:44 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 11 17:52:59 volumio volumio[1007]: info: CoreCommandRouter::volumioGetState Jan 11 17:52:59 volumio volumio[1007]: info: CorePlayQueue::getTrack 0 Jan 11 17:52:59 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 11 17:52:59 volumio volumio[1007]: info: Listing playlists Jan 11 17:52:59 volumio volumio[1007]: info: CoreCommandRouter::volumioGetQueue Jan 11 17:52:59 volumio volumio[1007]: info: CoreStateMachine::getQueue Jan 11 17:52:59 volumio volumio[1007]: info: CorePlayQueue::getQueue Jan 11 17:52:59 volumio volumio[1007]: info: CoreCommandRouter::volumioGetVisibleSources Jan 11 17:52:59 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 17:53:04 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Jan 11 17:53:04 volumio volumio[1007]: info: [1736617984614] [80s80s] handleBrowseUri curUri: 80s80s Jan 11 17:53:05 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Jan 11 17:53:05 volumio volumio[1007]: info: [1736617985703] [80s80s] handleBrowseUri curUri: 80s80s/nineties Jan 11 17:53:05 volumio volumio[1007]: info: [1736617985705] [80s80s] getRadioContent url: nineties Jan 11 17:53:07 volumio volumio[1007]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::ClearQueue Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::stop Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 17:53:07 volumio volumio[1007]: verbose: UNSET VOLATILE Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::stPlaybackTimer Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::updateTrackBlock Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::getTrackBlock Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::pushState Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::getTrack 0 Jan 11 17:53:07 volumio volumio[1007]: info: CoreCommandRouter::volumioPushState Jan 11 17:53:07 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::serviceStop Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::getTrack 0 Jan 11 17:53:07 volumio volumio[1007]: info: CoreCommandRouter::serviceStop Jan 11 17:53:07 volumio volumio[1007]: info: ControllerMpd::stop Jan 11 17:53:07 volumio volumio[1007]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::clearPlayQueue Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::saveQueue Jan 11 17:53:07 volumio volumio[1007]: info: CoreCommandRouter::volumioPushState Jan 11 17:53:07 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:53:07 volumio volumio[1007]: info: CoreCommandRouter::volumioPushQueue Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::addQueueItems Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::addQueueItems Jan 11 17:53:07 volumio volumio[1007]: info: Adding Item to queue: webnineties/0 Jan 11 17:53:07 volumio volumio[1007]: info: Exploding uri webnineties/0 in service 80s80s Jan 11 17:53:07 volumio volumio[1007]: info: [1736617987203] [80s80s] explodeUri: webnineties/0 Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::saveQueue Jan 11 17:53:07 volumio volumio[1007]: info: CoreCommandRouter::volumioPushQueue Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::updateTrackBlock Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::getTrackBlock Jan 11 17:53:07 volumio volumio[1007]: info: CoreCommandRouter::volumioPlay Jan 11 17:53:07 volumio volumio[1007]: verbose: UNSET VOLATILE Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::play index 0 Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::stop Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 17:53:07 volumio volumio[1007]: verbose: UNSET VOLATILE Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::play index undefined Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::getTrack 0 Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::startPlaybackTimer Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::getTrack 0 Jan 11 17:53:07 volumio volumio[1007]: info: [1736617987240] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/pop/mp3-192/volumio Jan 11 17:53:07 volumio volumio[1007]: info: [1736617987242] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=141&count=2 Jan 11 17:53:07 volumio volumio[1007]: info: Jan 11 17:53:07 volumio volumio[1007]: ---------------------------- MPD announces state update: player Jan 11 17:53:07 volumio volumio[1007]: info: sendMpdCommand stop took 94 milliseconds Jan 11 17:53:07 volumio volumio[1007]: info: ControllerMpd::getState Jan 11 17:53:07 volumio volumio[1007]: verbose: ControllerMpd::sendMpdCommand status Jan 11 17:53:07 volumio volumio[1007]: info: sendMpdCommand status took 3 milliseconds Jan 11 17:53:07 volumio volumio[1007]: verbose: ControllerMpd::parseState Jan 11 17:53:07 volumio volumio[1007]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 17:53:07 volumio volumio[1007]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 11 17:53:07 volumio volumio[1007]: verbose: ControllerMpd::parseTrackInfo Jan 11 17:53:07 volumio volumio[1007]: info: ControllerMpd::pushState Jan 11 17:53:07 volumio volumio[1007]: info: CoreCommandRouter::servicePushState Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::pushState Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::getTrack 0 Jan 11 17:53:07 volumio volumio[1007]: info: CoreCommandRouter::volumioPushState Jan 11 17:53:07 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::getTrack 0 Jan 11 17:53:07 volumio volumio[1007]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Jan 11 17:53:07 volumio volumio[1007]: info: ------------------------------ 51ms Jan 11 17:53:07 volumio volumio[1007]: info: [1736617987519] [80s80s] received new event containing 2 songs. Jan 11 17:53:07 volumio volumio[1007]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 17:53:07 volumio volumio[1007]: info: sendMpdCommand stop took 4 milliseconds Jan 11 17:53:07 volumio volumio[1007]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 17:53:07 volumio volumio[1007]: info: Jan 11 17:53:07 volumio volumio[1007]: ---------------------------- MPD announces system playlist update Jan 11 17:53:07 volumio volumio[1007]: info: Ignoring MPD Status Update Jan 11 17:53:07 volumio volumio[1007]: info: sendMpdCommand clear took 9 milliseconds Jan 11 17:53:07 volumio volumio[1007]: info: [1736617987545] [80s80s] adding url: http://streams.90s90s.de/pop/mp3-192/volumio Jan 11 17:53:07 volumio volumio[1007]: verbose: ControllerMpd::sendMpdCommand add "http://streams.90s90s.de/pop/mp3-192/volumio" Jan 11 17:53:07 volumio volumio[1007]: error: updateQueue error: null Jan 11 17:53:07 volumio volumio[1007]: info: Jan 11 17:53:07 volumio volumio[1007]: ---------------------------- MPD announces system playlist update Jan 11 17:53:07 volumio volumio[1007]: info: Ignoring MPD Status Update Jan 11 17:53:07 volumio volumio[1007]: info: ------------------------------ 25ms Jan 11 17:53:07 volumio volumio[1007]: info: sendMpdCommand add "http://streams.90s90s.de/pop/mp3-192/volumio" took 13 milliseconds Jan 11 17:53:07 volumio volumio[1007]: verbose: ControllerMpd::sendMpdCommand play Jan 11 17:53:07 volumio volumio[1007]: info: ------------------------------ 21ms Jan 11 17:53:07 volumio volumio[1007]: info: sendMpdCommand play took 7 milliseconds Jan 11 17:53:07 volumio volumio[1007]: info: [1736617987584] [80s80s] Pushing the next song state: Captain Hollywood Project - Only With You Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::getTrack 0 Jan 11 17:53:07 volumio volumio[1007]: info: CoreCommandRouter::servicePushState Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::getTrack 0 Jan 11 17:53:07 volumio volumio[1007]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music124/v4/64/00/94/640094e9-3bb4-2f1d-bcb3-b465f85f9793/source/600x600bb.jpg","name":"Captain Hollywood Project - Only With You","title":"Only With You","artist":"90s90s Hits","album":"","streaming":true,"disableUiControls":true,"duration":"226","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jan 11 17:53:07 volumio volumio[1007]: verbose: CURRENT POSITION 0 Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::syncState stateService play Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::syncState currentStatus stop Jan 11 17:53:07 volumio volumio[1007]: info: CoreStateMachine::pushState Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::getTrack 0 Jan 11 17:53:07 volumio volumio[1007]: info: CoreCommandRouter::volumioPushState Jan 11 17:53:07 volumio volumio[1007]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 17:53:07 volumio volumio[1007]: info: [1736617987628] [80s80s] getContentOfUrl started with url http://ntp-a4.nict.go.jp/cgi-bin/json Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::getTrack 0 Jan 11 17:53:07 volumio volumio[1007]: info: CorePlayQueue::getTrack 1 Jan 11 17:53:08 volumio volumio[1007]: info: Jan 11 17:53:08 volumio volumio[1007]: ---------------------------- MPD announces state update: player Jan 11 17:53:08 volumio volumio[1007]: info: ControllerMpd::getState Jan 11 17:53:08 volumio volumio[1007]: verbose: ControllerMpd::sendMpdCommand status Jan 11 17:53:08 volumio volumio[1007]: info: sendMpdCommand status took 7 milliseconds Jan 11 17:53:08 volumio volumio[1007]: verbose: ControllerMpd::parseState Jan 11 17:53:08 volumio volumio[1007]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 17:53:08 volumio volumio[1007]: info: Jan 11 17:53:08 volumio volumio[1007]: ---------------------------- MPD announces state update: player Jan 11 17:53:08 volumio volumio[1007]: info: ControllerMpd::getState Jan 11 17:53:08 volumio volumio[1007]: verbose: ControllerMpd::sendMpdCommand status Jan 11 17:53:08 volumio volumio[1007]: info: Jan 11 17:53:08 volumio volumio[1007]: ---------------------------- MPD announces system playlist update Jan 11 17:53:08 volumio volumio[1007]: info: Ignoring MPD Status Update Jan 11 17:53:09 volumio volumio[1007]: info: sendMpdCommand playlistinfo took 8 milliseconds Jan 11 17:53:09 volumio volumio[1007]: info: sendMpdCommand status took 3 milliseconds Jan 11 17:53:09 volumio volumio[1007]: verbose: ControllerMpd::parseTrackInfo Jan 11 17:53:09 volumio volumio[1007]: verbose: ControllerMpd::parseState Jan 11 17:53:09 volumio volumio[1007]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 17:53:09 volumio volumio[1007]: info: ControllerMpd::pushState Jan 11 17:53:09 volumio volumio[1007]: info: CoreCommandRouter::servicePushState Jan 11 17:53:09 volumio volumio[1007]: info: CorePlayQueue::getTrack 0 Jan 11 17:53:09 volumio volumio[1007]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Jan 11 17:53:09 volumio volumio[1007]: info: ------------------------------ 23ms Jan 11 17:53:09 volumio volumio[1007]: info: [1736617988881] [80s80s] Failed to query api, status code: 404 Jan 11 17:53:09 volumio volumio[1007]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 17:53:09 volumio volumio[1007]: ReferenceError: station is not defined Jan 11 17:53:09 volumio volumio[1007]: at ClientRequest.http.get (/data/plugins/music_service/80s80s/index.js:478:26) Jan 11 17:53:09 volumio volumio[1007]: at Object.onceWrapper (events.js:315:30) Jan 11 17:53:09 volumio volumio[1007]: at emitOne (events.js:116:13) Jan 11 17:53:09 volumio volumio[1007]: at ClientRequest.emit (events.js:211:7) Jan 11 17:53:09 volumio volumio[1007]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:551:21) Jan 11 17:53:09 volumio volumio[1007]: at HTTPParser.parserOnHeadersComplete (_http_common.js:115:23) Jan 11 17:53:09 volumio volumio[1007]: at Socket.socketOnData (_http_client.js:440:20) Jan 11 17:53:09 volumio volumio[1007]: at emitOne (events.js:116:13) Jan 11 17:53:09 volumio volumio[1007]: at Socket.emit (events.js:211:7) Jan 11 17:53:09 volumio volumio[1007]: at addChunk (_stream_readable.js:263:12) Jan 11 17:53:09 volumio volumio[1007]: at readableAddChunk (_stream_readable.js:250:11) Jan 11 17:53:09 volumio volumio[1007]: at Socket.Readable.push (_stream_readable.js:208:10) Jan 11 17:53:09 volumio volumio[1007]: at TCP.onread (net.js:607:20) Jan 11 17:53:09 volumio volumio[1007]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 17:53:11 volumio sudo[23090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-11 17:52 Jan 11 17:53:11 volumio sudo[23090]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 11:49:13 CEST 2021" VOLUMIO_VERSION="2.916" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="62511ec23417b6085328d5bda7373a0c"