-- Logs begin at Wed 2019-12-11 06:36:56 UTC, end at Fri 2025-10-31 07:40:24 UTC. -- Oct 31 07:39:10 volumio systemd[1]: Time has been changed Oct 31 07:39:10 volumio volumio[778]: info: Loading i18n strings for locale ru Oct 31 07:39:10 volumio volumio[778]: Updating browse sources language Oct 31 07:39:10 volumio volumio[778]: Cannot find translation for sourceMedia Servers Oct 31 07:39:10 volumio volumio[778]: Cannot find translation for source80s80s Radio Oct 31 07:39:10 volumio volumio[778]: Cannot find translation for sourceRadio Paradise Oct 31 07:39:10 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 31 07:39:10 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 31 07:39:10 volumio volumio[778]: info: CoreCommandRouter::initPlayerControls Oct 31 07:39:10 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 07:39:10 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 31 07:39:10 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 07:39:10 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 07:39:10 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 07:39:10 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 07:39:10 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 07:39:10 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 31 07:39:10 volumio volumio[778]: info: BOOT COMPLETED Oct 31 07:39:10 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 31 07:39:15 volumio volumio[778]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Oct 31 07:39:15 volumio volumio[778]: info: CoreCommandRouter::Close All Modals sent Oct 31 07:39:15 volumio volumio[778]: info: CoreCommandRouter::Close All Modals sent Oct 31 07:39:15 volumio volumio[778]: Express server listening on port 3000 Oct 31 07:39:15 volumio volumio[778]: Volumio Calling Home Oct 31 07:39:15 volumio volumio[778]: info: CoreStateMachine::resetVolumioState Oct 31 07:39:15 volumio volumio[778]: info: CoreStateMachine::getcurrentVolume Oct 31 07:39:15 volumio volumio[778]: info: CoreCommandRouter::volumioRetrievevolume Oct 31 07:39:16 volumio sudo[895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 31 07:39:16 volumio sudo[895]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 07:39:16 volumio sudo[895]: pam_unix(sudo:session): session closed for user root Oct 31 07:39:16 volumio volumio[778]: info: Setting Device type: Raspberry PI Oct 31 07:39:16 volumio volumio[778]: info: MPD running with PID567 ,establishing connection Oct 31 07:39:16 volumio sudo[910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Oct 31 07:39:16 volumio sudo[910]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 07:39:16 volumio sudo[910]: pam_unix(sudo:session): session closed for user root Oct 31 07:39:16 volumio volumio-remote-updater[528]: [2025-10-31 07:39:16] [connect] Successful connection Oct 31 07:39:17 volumio volumio[778]: info: VolumeController:: Volume=60 Mute =false Oct 31 07:39:17 volumio volumio[778]: info: CoreStateMachine::pushState Oct 31 07:39:17 volumio volumio[778]: info: CoreStateMachine::getState Oct 31 07:39:17 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 07:39:17 volumio volumio[778]: info: CoreStateMachine::updateTrackBlock Oct 31 07:39:17 volumio volumio[778]: info: CorePlayQueue::getTrackBlock Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::volumioRetrievevolume Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 31 07:39:17 volumio volumio[778]: info: Reloading queue from file Oct 31 07:39:17 volumio volumio[778]: info: Oct 31 07:39:17 volumio volumio[778]: info: message= [50@0] {} No such directory, stack=Error: [50@0] {} No such directory Oct 31 07:39:17 volumio volumio[778]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:63:14) Oct 31 07:39:17 volumio volumio[778]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:10) Oct 31 07:39:17 volumio volumio[778]: at emitOne (events.js:116:13) Oct 31 07:39:17 volumio volumio[778]: at Socket.emit (events.js:211:7) Oct 31 07:39:17 volumio volumio[778]: at addChunk (_stream_readable.js:263:12) Oct 31 07:39:17 volumio volumio[778]: at readableAddChunk (_stream_readable.js:246:13) Oct 31 07:39:17 volumio volumio[778]: at Socket.Readable.push (_stream_readable.js:208:10) Oct 31 07:39:17 volumio volumio[778]: at Pipe.onread (net.js:607:20) Oct 31 07:39:17 volumio volumio-remote-updater[528]: [2025-10-31 07:39:17] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1761896356 101 Oct 31 07:39:17 volumio volumio[778]: info: CoreStateMachine::setRepeat true single undefined Oct 31 07:39:17 volumio volumio[778]: info: CoreStateMachine::pushState Oct 31 07:39:17 volumio volumio[778]: info: CoreStateMachine::getState Oct 31 07:39:17 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 07:39:17 volumio volumio[778]: info: CoreStateMachine::setRandom true Oct 31 07:39:17 volumio volumio[778]: info: CoreStateMachine::pushState Oct 31 07:39:17 volumio volumio[778]: info: CoreStateMachine::getState Oct 31 07:39:17 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::volumioGetVisibleSources Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::volumioGetState Oct 31 07:39:17 volumio volumio[778]: info: CoreStateMachine::getState Oct 31 07:39:17 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::volumioGetQueue Oct 31 07:39:17 volumio volumio[778]: info: CoreStateMachine::getQueue Oct 31 07:39:17 volumio volumio[778]: info: CorePlayQueue::getQueue Oct 31 07:39:17 volumio volumio[778]: info: Listing playlists Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 31 07:39:17 volumio volumio[778]: info: VolumeController:: Volume=60 Mute =false Oct 31 07:39:17 volumio volumio[778]: info: CoreStateMachine::pushState Oct 31 07:39:17 volumio volumio[778]: info: CoreStateMachine::getState Oct 31 07:39:17 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Oct 31 07:39:17 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 07:39:17 volumio volumio[778]: info: mDNS: A device disapperared from network Oct 31 07:39:17 volumio volumio[778]: info: mDNS Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Oct 31 07:39:18 volumio sudo[924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 31 07:39:18 volumio sudo[924]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 07:39:18 volumio sudo[926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Oct 31 07:39:18 volumio sudo[926]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 07:39:18 volumio sudo[930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Oct 31 07:39:18 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Oct 31 07:39:18 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Oct 31 07:39:18 volumio sudo[930]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 07:39:18 volumio sudo[924]: pam_unix(sudo:session): session closed for user root Oct 31 07:39:18 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Oct 31 07:39:18 volumio systemd[1]: Started ShairportSync AirTunes receiver. Oct 31 07:39:18 volumio sudo[926]: pam_unix(sudo:session): session closed for user root Oct 31 07:39:18 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Oct 31 07:39:18 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Oct 31 07:39:18 volumio systemd[1]: Started ShairportSync AirTunes receiver. Oct 31 07:39:18 volumio sudo[930]: pam_unix(sudo:session): session closed for user root Oct 31 07:39:18 volumio shairport-sync[951]: Successful Startup Oct 31 07:39:18 volumio volumio[778]: Discovery: adding 624369ad-a737-463b-a088-239ea874bb43 Oct 31 07:39:18 volumio volumio[778]: info: mDNS: Found device Volumio Oct 31 07:39:18 volumio sudo[958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 31 07:39:18 volumio sudo[958]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 07:39:18 volumio volumio[778]: info: Shairport-Sync Started Oct 31 07:39:18 volumio volumio[778]: Error adding Membership: Error: addMembership EINVAL Oct 31 07:39:18 volumio volumio[778]: info: Shairport-Sync Started Oct 31 07:39:18 volumio volumio[778]: info: Upmpdcli Daemon Started Oct 31 07:39:18 volumio sudo[958]: pam_unix(sudo:session): session closed for user root Oct 31 07:39:18 volumio volumio[778]: info: CoreCommandRouter::volumioGetState Oct 31 07:39:18 volumio volumio[778]: info: CoreStateMachine::getState Oct 31 07:39:18 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Oct 31 07:39:18 volumio volumio[778]: Discovery: this is already registered, 624369ad-a737-463b-a088-239ea874bb43 Oct 31 07:39:18 volumio volumio[778]: info: mDNS: Found device Volumio Oct 31 07:39:18 volumio sudo[969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 31 07:39:18 volumio sudo[969]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 07:39:18 volumio sudo[972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 31 07:39:18 volumio sudo[969]: pam_unix(sudo:session): session closed for user root Oct 31 07:39:18 volumio sudo[972]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 07:39:18 volumio sudo[972]: pam_unix(sudo:session): session closed for user root Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 31 07:39:19 volumio volumio[778]: info: Adding plugin bluetooth to MyMusic Plugins Oct 31 07:39:19 volumio volumio[778]: info: Adding plugin cd_controller to MyMusic Plugins Oct 31 07:39:19 volumio volumio[778]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 31 07:39:19 volumio volumio[778]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 31 07:39:24 volumio volumio[778]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 31 07:39:27 volumio volumio[778]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 31 07:39:27 volumio volumio[778]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 31 07:39:27 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 31 07:39:27 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 31 07:39:27 volumio volumio[778]: info: Starting MyVolumio Remote Streaming Endpoints Oct 31 07:39:27 volumio volumio[778]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 31 07:39:27 volumio volumio[778]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 31 07:39:27 volumio volumio[778]: info: Streaming services startup Oct 31 07:39:27 volumio volumio[778]: info: Starting Streaming Daemon Oct 31 07:39:27 volumio volumio[778]: info: MyVolumio not started Oct 31 07:39:27 volumio volumio[778]: info: Initializing device activation check Oct 31 07:39:27 volumio sudo[1004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 31 07:39:27 volumio sudo[1004]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 07:39:27 volumio volumio[778]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 31 07:39:27 volumio systemd[1]: Stopping Volumio Streaming Daemon... Oct 31 07:39:27 volumio systemd[1]: Starting Volumio Streaming Daemon... Oct 31 07:39:27 volumio systemd[1]: Started Volumio Streaming Daemon. Oct 31 07:39:27 volumio sudo[1004]: pam_unix(sudo:session): session closed for user root Oct 31 07:39:27 volumio volumio-streaming-daemon[1010]: ############################ Oct 31 07:39:27 volumio volumio-streaming-daemon[1010]: # Volumio Streaming Daemon # Oct 31 07:39:27 volumio volumio-streaming-daemon[1010]: # Running on port 7777 # Oct 31 07:39:27 volumio volumio-streaming-daemon[1010]: ############################ Oct 31 07:39:27 volumio volumio[778]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.673&uuid=e8d4aae5a88555735b52400504c34172" http://updates.volumio.org:7070/downloader-v1/track-device Oct 31 07:39:27 volumio volumio[778]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 31 07:39:27 volumio volumio[778]: Dload Upload Total Spent Left Speed Oct 31 07:39:27 volumio volumio[778]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Oct 31 07:39:27 volumio volumio[778]: retrying in 5 seconds, trial 0 Oct 31 07:39:27 volumio volumio[778]: Volumio Calling Home Oct 31 07:39:30 volumio volumio[778]: info: Fetching Streaming Services browse cache Oct 31 07:39:30 volumio volumio[778]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Oct 31 07:39:30 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 31 07:39:30 volumio volumio[778]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Oct 31 07:39:30 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 31 07:39:37 volumio volumio[778]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.673&uuid=e8d4aae5a88555735b52400504c34172" http://updates.volumio.org:7070/downloader-v1/track-device Oct 31 07:39:37 volumio volumio[778]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 31 07:39:37 volumio volumio[778]: Dload Upload Total Spent Left Speed Oct 31 07:39:37 volumio volumio[778]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Oct 31 07:39:37 volumio volumio[778]: retrying in 5 seconds, trial 1 Oct 31 07:39:37 volumio volumio[778]: Volumio Calling Home Oct 31 07:39:40 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 31 07:39:40 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 31 07:39:43 volumio avahi-daemon[559]: Invalid response packet from host 192.168.1.230. Oct 31 07:39:48 volumio volumio[778]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.673&uuid=e8d4aae5a88555735b52400504c34172" http://updates.volumio.org:7070/downloader-v1/track-device Oct 31 07:39:48 volumio volumio[778]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 31 07:39:48 volumio volumio[778]: Dload Upload Total Spent Left Speed Oct 31 07:39:48 volumio volumio[778]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Oct 31 07:39:48 volumio volumio[778]: retrying in 5 seconds, trial 2 Oct 31 07:39:48 volumio volumio[778]: Volumio Calling Home Oct 31 07:40:16 volumio sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 31 07:40:16 volumio sudo[1132]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 07:40:16 volumio sudo[1134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 31 07:40:16 volumio sudo[1132]: pam_unix(sudo:session): session closed for user root Oct 31 07:40:16 volumio sudo[1134]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 07:40:16 volumio sudo[1134]: pam_unix(sudo:session): session closed for user root Oct 31 07:40:16 volumio volumio[778]: info: CoreCommandRouter::volumioGetState Oct 31 07:40:16 volumio volumio[778]: info: CoreStateMachine::getState Oct 31 07:40:16 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Oct 31 07:40:16 volumio sudo[1152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 31 07:40:16 volumio sudo[1152]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 07:40:16 volumio sudo[1152]: pam_unix(sudo:session): session closed for user root Oct 31 07:40:16 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 31 07:40:16 volumio volumio[778]: info: CoreCommandRouter::volumioGetVisibleSources Oct 31 07:40:16 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 31 07:40:16 volumio sudo[1163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 31 07:40:16 volumio volumio[778]: info: Listing playlists Oct 31 07:40:16 volumio sudo[1163]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 07:40:16 volumio sudo[1163]: pam_unix(sudo:session): session closed for user root Oct 31 07:40:17 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 31 07:40:17 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 31 07:40:17 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 31 07:40:17 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 31 07:40:18 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Oct 31 07:40:18 volumio volumio[778]: info: [1761896418658] [80s80s] handleBrowseUri curUri: 80s80s Oct 31 07:40:18 volumio volumio[778]: info: CoreCommandRouter::volumioGetQueue Oct 31 07:40:18 volumio volumio[778]: info: CoreStateMachine::getQueue Oct 31 07:40:18 volumio volumio[778]: info: CorePlayQueue::getQueue Oct 31 07:40:19 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 31 07:40:19 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Oct 31 07:40:19 volumio volumio[778]: info: [1761896419667] [80s80s] handleBrowseUri curUri: 80s80s/eighties Oct 31 07:40:19 volumio volumio[778]: info: [1761896419669] [80s80s] getRadioContent url: eighties Oct 31 07:40:21 volumio volumio[778]: info: CoreCommandRouter::volumioAddQueueItems Oct 31 07:40:21 volumio volumio[778]: info: CoreStateMachine::addQueueItems Oct 31 07:40:21 volumio volumio[778]: info: CorePlayQueue::addQueueItems Oct 31 07:40:21 volumio volumio[778]: info: Adding Item to queue: webeighties/5 Oct 31 07:40:21 volumio volumio[778]: info: Exploding uri webeighties/5 in service 80s80s Oct 31 07:40:21 volumio volumio[778]: info: [1761896421130] [80s80s] explodeUri: webeighties/5 Oct 31 07:40:21 volumio volumio[778]: info: CorePlayQueue::saveQueue Oct 31 07:40:21 volumio volumio[778]: info: CoreCommandRouter::volumioPushQueue Oct 31 07:40:21 volumio volumio[778]: info: CoreStateMachine::updateTrackBlock Oct 31 07:40:21 volumio volumio[778]: info: CorePlayQueue::getTrackBlock Oct 31 07:40:21 volumio volumio[778]: info: CoreCommandRouter::volumioPlay Oct 31 07:40:21 volumio volumio[778]: UNSET VOLATILE Oct 31 07:40:21 volumio volumio[778]: info: CoreStateMachine::play index 26 Oct 31 07:40:21 volumio volumio[778]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 31 07:40:21 volumio volumio[778]: info: CoreStateMachine::stop Oct 31 07:40:21 volumio volumio[778]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 31 07:40:21 volumio volumio[778]: UNSET VOLATILE Oct 31 07:40:21 volumio volumio[778]: info: CoreStateMachine::play index undefined Oct 31 07:40:21 volumio volumio[778]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 31 07:40:21 volumio volumio[778]: info: CorePlayQueue::getTrack 26 Oct 31 07:40:21 volumio volumio[778]: info: CoreStateMachine::startPlaybackTimer Oct 31 07:40:21 volumio volumio[778]: info: CorePlayQueue::getTrack 26 Oct 31 07:40:21 volumio volumio[778]: info: [1761896421188] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio Oct 31 07:40:21 volumio volumio[778]: info: [1761896421190] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 Oct 31 07:40:21 volumio volumio[778]: info: [1761896421635] [80s80s] received new event containing 2 songs. Oct 31 07:40:21 volumio volumio[778]: info: ControllerMpd::sendMpdCommand stop Oct 31 07:40:21 volumio volumio[778]: info: sending command... Oct 31 07:40:21 volumio volumio[778]: info: parsing response... Oct 31 07:40:21 volumio volumio[778]: info: ControllerMpd::sendMpdCommand clear Oct 31 07:40:21 volumio volumio[778]: info: sending command... Oct 31 07:40:21 volumio volumio[778]: info: Oct 31 07:40:21 volumio volumio[778]: ---------------------------- MPD announces system playlist update Oct 31 07:40:21 volumio volumio[778]: info: Ignoring MPD Status Update Oct 31 07:40:21 volumio volumio[778]: info: parsing response... Oct 31 07:40:21 volumio volumio[778]: info: [1761896421667] [80s80s] adding url: http://streams.80s80s.de/italohits/mp3-192/volumio Oct 31 07:40:21 volumio volumio[778]: info: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/italohits/mp3-192/volumio" Oct 31 07:40:21 volumio volumio[778]: info: sending command... Oct 31 07:40:21 volumio volumio[778]: info: Oct 31 07:40:21 volumio volumio[778]: info: Oct 31 07:40:21 volumio volumio[778]: ---------------------------- MPD announces system playlist update Oct 31 07:40:21 volumio volumio[778]: info: Ignoring MPD Status Update Oct 31 07:40:21 volumio volumio[778]: info: ------------------------------ 19ms Oct 31 07:40:21 volumio volumio[778]: info: parsing response... Oct 31 07:40:21 volumio volumio[778]: info: ControllerMpd::sendMpdCommand play Oct 31 07:40:21 volumio volumio[778]: info: sending command... Oct 31 07:40:21 volumio volumio[778]: info: ------------------------------ 18ms Oct 31 07:40:21 volumio volumio[778]: info: parsing response... Oct 31 07:40:21 volumio volumio[778]: info: [1761896421697] [80s80s] Pushing the next song state: Den Harrow - Don't Break My Heart Oct 31 07:40:21 volumio volumio[778]: info: CoreStateMachine::getState Oct 31 07:40:21 volumio volumio[778]: info: CorePlayQueue::getTrack 26 Oct 31 07:40:21 volumio volumio[778]: info: CoreCommandRouter::servicePushState Oct 31 07:40:21 volumio volumio[778]: info: CoreStateMachine::syncState Oct 31 07:40:21 volumio volumio[778]: info: CorePlayQueue::getTrack 26 Oct 31 07:40:21 volumio volumio[778]: info: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music125/v4/37/c8/5b/37c85b5a-1a07-50b1-b326-9446d84dd0a5/source/600x600bb.jpg","name":"Den Harrow - Don't Break My Heart","title":"Don't Break My Heart","artist":"80s80s Italo Disco","album":"","streaming":true,"disableUiControls":true,"duration":"219","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Oct 31 07:40:21 volumio volumio[778]: info: CURRENT POSITION 26 Oct 31 07:40:21 volumio volumio[778]: info: CoreStateMachine::syncState stateService play Oct 31 07:40:21 volumio volumio[778]: info: CoreStateMachine::syncState currentStatus stop Oct 31 07:40:21 volumio volumio[778]: info: CoreStateMachine::pushState Oct 31 07:40:21 volumio volumio[778]: info: CoreStateMachine::getState Oct 31 07:40:21 volumio volumio[778]: info: CorePlayQueue::getTrack 26 Oct 31 07:40:21 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Oct 31 07:40:21 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 07:40:21 volumio volumio[778]: info: [1761896421767] [80s80s] getContentOfUrl started with url http://ntp-a4.nict.go.jp/cgi-bin/json Oct 31 07:40:21 volumio sudo[1185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 31 07:40:21 volumio sudo[1185]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 07:40:21 volumio sudo[1185]: pam_unix(sudo:session): session closed for user root Oct 31 07:40:21 volumio volumio[778]: info: CorePlayQueue::getTrack 26 Oct 31 07:40:21 volumio volumio[778]: info: CorePlayQueue::getTrack 1 Oct 31 07:40:22 volumio volumio[778]: info: VolumeController::SetAlsaVolume30 Oct 31 07:40:22 volumio volumio[778]: info: CoreStateMachine::pushState Oct 31 07:40:22 volumio volumio[778]: info: CoreStateMachine::getState Oct 31 07:40:22 volumio volumio[778]: info: CorePlayQueue::getTrack 26 Oct 31 07:40:22 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Oct 31 07:40:22 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 07:40:22 volumio volumio[778]: info: Oct 31 07:40:22 volumio volumio[778]: ---------------------------- MPD announces state update: mixer Oct 31 07:40:22 volumio volumio[778]: info: ControllerMpd::getState Oct 31 07:40:22 volumio volumio[778]: info: ControllerMpd::sendMpdCommand status Oct 31 07:40:22 volumio sudo[1197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 31 07:40:22 volumio volumio[778]: info: sending command... Oct 31 07:40:22 volumio volumio[778]: info: parsing response... Oct 31 07:40:22 volumio volumio[778]: info: ControllerMpd::parseState Oct 31 07:40:22 volumio volumio[778]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 31 07:40:22 volumio sudo[1197]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 07:40:22 volumio volumio[778]: info: sending command... Oct 31 07:40:22 volumio volumio[778]: info: parsing response... Oct 31 07:40:22 volumio volumio[778]: info: ControllerMpd::parseTrackInfo Oct 31 07:40:22 volumio volumio[778]: info: ControllerMpd::pushState Oct 31 07:40:22 volumio volumio[778]: info: CoreCommandRouter::servicePushState Oct 31 07:40:22 volumio volumio[778]: info: CoreStateMachine::syncState Oct 31 07:40:22 volumio volumio[778]: info: ERROR Prefetch 500ms setTimeout missed >> directly calling increasePlaybackTimer Oct 31 07:40:22 volumio volumio[778]: info: ERROR this.runPlaybackTimer:true this.currentSongDuration:219 - this.currentSeek:237 - this.prefetchDone:false - this.simulateStopStartDone:false Oct 31 07:40:22 volumio volumio[778]: info: CorePlayQueue::getTrack 26 Oct 31 07:40:22 volumio volumio[778]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Oct 31 07:40:22 volumio volumio[778]: info: ------------------------------ 50ms Oct 31 07:40:22 volumio volumio[778]: info: [1761896422187] [80s80s] Failed to query api, status code: 404 Oct 31 07:40:22 volumio volumio[778]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 07:40:22 volumio sudo[1197]: pam_unix(sudo:session): session closed for user root Oct 31 07:40:22 volumio volumio[778]: ReferenceError: station is not defined Oct 31 07:40:22 volumio volumio[778]: at ClientRequest.http.get (/data/plugins/music_service/80s80s/index.js:478:26) Oct 31 07:40:22 volumio volumio[778]: at Object.onceWrapper (events.js:315:30) Oct 31 07:40:22 volumio volumio[778]: at emitOne (events.js:116:13) Oct 31 07:40:22 volumio volumio[778]: at ClientRequest.emit (events.js:211:7) Oct 31 07:40:22 volumio volumio[778]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:551:21) Oct 31 07:40:22 volumio volumio[778]: at HTTPParser.parserOnHeadersComplete (_http_common.js:115:23) Oct 31 07:40:22 volumio volumio[778]: at Socket.socketOnData (_http_client.js:440:20) Oct 31 07:40:22 volumio volumio[778]: at emitOne (events.js:116:13) Oct 31 07:40:22 volumio volumio[778]: at Socket.emit (events.js:211:7) Oct 31 07:40:22 volumio volumio[778]: at addChunk (_stream_readable.js:263:12) Oct 31 07:40:22 volumio volumio[778]: at readableAddChunk (_stream_readable.js:250:11) Oct 31 07:40:22 volumio volumio[778]: at Socket.Readable.push (_stream_readable.js:208:10) Oct 31 07:40:22 volumio volumio[778]: at TCP.onread (net.js:607:20) Oct 31 07:40:22 volumio volumio[778]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 07:40:23 volumio sudo[1216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-31 07:39 Oct 31 07:40:24 volumio sudo[1216]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="76976c3150e60fa37f55c84c5ca4b7a47b667b83" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="2b418696ba9df7da37e66ecee4256e963897e4a2" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun Dec 1 01:32:00 CET 2019" VOLUMIO_VERSION="2.673" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="195d359258dcdb7969a22e2c84f33e21"