-- Logs begin at Sun 2025-09-14 05:06:49 UTC, end at Sun 2025-09-14 05:09:20 UTC. -- Sep 14 05:08:00 volumio volumio[1011]: info: VolumeController:: Volume=undefined Mute =false Sep 14 05:08:00 volumio volumio[1011]: info: CoreStateMachine::pushState Sep 14 05:08:00 volumio volumio[1011]: info: CorePlayQueue::getTrack 0 Sep 14 05:08:00 volumio volumio[1011]: info: CoreCommandRouter::volumioPushState Sep 14 05:08:00 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 14 05:08:00 volumio sudo[1303]: pam_unix(sudo:session): session closed for user root Sep 14 05:08:00 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 14 05:08:00 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Sep 14 05:08:00 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Sep 14 05:08:00 volumio sudo[1308]: pam_unix(sudo:session): session closed for user root Sep 14 05:08:00 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Sep 14 05:08:00 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 14 05:08:00 volumio sudo[1307]: pam_unix(sudo:session): session closed for user root Sep 14 05:08:00 volumio volumio[1011]: info: Upmpdcli Daemon Started Sep 14 05:08:00 volumio volumio[1011]: info: Shairport-Sync Started Sep 14 05:08:00 volumio volumio[1011]: Error adding Membership: Error: addMembership EINVAL Sep 14 05:08:01 volumio volumio[1011]: info: Shairport-Sync Started Sep 14 05:08:01 volumio volumio[1011]: info: CoreCommandRouter::volumioGetState Sep 14 05:08:01 volumio volumio[1011]: info: CorePlayQueue::getTrack 0 Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 14 05:08:02 volumio volumio[1011]: info: Adding plugin bluetooth to MyMusic Plugins Sep 14 05:08:02 volumio volumio[1011]: info: Adding plugin cd_controller to MyMusic Plugins Sep 14 05:08:02 volumio volumio[1011]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 14 05:08:02 volumio volumio[1011]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 14 05:08:02 volumio volumio[1011]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 14 05:08:03 volumio volumio[1011]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 14 05:08:03 volumio volumio[1011]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 14 05:08:03 volumio volumio[1011]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 14 05:08:03 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 05:08:03 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 05:08:03 volumio volumio[1011]: info: Starting MyVolumio Remote Streaming Endpoints Sep 14 05:08:03 volumio volumio[1011]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 14 05:08:03 volumio volumio[1011]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 14 05:08:03 volumio volumio[1011]: info: Streaming services startup Sep 14 05:08:03 volumio volumio[1011]: info: Starting Streaming Daemon Sep 14 05:08:03 volumio sudo[1350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 14 05:08:03 volumio sudo[1350]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 05:08:03 volumio volumio[1011]: info: MyVolumio not started Sep 14 05:08:03 volumio volumio[1011]: info: Initializing device activation check Sep 14 05:08:03 volumio volumio[1011]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 14 05:08:03 volumio systemd[1]: Stopping Volumio Streaming Daemon... Sep 14 05:08:03 volumio systemd[1]: Starting Volumio Streaming Daemon... Sep 14 05:08:03 volumio systemd[1]: Started Volumio Streaming Daemon. Sep 14 05:08:03 volumio sudo[1350]: pam_unix(sudo:session): session closed for user root Sep 14 05:08:04 volumio volumio[1011]: info: Connecting to daemon Sep 14 05:08:04 volumio volumio-streaming-daemon[1357]: ############################ Sep 14 05:08:04 volumio volumio-streaming-daemon[1357]: # Volumio Streaming Daemon # Sep 14 05:08:04 volumio volumio-streaming-daemon[1357]: # Running on port 7777 # Sep 14 05:08:04 volumio volumio-streaming-daemon[1357]: ############################ Sep 14 05:08:04 volumio volumio-streaming-daemon[1357]: Environment: production Sep 14 05:08:04 volumio volumio[1011]: error: SPOP command error: Error: connect ECONNREFUSED 127.0.0.1:6602 Sep 14 05:08:04 volumio volumio[1011]: error: SPOP status error: Error: connect ECONNREFUSED 127.0.0.1:6602 Sep 14 05:08:04 volumio volumio[1011]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Sep 14 05:08:04 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 14 05:08:06 volumio volumio-streaming-daemon[1357]: Environment: production Sep 14 05:08:06 volumio volumio[1011]: info: Fetching Streaming Services browse cache Sep 14 05:08:07 volumio volumio-remote-updater[629]: [2025-09-14 05:08:07] [connect] Successful connection Sep 14 05:08:07 volumio volumio-remote-updater[629]: [2025-09-14 05:08:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1757826487 101 Sep 14 05:08:09 volumio kernel: perf interrupt took too long (2519 > 2500), lowering kernel.perf_event_max_sample_rate to 50000 Sep 14 05:08:22 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 14 05:08:22 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 05:08:23 volumio volumio[1011]: info: CoreCommandRouter::volumioGetState Sep 14 05:08:23 volumio volumio[1011]: info: CorePlayQueue::getTrack 0 Sep 14 05:08:23 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 14 05:08:23 volumio volumio[1011]: info: CoreCommandRouter::volumioGetVisibleSources Sep 14 05:08:23 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 14 05:08:23 volumio volumio[1011]: info: Listing playlists Sep 14 05:08:23 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 14 05:08:23 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 14 05:08:23 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 14 05:08:23 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 14 05:08:24 volumio volumio[1011]: info: VolumeController::SetAlsaVolume0 Sep 14 05:08:24 volumio volumio[1011]: info: CoreStateMachine::pushState Sep 14 05:08:24 volumio volumio[1011]: info: CorePlayQueue::getTrack 0 Sep 14 05:08:24 volumio volumio[1011]: info: CoreCommandRouter::volumioPushState Sep 14 05:08:24 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 14 05:08:24 volumio kernel: usb 1-3.2: cannot get ctl value: req = 0x81, wValue = 0x100, wIndex = 0x800, type = 3 Sep 14 05:08:24 volumio volumio[1011]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Sep 14 05:08:27 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 14 05:08:38 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 14 05:08:38 volumio volumio[1011]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 14 05:08:38 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 14 05:08:38 volumio volumio[1011]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio Sep 14 05:08:38 volumio volumio[1011]: info: Received Get System Version Sep 14 05:08:38 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 14 05:09:17 volumio volumio[1011]: info: CoreCommandRouter::volumioPlay Sep 14 05:09:17 volumio volumio[1011]: verbose: UNSET VOLATILE Sep 14 05:09:17 volumio volumio[1011]: info: CoreStateMachine::play index undefined Sep 14 05:09:17 volumio volumio[1011]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 14 05:09:17 volumio volumio[1011]: info: CorePlayQueue::getTrack 0 Sep 14 05:09:17 volumio volumio[1011]: info: CoreStateMachine::startPlaybackTimer Sep 14 05:09:17 volumio volumio[1011]: info: CorePlayQueue::getTrack 0 Sep 14 05:09:17 volumio volumio[1011]: info: [1757826557126] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/love/mp3-192/volumio Sep 14 05:09:17 volumio volumio[1011]: info: [1757826557128] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=85&count=2 Sep 14 05:09:17 volumio volumio[1011]: info: [1757826557411] [80s80s] received new event containing 2 songs. Sep 14 05:09:17 volumio volumio[1011]: verbose: ControllerMpd::sendMpdCommand stop Sep 14 05:09:17 volumio volumio[1011]: info: sendMpdCommand stop took 9 milliseconds Sep 14 05:09:17 volumio volumio[1011]: verbose: ControllerMpd::sendMpdCommand clear Sep 14 05:09:17 volumio volumio[1011]: info: Sep 14 05:09:17 volumio volumio[1011]: ---------------------------- MPD announces system playlist update Sep 14 05:09:17 volumio volumio[1011]: info: Ignoring MPD Status Update Sep 14 05:09:17 volumio volumio[1011]: info: sendMpdCommand clear took 10 milliseconds Sep 14 05:09:17 volumio volumio[1011]: info: [1757826557443] [80s80s] adding url: http://streams.80s80s.de/love/mp3-192/volumio Sep 14 05:09:17 volumio volumio[1011]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/love/mp3-192/volumio" Sep 14 05:09:17 volumio volumio[1011]: error: updateQueue error: null Sep 14 05:09:17 volumio volumio[1011]: info: Sep 14 05:09:17 volumio volumio[1011]: ---------------------------- MPD announces system playlist update Sep 14 05:09:17 volumio volumio[1011]: info: Ignoring MPD Status Update Sep 14 05:09:17 volumio volumio[1011]: info: ------------------------------ 30ms Sep 14 05:09:17 volumio volumio[1011]: info: sendMpdCommand add "http://streams.80s80s.de/love/mp3-192/volumio" took 16 milliseconds Sep 14 05:09:17 volumio volumio[1011]: verbose: ControllerMpd::sendMpdCommand play Sep 14 05:09:17 volumio volumio[1011]: info: ------------------------------ 27ms Sep 14 05:09:17 volumio volumio[1011]: info: sendMpdCommand play took 5 milliseconds Sep 14 05:09:17 volumio volumio[1011]: info: [1757826557486] [80s80s] Pushing the next song state: Prince & The Revolution - I Would Die 4 U Sep 14 05:09:17 volumio volumio[1011]: info: CorePlayQueue::getTrack 0 Sep 14 05:09:17 volumio volumio[1011]: info: CoreCommandRouter::servicePushState Sep 14 05:09:17 volumio volumio[1011]: info: CorePlayQueue::getTrack 0 Sep 14 05:09:17 volumio volumio[1011]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is4-ssl.mzstatic.com/image/thumb/Music125/v4/1d/5f/63/1d5f63e5-03d9-b02b-0ff6-764793106578/source/600x600bb.jpg","name":"Prince & The Revolution - I Would Die 4 U","title":"I Would Die 4 U","artist":"80s80s Love","album":"","streaming":true,"disableUiControls":true,"duration":"161","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Sep 14 05:09:17 volumio volumio[1011]: verbose: CURRENT POSITION 0 Sep 14 05:09:17 volumio volumio[1011]: info: CoreStateMachine::syncState stateService play Sep 14 05:09:17 volumio volumio[1011]: info: CoreStateMachine::syncState currentStatus stop Sep 14 05:09:17 volumio volumio[1011]: info: CoreStateMachine::pushState Sep 14 05:09:17 volumio volumio[1011]: info: CorePlayQueue::getTrack 0 Sep 14 05:09:17 volumio volumio[1011]: info: CoreCommandRouter::volumioPushState Sep 14 05:09:17 volumio volumio[1011]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 14 05:09:17 volumio volumio[1011]: info: [1757826557538] [80s80s] getContentOfUrl started with url http://ntp-a4.nict.go.jp/cgi-bin/json Sep 14 05:09:17 volumio volumio[1011]: info: CorePlayQueue::getTrack 0 Sep 14 05:09:17 volumio volumio[1011]: info: CorePlayQueue::getTrack 1 Sep 14 05:09:18 volumio volumio[1011]: info: [1757826558702] [80s80s] Failed to query api, status code: 404 Sep 14 05:09:18 volumio volumio[1011]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 14 05:09:18 volumio volumio[1011]: ReferenceError: station is not defined Sep 14 05:09:18 volumio volumio[1011]: at ClientRequest.http.get (/data/plugins/music_service/80s80s/index.js:478:26) Sep 14 05:09:18 volumio volumio[1011]: at Object.onceWrapper (events.js:315:30) Sep 14 05:09:18 volumio volumio[1011]: at emitOne (events.js:116:13) Sep 14 05:09:18 volumio volumio[1011]: at ClientRequest.emit (events.js:211:7) Sep 14 05:09:18 volumio volumio[1011]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:551:21) Sep 14 05:09:18 volumio volumio[1011]: at HTTPParser.parserOnHeadersComplete (_http_common.js:115:23) Sep 14 05:09:18 volumio volumio[1011]: at Socket.socketOnData (_http_client.js:440:20) Sep 14 05:09:18 volumio volumio[1011]: at emitOne (events.js:116:13) Sep 14 05:09:18 volumio volumio[1011]: at Socket.emit (events.js:211:7) Sep 14 05:09:18 volumio volumio[1011]: at addChunk (_stream_readable.js:263:12) Sep 14 05:09:18 volumio volumio[1011]: at readableAddChunk (_stream_readable.js:250:11) Sep 14 05:09:18 volumio volumio[1011]: at Socket.Readable.push (_stream_readable.js:208:10) Sep 14 05:09:18 volumio volumio[1011]: at TCP.onread (net.js:607:20) Sep 14 05:09:18 volumio volumio[1011]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 14 05:09:20 volumio sudo[1588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-14 05:08 Sep 14 05:09:20 volumio sudo[1588]: 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"