-- Logs begin at Sat 2025-07-19 07:22:20 UTC, end at Sat 2025-07-19 07:36:20 UTC. -- Jul 19 07:35:56 volumio kernel: usb 1-3: new high-speed USB device number 5 using ehci-pci Jul 19 07:35:57 volumio kernel: usb 3-1: new full-speed USB device number 2 using uhci_hcd Jul 19 07:35:57 volumio kernel: usb 3-1: not running at top speed; connect to a high speed hub Jul 19 07:35:57 volumio kernel: usb 3-1: New USB device found, idVendor=20b1, idProduct=2023 Jul 19 07:35:57 volumio kernel: usb 3-1: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Jul 19 07:35:57 volumio kernel: usb 3-1: Product: JLsounds Hi-Rez Audio 2.0 Jul 19 07:35:57 volumio kernel: usb 3-1: Manufacturer: JLsounds Jul 19 07:35:59 volumio kernel: snd_usb_audio: unknown parameter 'nrpacks' ignored Jul 19 07:35:59 volumio systemd[1]: Starting Sound Card. Jul 19 07:35:59 volumio systemd[1]: Reached target Sound Card. Jul 19 07:35:59 volumio kernel: usbcore: registered new interface driver snd-usb-audio Jul 19 07:35:59 volumio volumio[821]: info: Jul 19 07:35:59 volumio volumio[821]: ---------------------------- USB Audio Device Attached Jul 19 07:35:59 volumio volumio[821]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 19 07:36:04 volumio volumio[821]: info: CoreCommandRouter::volumioGetQueue Jul 19 07:36:04 volumio volumio[821]: info: CoreStateMachine::getQueue Jul 19 07:36:04 volumio volumio[821]: info: CorePlayQueue::getQueue Jul 19 07:36:12 volumio volumio[821]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Jul 19 07:36:12 volumio volumio[821]: info: [1752910572703] [80s80s] handleBrowseUri curUri: 80s80s Jul 19 07:36:14 volumio volumio[821]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Jul 19 07:36:14 volumio volumio[821]: info: [1752910574565] [80s80s] handleBrowseUri curUri: 80s80s/eighties Jul 19 07:36:14 volumio volumio[821]: info: [1752910574565] [80s80s] getRadioContent url: eighties Jul 19 07:36:17 volumio volumio[821]: info: CoreCommandRouter::volumioAddQueueItems Jul 19 07:36:17 volumio volumio[821]: info: CoreStateMachine::addQueueItems Jul 19 07:36:17 volumio volumio[821]: info: CorePlayQueue::addQueueItems Jul 19 07:36:17 volumio volumio[821]: info: Adding Item to queue: webeighties/3 Jul 19 07:36:17 volumio volumio[821]: info: Exploding uri webeighties/3 in service 80s80s Jul 19 07:36:17 volumio volumio[821]: info: [1752910577007] [80s80s] explodeUri: webeighties/3 Jul 19 07:36:17 volumio volumio[821]: info: CorePlayQueue::saveQueue Jul 19 07:36:17 volumio volumio[821]: info: CoreCommandRouter::volumioPushQueue Jul 19 07:36:18 volumio volumio[821]: info: CoreStateMachine::updateTrackBlock Jul 19 07:36:18 volumio volumio[821]: info: CorePlayQueue::getTrackBlock Jul 19 07:36:18 volumio volumio[821]: info: CoreCommandRouter::volumioPlay Jul 19 07:36:18 volumio volumio[821]: UNSET VOLATILE Jul 19 07:36:18 volumio volumio[821]: info: CoreStateMachine::play index 13662 Jul 19 07:36:18 volumio volumio[821]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 07:36:18 volumio volumio[821]: info: CoreStateMachine::stop Jul 19 07:36:18 volumio volumio[821]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 07:36:18 volumio volumio[821]: UNSET VOLATILE Jul 19 07:36:18 volumio volumio[821]: info: CoreStateMachine::play index undefined Jul 19 07:36:18 volumio volumio[821]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 07:36:18 volumio volumio[821]: info: CorePlayQueue::getTrack 13662 Jul 19 07:36:18 volumio volumio[821]: info: CoreStateMachine::startPlaybackTimer Jul 19 07:36:18 volumio volumio[821]: info: CorePlayQueue::getTrack 13662 Jul 19 07:36:18 volumio volumio[821]: info: [1752910578029] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/party/mp3-192/volumio Jul 19 07:36:18 volumio volumio[821]: info: [1752910578029] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=252&count=2 Jul 19 07:36:18 volumio volumio[821]: info: [1752910578378] [80s80s] received new event containing 2 songs. Jul 19 07:36:18 volumio volumio[821]: verbose: ControllerMpd::sendMpdCommand stop Jul 19 07:36:18 volumio volumio[821]: verbose: ControllerMpd::sendMpdCommand clear Jul 19 07:36:18 volumio volumio[821]: info: Jul 19 07:36:18 volumio volumio[821]: ---------------------------- MPD announces system playlist update Jul 19 07:36:18 volumio volumio[821]: info: Ignoring MPD Status Update Jul 19 07:36:18 volumio volumio[821]: info: [1752910578385] [80s80s] adding url: http://streams.80s80s.de/party/mp3-192/volumio Jul 19 07:36:18 volumio volumio[821]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/party/mp3-192/volumio" Jul 19 07:36:18 volumio volumio[821]: error: updateQueue error: null Jul 19 07:36:18 volumio volumio[821]: info: Jul 19 07:36:18 volumio volumio[821]: ---------------------------- MPD announces system playlist update Jul 19 07:36:18 volumio volumio[821]: info: Ignoring MPD Status Update Jul 19 07:36:18 volumio volumio[821]: info: ------------------------------ 13ms Jul 19 07:36:18 volumio volumio[821]: verbose: ControllerMpd::sendMpdCommand play Jul 19 07:36:18 volumio volumio[821]: info: ------------------------------ 14ms Jul 19 07:36:18 volumio volumio[821]: info: [1752910578409] [80s80s] Pushing the next song state: Thomas Dolby - She Blinded Me With Science Jul 19 07:36:18 volumio volumio[821]: info: CorePlayQueue::getTrack 13662 Jul 19 07:36:18 volumio volumio[821]: info: CoreCommandRouter::servicePushState Jul 19 07:36:18 volumio volumio[821]: info: CorePlayQueue::getTrack 13662 Jul 19 07:36:18 volumio volumio[821]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music115/v4/0b/fd/e4/0bfde49f-e22a-0382-0df7-ad9ed1c07782/source/600x600bb.jpg","name":"Thomas Dolby - She Blinded Me With Science","title":"She Blinded Me With Science","artist":"80s80s Party","album":"","streaming":true,"disableUiControls":true,"duration":"297","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 19 07:36:18 volumio volumio[821]: verbose: CURRENT POSITION 13662 Jul 19 07:36:18 volumio volumio[821]: info: CoreStateMachine::syncState stateService play Jul 19 07:36:18 volumio volumio[821]: info: CoreStateMachine::syncState currentStatus stop Jul 19 07:36:18 volumio volumio[821]: info: CoreStateMachine::pushState Jul 19 07:36:18 volumio volumio[821]: info: CorePlayQueue::getTrack 13662 Jul 19 07:36:18 volumio volumio[821]: info: CoreCommandRouter::volumioPushState Jul 19 07:36:18 volumio volumio[821]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 07:36:18 volumio volumio[821]: info: [1752910578443] [80s80s] getContentOfUrl started with url http://ntp-a4.nict.go.jp/cgi-bin/json Jul 19 07:36:18 volumio volumio[821]: info: CorePlayQueue::getTrack 13662 Jul 19 07:36:18 volumio volumio[821]: info: CorePlayQueue::getTrack 13663 Jul 19 07:36:19 volumio volumio[821]: info: Jul 19 07:36:19 volumio volumio[821]: ---------------------------- MPD announces state update: player Jul 19 07:36:19 volumio volumio[821]: info: ControllerMpd::getState Jul 19 07:36:19 volumio volumio[821]: verbose: ControllerMpd::sendMpdCommand status Jul 19 07:36:19 volumio volumio[821]: info: Jul 19 07:36:19 volumio volumio[821]: ---------------------------- MPD announces system playlist update Jul 19 07:36:19 volumio volumio[821]: info: Ignoring MPD Status Update Jul 19 07:36:19 volumio volumio[821]: info: Jul 19 07:36:19 volumio volumio[821]: ---------------------------- MPD announces state update: player Jul 19 07:36:19 volumio volumio[821]: info: ControllerMpd::getState Jul 19 07:36:19 volumio volumio[821]: verbose: ControllerMpd::sendMpdCommand status Jul 19 07:36:19 volumio volumio[821]: verbose: ControllerMpd::parseState Jul 19 07:36:19 volumio volumio[821]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 07:36:19 volumio volumio[821]: info: Jul 19 07:36:19 volumio volumio[821]: ---------------------------- MPD announces system playlist update Jul 19 07:36:19 volumio volumio[821]: info: Ignoring MPD Status Update Jul 19 07:36:19 volumio volumio[821]: info: Jul 19 07:36:19 volumio volumio[821]: ---------------------------- MPD announces state update: player Jul 19 07:36:19 volumio volumio[821]: info: ControllerMpd::getState Jul 19 07:36:19 volumio volumio[821]: verbose: ControllerMpd::sendMpdCommand status Jul 19 07:36:19 volumio volumio[821]: info: ------------------------------ 7ms Jul 19 07:36:19 volumio volumio[821]: verbose: ControllerMpd::parseState Jul 19 07:36:19 volumio volumio[821]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 07:36:19 volumio volumio[821]: verbose: ControllerMpd::parseTrackInfo Jul 19 07:36:19 volumio volumio[821]: info: ControllerMpd::pushState Jul 19 07:36:19 volumio volumio[821]: info: CoreCommandRouter::servicePushState Jul 19 07:36:19 volumio volumio[821]: info: CorePlayQueue::getTrack 13662 Jul 19 07:36:19 volumio volumio[821]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Jul 19 07:36:19 volumio volumio[821]: info: ------------------------------ 62ms Jul 19 07:36:19 volumio volumio[821]: info: ------------------------------ 5ms Jul 19 07:36:19 volumio volumio[821]: verbose: ControllerMpd::parseState Jul 19 07:36:19 volumio volumio[821]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 07:36:19 volumio volumio[821]: verbose: ControllerMpd::parseTrackInfo Jul 19 07:36:19 volumio volumio[821]: info: ControllerMpd::pushState Jul 19 07:36:19 volumio volumio[821]: info: CoreCommandRouter::servicePushState Jul 19 07:36:19 volumio volumio[821]: info: CorePlayQueue::getTrack 13662 Jul 19 07:36:19 volumio volumio[821]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Jul 19 07:36:19 volumio volumio[821]: info: ------------------------------ 12ms Jul 19 07:36:19 volumio volumio[821]: verbose: ControllerMpd::parseTrackInfo Jul 19 07:36:19 volumio volumio[821]: info: ControllerMpd::pushState Jul 19 07:36:19 volumio volumio[821]: info: CoreCommandRouter::servicePushState Jul 19 07:36:19 volumio volumio[821]: info: CorePlayQueue::getTrack 13662 Jul 19 07:36:19 volumio volumio[821]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Jul 19 07:36:19 volumio volumio[821]: info: ------------------------------ 7ms Jul 19 07:36:20 volumio volumio[821]: info: [1752910580234] [80s80s] Failed to query api, status code: 404 Jul 19 07:36:20 volumio volumio[821]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 19 07:36:20 volumio volumio[821]: ReferenceError: station is not defined Jul 19 07:36:20 volumio volumio[821]: at ClientRequest.http.get (/data/plugins/music_service/80s80s/index.js:478:26) Jul 19 07:36:20 volumio volumio[821]: at Object.onceWrapper (events.js:315:30) Jul 19 07:36:20 volumio volumio[821]: at emitOne (events.js:116:13) Jul 19 07:36:20 volumio volumio[821]: at ClientRequest.emit (events.js:211:7) Jul 19 07:36:20 volumio volumio[821]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:551:21) Jul 19 07:36:20 volumio volumio[821]: at HTTPParser.parserOnHeadersComplete (_http_common.js:115:23) Jul 19 07:36:20 volumio volumio[821]: at Socket.socketOnData (_http_client.js:440:20) Jul 19 07:36:20 volumio volumio[821]: at emitOne (events.js:116:13) Jul 19 07:36:20 volumio volumio[821]: at Socket.emit (events.js:211:7) Jul 19 07:36:20 volumio volumio[821]: at addChunk (_stream_readable.js:263:12) Jul 19 07:36:20 volumio volumio[821]: at readableAddChunk (_stream_readable.js:250:11) Jul 19 07:36:20 volumio volumio[821]: at Socket.Readable.push (_stream_readable.js:208:10) Jul 19 07:36:20 volumio volumio[821]: at TCP.onread (net.js:607:20) Jul 19 07:36:20 volumio volumio[821]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 19 07:36:20 volumio sudo[3272]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-19 07:35 Jul 19 07:36:20 volumio sudo[3272]: 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"