-- Logs begin at Fri 2021-07-02 10:45:33 UTC, end at Thu 2025-09-11 08:45:42 UTC. --
Sep 11 08:44:00 volumio volumio[9531]: Starting albumart workers
Sep 11 08:44:03 volumio volumio-remote-updater[613]: [2025-09-11 08:44:03] [connect] Successful connection
Sep 11 08:44:04 volumio volumio[9531]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Sep 11 08:44:04 volumio volumio[9531]: info: CoreCommandRouter::Close All Modals sent
Sep 11 08:44:04 volumio volumio[9531]: info: CoreCommandRouter::Close All Modals sent
Sep 11 08:44:04 volumio volumio[9531]: Express server listening on port 3000
Sep 11 08:44:04 volumio volumio[9531]: [Metrics] WebUI: 15s 2.72ms
Sep 11 08:44:04 volumio volumio[9531]: Volumio Calling Home
Sep 11 08:44:04 volumio volumio[9531]: info: CoreStateMachine::resetVolumioState
Sep 11 08:44:04 volumio volumio[9531]: info: CoreStateMachine::getcurrentVolume
Sep 11 08:44:04 volumio volumio[9531]: info: CoreCommandRouter::volumioRetrievevolume
Sep 11 08:44:04 volumio volumio[9531]: info: Cannot mount NAS N5101 at system boot, trial number 2 ,retrying in 5 seconds
Sep 11 08:44:04 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 08:44:04 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 08:44:04 volumio volumio[9531]: info: Setting Device type: Raspberry PI
Sep 11 08:44:04 volumio volumio[9531]: info: MPD running with PID3920
Sep 11 08:44:04 volumio volumio[9531]: ,establishing connection
Sep 11 08:44:04 volumio sudo[9656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1
Sep 11 08:44:04 volumio sudo[9656]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 08:44:04 volumio sudo[9656]: pam_unix(sudo:session): session closed for user root
Sep 11 08:44:04 volumio volumio-remote-updater[613]: [2025-09-11 08:44:04] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1757580243 101
Sep 11 08:44:04 volumio volumio[9531]: info: VolumeController:: Volume=85 Mute =false
Sep 11 08:44:04 volumio volumio[9531]: info: CoreStateMachine::pushState
Sep 11 08:44:04 volumio volumio[9531]: info: CorePlayQueue::getTrack 0
Sep 11 08:44:04 volumio volumio[9531]: info: CoreCommandRouter::volumioPushState
Sep 11 08:44:04 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 11 08:44:04 volumio volumio[9531]: info: CoreStateMachine::updateTrackBlock
Sep 11 08:44:04 volumio volumio[9531]: info: CorePlayQueue::getTrackBlock
Sep 11 08:44:04 volumio volumio[9531]: info: CoreCommandRouter::volumioRetrievevolume
Sep 11 08:44:05 volumio volumio[9531]: info:
Sep 11 08:44:05 volumio volumio[9531]: ---------------------------- Client requests Volume 85
Sep 11 08:44:05 volumio volumio[9531]: info: VolumeController::SetAlsaVolume85
Sep 11 08:44:05 volumio volumio[9531]: info: CoreStateMachine::pushState
Sep 11 08:44:05 volumio volumio[9531]: info: CorePlayQueue::getTrack 0
Sep 11 08:44:05 volumio volumio[9531]: info: CoreCommandRouter::volumioPushState
Sep 11 08:44:05 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 11 08:44:05 volumio volumio[9531]: info: Volumio called home
Sep 11 08:44:05 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 08:44:05 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Sep 11 08:44:05 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Sep 11 08:44:05 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Sep 11 08:44:05 volumio volumio[9531]: info: Reloading queue from file
Sep 11 08:44:06 volumio volumio[9531]: error: Failed LSINFO: Error: [50@0] {} No such directory
Sep 11 08:44:06 volumio volumio[9531]: info: CoreCommandRouter::volumioGetState
Sep 11 08:44:06 volumio volumio[9531]: info: CorePlayQueue::getTrack 0
Sep 11 08:44:06 volumio volumio[9531]: info: Setting volume on startup at 85
Sep 11 08:44:06 volumio volumio[9531]: info: CoreStateMachine::setRepeat true single undefined
Sep 11 08:44:06 volumio volumio[9531]: info: CoreStateMachine::pushState
Sep 11 08:44:06 volumio volumio[9531]: info: CorePlayQueue::getTrack 0
Sep 11 08:44:06 volumio volumio[9531]: info: CoreCommandRouter::volumioPushState
Sep 11 08:44:06 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 11 08:44:06 volumio volumio[9531]: info: CoreStateMachine::setRandom true
Sep 11 08:44:06 volumio volumio[9531]: info: CoreStateMachine::pushState
Sep 11 08:44:06 volumio volumio[9531]: info: CorePlayQueue::getTrack 0
Sep 11 08:44:06 volumio volumio[9531]: info: CoreCommandRouter::volumioPushState
Sep 11 08:44:06 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 11 08:44:06 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 11 08:44:06 volumio volumio[9531]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 11 08:44:06 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 11 08:44:06 volumio volumio[9531]: info: Listing playlists
Sep 11 08:44:06 volumio volumio[9531]: info: CoreCommandRouter::volumioGetQueue
Sep 11 08:44:06 volumio volumio[9531]: info: CoreStateMachine::getQueue
Sep 11 08:44:06 volumio volumio[9531]: info: CorePlayQueue::getQueue
Sep 11 08:44:07 volumio volumio[9531]: info: VolumeController:: Volume=85 Mute =false
Sep 11 08:44:07 volumio volumio[9531]: info: CoreStateMachine::pushState
Sep 11 08:44:07 volumio volumio[9531]: info: CorePlayQueue::getTrack 0
Sep 11 08:44:07 volumio volumio[9531]: info: CoreCommandRouter::volumioPushState
Sep 11 08:44:07 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 11 08:44:07 volumio volumio[9531]: info: Starting Shairport Sync
Sep 11 08:44:07 volumio volumio[9531]: info: Starting Shairport Sync
Sep 11 08:44:07 volumio sudo[9672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 11 08:44:07 volumio sudo[9672]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 08:44:07 volumio sudo[9675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 11 08:44:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 11 08:44:07 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Sep 11 08:44:07 volumio sudo[9675]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 08:44:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 11 08:44:07 volumio sudo[9672]: pam_unix(sudo:session): session closed for user root
Sep 11 08:44:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 11 08:44:07 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Sep 11 08:44:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 11 08:44:07 volumio sudo[9675]: pam_unix(sudo:session): session closed for user root
Sep 11 08:44:07 volumio volumio[9531]: info: Shairport-Sync Started
Sep 11 08:44:07 volumio volumio[9531]: Error adding Membership: Error: addMembership EINVAL
Sep 11 08:44:07 volumio volumio[9531]: info: Shairport-Sync Started
Sep 11 08:44:07 volumio volumio[9531]: info: CoreCommandRouter::volumioGetState
Sep 11 08:44:07 volumio volumio[9531]: info: CorePlayQueue::getTrack 0
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Sep 11 08:44:08 volumio volumio[9531]: info: Adding plugin bluetooth to MyMusic Plugins
Sep 11 08:44:08 volumio volumio[9531]: info: Adding plugin cd_controller to MyMusic Plugins
Sep 11 08:44:08 volumio volumio[9531]: info: Adding plugin smart_inputs to MyMusic Plugins
Sep 11 08:44:08 volumio volumio[9531]: info: Adding plugin tidalconnect to MyMusic Plugins
Sep 11 08:44:08 volumio volumio[9531]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Sep 11 08:44:09 volumio volumio[9531]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Sep 11 08:44:09 volumio volumio[9531]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Sep 11 08:44:09 volumio volumio[9531]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Sep 11 08:44:09 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 08:44:09 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 08:44:09 volumio volumio[9531]: info: Starting MyVolumio Remote Streaming Endpoints
Sep 11 08:44:10 volumio volumio[9531]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Sep 11 08:44:10 volumio volumio[9531]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Sep 11 08:44:10 volumio volumio[9531]: info: Streaming services startup
Sep 11 08:44:10 volumio volumio[9531]: info: Starting Streaming Daemon
Sep 11 08:44:10 volumio sudo[9710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Sep 11 08:44:10 volumio sudo[9710]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 08:44:10 volumio systemd[1]: Stopping Volumio Streaming Daemon...
Sep 11 08:44:10 volumio volumio[9531]: info: MyVolumio not started
Sep 11 08:44:10 volumio volumio[9531]: info: Initializing device activation check
Sep 11 08:44:10 volumio systemd[1]: Starting Volumio Streaming Daemon...
Sep 11 08:44:10 volumio systemd[1]: Started Volumio Streaming Daemon.
Sep 11 08:44:10 volumio sudo[9710]: pam_unix(sudo:session): session closed for user root
Sep 11 08:44:10 volumio volumio[9531]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Sep 11 08:44:10 volumio volumio-streaming-daemon[9720]: ############################
Sep 11 08:44:10 volumio volumio-streaming-daemon[9720]: # Volumio Streaming Daemon #
Sep 11 08:44:10 volumio volumio-streaming-daemon[9720]: # Running on port 7777 #
Sep 11 08:44:10 volumio volumio-streaming-daemon[9720]: ############################
Sep 11 08:44:10 volumio volumio-streaming-daemon[9720]: Environment: production
Sep 11 08:44:10 volumio volumio[9531]: info: Cannot mount NAS N5101 at system boot, trial number 3 ,retrying in 5 seconds
Sep 11 08:44:10 volumio volumio[9531]: Discovery: adding 5bd3485b-fff6-4060-95ac-a6276faf7797
Sep 11 08:44:10 volumio volumio[9531]: info: mDNS: Found device Volumio
Sep 11 08:44:10 volumio volumio[9531]: info: CoreCommandRouter::volumioGetState
Sep 11 08:44:10 volumio volumio[9531]: info: CorePlayQueue::getTrack 0
Sep 11 08:44:12 volumio volumio[9531]: Discovery: this is already registered, 5bd3485b-fff6-4060-95ac-a6276faf7797
Sep 11 08:44:12 volumio volumio[9531]: info: mDNS: Found device Volumio
Sep 11 08:44:12 volumio volumio[9531]: info: CoreCommandRouter::volumioGetState
Sep 11 08:44:12 volumio volumio[9531]: info: CorePlayQueue::getTrack 0
Sep 11 08:44:12 volumio volumio-streaming-daemon[9720]: Environment: production
Sep 11 08:44:12 volumio volumio[9531]: info: Fetching Streaming Services browse cache
Sep 11 08:44:15 volumio volumio[9531]: info: Cannot mount NAS N5101 at system boot, trial number 4 ,retrying in 5 seconds
Sep 11 08:44:19 volumio volumio[9531]: info: CoreCommandRouter::volumioGetState
Sep 11 08:44:19 volumio volumio[9531]: info: CorePlayQueue::getTrack 0
Sep 11 08:44:19 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 11 08:44:19 volumio volumio[9531]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 11 08:44:19 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 11 08:44:19 volumio volumio[9531]: info: Listing playlists
Sep 11 08:44:19 volumio volumio[9531]: info: CoreCommandRouter::volumioGetQueue
Sep 11 08:44:19 volumio volumio[9531]: info: CoreStateMachine::getQueue
Sep 11 08:44:19 volumio volumio[9531]: info: CorePlayQueue::getQueue
Sep 11 08:44:20 volumio volumio[9531]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Sep 11 08:44:28 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 11 08:44:28 volumio volumio[9531]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 08:44:46 volumio volumio[9531]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 11 08:44:46 volumio volumio[9531]: { Error: connect ETIMEDOUT 162.125.80.3:443
Sep 11 08:44:46 volumio volumio[9531]: at Object._errnoException (util.js:1022:11)
Sep 11 08:44:46 volumio volumio[9531]: at _exceptionWithHostPort (util.js:1044:20)
Sep 11 08:44:46 volumio volumio[9531]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Sep 11 08:44:46 volumio volumio[9531]: code: 'ETIMEDOUT',
Sep 11 08:44:46 volumio volumio[9531]: errno: 'ETIMEDOUT',
Sep 11 08:44:46 volumio volumio[9531]: syscall: 'connect',
Sep 11 08:44:46 volumio volumio[9531]: address: '162.125.80.3',
Sep 11 08:44:46 volumio volumio[9531]: port: 443 }
Sep 11 08:44:46 volumio volumio[9531]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 11 08:44:47 volumio sudo[9762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-11 08:43
Sep 11 08:44:47 volumio sudo[9762]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 08:44:47 volumio sudo[9762]: pam_unix(sudo:session): session closed for user root
Sep 11 08:44:47 volumio volumio-remote-updater[613]: [2025-09-11 08:44:47] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Sep 11 08:44:47 volumio volumio-remote-updater[613]: [2025-09-11 08:44:47] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Sep 11 08:44:47 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Sep 11 08:44:47 volumio systemd[1]: Unit volumio.service entered failed state.
Sep 11 08:44:47 volumio systemd[1]: Starting dynamicswap service...
Sep 11 08:44:47 volumio systemd[1]: Started dynamicswap service.
Sep 11 08:44:48 volumio systemd[1]: volumio.service holdoff time over, scheduling restart.
Sep 11 08:44:48 volumio systemd[1]: Starting dynamicswap service...
Sep 11 08:44:48 volumio systemd[1]: Started dynamicswap service.
Sep 11 08:44:48 volumio systemd[1]: Stopping Volumio Backend Module...
Sep 11 08:44:48 volumio systemd[1]: Starting Volumio Backend Module...
Sep 11 08:44:48 volumio systemd[1]: Started Volumio Backend Module.
Sep 11 08:44:51 volumio volumio[9783]: info: -------------------------------------------
Sep 11 08:44:51 volumio volumio[9783]: info: ----- Volumio2 ----
Sep 11 08:44:51 volumio volumio[9783]: info: -------------------------------------------
Sep 11 08:44:51 volumio volumio[9783]: info: ----- System startup ----
Sep 11 08:44:51 volumio volumio[9783]: info: -------------------------------------------
Sep 11 08:44:52 volumio volumio-remote-updater[613]: [2025-09-11 08:44:52] [connect] Successful connection
Sep 11 08:44:52 volumio volumio[9783]: info: MYVOLUMIO Environment detected
Sep 11 08:44:53 volumio volumio[9783]: info: Plugin folders cleanup
Sep 11 08:44:53 volumio volumio[9783]: info: Scanning into folder /volumio/app/plugins/
Sep 11 08:44:53 volumio volumio[9783]: info: Scanning category audio_interface
Sep 11 08:44:53 volumio volumio[9783]: info: Scanning category miscellanea
Sep 11 08:44:53 volumio volumio[9783]: info: Scanning category music_service
Sep 11 08:44:53 volumio volumio[9783]: info: Scanning category plugins.json
Sep 11 08:44:53 volumio volumio[9783]: info: Scanning category system_controller
Sep 11 08:44:53 volumio volumio[9783]: info: Scanning category user_interface
Sep 11 08:44:53 volumio volumio[9783]: info: Scanning into folder /data/plugins/
Sep 11 08:44:53 volumio volumio[9783]: info: Plugin folders cleanup completed
Sep 11 08:44:53 volumio volumio[9783]: info: -------------------------------------------
Sep 11 08:44:53 volumio volumio[9783]: info: ----- Core plugins startup ----
Sep 11 08:44:53 volumio volumio[9783]: info: -------------------------------------------
Sep 11 08:44:53 volumio volumio[9783]: info: Loading plugins from folder /volumio/app/plugins/
Sep 11 08:44:53 volumio volumio[9783]: info: Adding plugin upnp to MyMusic Plugins
Sep 11 08:44:53 volumio volumio[9783]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 11 08:44:53 volumio volumio[9783]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 11 08:44:53 volumio volumio[9783]: info: Loading plugins from folder /data/plugins/
Sep 11 08:44:53 volumio volumio[9783]: info: Loading plugin "system"...
Sep 11 08:44:53 volumio volumio[9783]: info: Loading plugin "appearance"...
Sep 11 08:44:56 volumio volumio[9783]: info: Loading plugin "network"...
Sep 11 08:44:56 volumio volumio[9783]: info: Refreshing Cached IP Addresses
Sep 11 08:44:57 volumio sudo[9808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 11 08:44:57 volumio volumio[9783]: info: Loading plugin "services"...
Sep 11 08:44:57 volumio sudo[9808]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 08:44:57 volumio volumio[9783]: info: Loading plugin "alsa_controller"...
Sep 11 08:44:57 volumio sudo[9808]: pam_unix(sudo:session): session closed for user root
Sep 11 08:44:57 volumio sudo[9812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 11 08:44:57 volumio sudo[9812]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 08:44:57 volumio sudo[9812]: pam_unix(sudo:session): session closed for user root
Sep 11 08:44:57 volumio volumio[9783]: info: Loading plugin "wizard"...
Sep 11 08:44:57 volumio volumio[9783]: info: Loading plugin "volumio_command_line_client"...
Sep 11 08:44:57 volumio volumio[9783]: info: Plugin upnp is not enabled
Sep 11 08:44:57 volumio volumio[9783]: info: Loading plugin "my_music"...
Sep 11 08:44:57 volumio volumio[9783]: info: Loading plugin "mpd"...
Sep 11 08:44:58 volumio volumio[9783]: info: Plugin upnp_browser is not enabled
Sep 11 08:44:58 volumio volumio[9783]: info: Loading plugin "networkfs"...
Sep 11 08:44:58 volumio volumio[9783]: info: Cannot mount NAS N5101 at system boot, trial number 1 ,retrying in 5 seconds
Sep 11 08:44:58 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 11 08:44:58 volumio volumio[9783]: info: Loading plugin "alarm-clock"...
Sep 11 08:44:58 volumio volumio[9783]: info: Loading plugin "airplay_emulation"...
Sep 11 08:44:58 volumio volumio[9783]: info: Starting Shairport Sync
Sep 11 08:44:58 volumio volumio[9783]: info: Loading plugin "last_100"...
Sep 11 08:44:58 volumio volumio[9783]: info: Loading plugin "webradio"...
Sep 11 08:44:58 volumio volumio[9783]: info: Loading plugin "i2s_dacs"...
Sep 11 08:44:59 volumio volumio[9783]: info: I2S DAC not set, start Auto-detection
Sep 11 08:44:59 volumio volumio[9783]: info: Loading plugin "volumiodiscovery"...
Sep 11 08:44:59 volumio volumio[9783]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 11 08:44:59 volumio node[9783]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 11 08:44:59 volumio node[9783]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 11 08:44:59 volumio node[9783]: *** WARNING *** For more information see
Sep 11 08:44:59 volumio node[9783]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 11 08:44:59 volumio node[9783]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 11 08:44:59 volumio node[9783]: *** WARNING *** For more information see
Sep 11 08:44:59 volumio volumio[9783]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 11 08:44:59 volumio volumio[9783]: *** WARNING *** For more information see
Sep 11 08:44:59 volumio volumio[9783]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 11 08:44:59 volumio volumio[9783]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 11 08:44:59 volumio volumio[9783]: *** WARNING *** For more information see
Sep 11 08:44:59 volumio volumio[9783]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 11 08:44:59 volumio volumio[9783]: Discovery: StartAdv! undefined
Sep 11 08:44:59 volumio volumio[9783]: Discovery: Started advertising... Volumio - undefined
Sep 11 08:44:59 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 11 08:44:59 volumio volumio[9783]: info: Loading plugin "outputs"...
Sep 11 08:44:59 volumio volumio[9783]: info: Loading plugin "albumart"...
Sep 11 08:44:59 volumio volumio[9783]: info: Plugin example_plugin is not enabled
Sep 11 08:44:59 volumio volumio[9783]: info: Loading plugin "inputs"...
Sep 11 08:44:59 volumio volumio[9783]: info: Loading plugin "updater_comm"...
Sep 11 08:44:59 volumio volumio[9783]: info: Plugin mpdemulation is not enabled
Sep 11 08:44:59 volumio volumio[9783]: info: Loading plugin "rest_api"...
Sep 11 08:44:59 volumio volumio[9783]: info: Loading plugin "websocket"...
Sep 11 08:44:59 volumio volumio[9783]: info: ___________ START PLUGINS ___________
Sep 11 08:44:59 volumio volumio[9783]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 11 08:44:59 volumio volumio[9783]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 11 08:44:59 volumio volumio[9783]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 11 08:44:59 volumio volumio[9783]: info: [1757580299906] CoreMusicLibrary::Adding element Last_100
Sep 11 08:44:59 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 11 08:44:59 volumio volumio[9783]: Forking 3 albumart workers
Sep 11 08:44:59 volumio volumio[9783]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 11 08:44:59 volumio volumio[9783]: info: [1757580299924] CoreMusicLibrary::Adding element Webradio
Sep 11 08:44:59 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 11 08:44:59 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 11 08:44:59 volumio volumio[9783]: info: -------------------------------------------
Sep 11 08:44:59 volumio volumio[9783]: info: ----- MyVolumio plugins startup ----
Sep 11 08:44:59 volumio volumio[9783]: info: -------------------------------------------
Sep 11 08:44:59 volumio volumio[9783]: info: [MyVolumio PluginManager] Fetching plans data....
Sep 11 08:44:59 volumio volumio[9783]: info: Loading i18n strings for locale zh
Sep 11 08:44:59 volumio volumio[9783]: Updating browse sources language
Sep 11 08:45:00 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 11 08:45:00 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 11 08:45:00 volumio volumio[9783]: info: CoreCommandRouter::initPlayerControls
Sep 11 08:45:00 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 08:45:00 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Sep 11 08:45:00 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 08:45:00 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 08:45:00 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 08:45:00 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 08:45:00 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 08:45:00 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 11 08:45:00 volumio volumio[9783]: info: BOOT COMPLETED
Sep 11 08:45:00 volumio volumio[9783]: [Metrics] CommandRouter: 8s 718.92ms
Sep 11 08:45:00 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 08:45:01 volumio volumio[9783]: Starting albumart workers
Sep 11 08:45:01 volumio volumio[9783]: Starting albumart workers
Sep 11 08:45:01 volumio volumio[9783]: Starting albumart workers
Sep 11 08:45:05 volumio volumio-remote-updater[613]: [2025-09-11 08:45:05] [connect] Successful connection
Sep 11 08:45:05 volumio volumio[9783]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Sep 11 08:45:05 volumio volumio[9783]: info: CoreCommandRouter::Close All Modals sent
Sep 11 08:45:05 volumio volumio[9783]: info: CoreCommandRouter::Close All Modals sent
Sep 11 08:45:05 volumio volumio[9783]: Express server listening on port 3000
Sep 11 08:45:05 volumio volumio[9783]: [Metrics] WebUI: 14s 977.51ms
Sep 11 08:45:05 volumio volumio[9783]: Volumio Calling Home
Sep 11 08:45:05 volumio volumio[9783]: info: CoreStateMachine::resetVolumioState
Sep 11 08:45:05 volumio volumio[9783]: info: CoreStateMachine::getcurrentVolume
Sep 11 08:45:05 volumio volumio[9783]: info: CoreCommandRouter::volumioRetrievevolume
Sep 11 08:45:05 volumio volumio[9783]: info: Cannot mount NAS N5101 at system boot, trial number 2 ,retrying in 5 seconds
Sep 11 08:45:05 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 08:45:05 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 08:45:06 volumio volumio[9783]: info: Setting Device type: Raspberry PI
Sep 11 08:45:06 volumio volumio[9783]: info: MPD running with PID3920
Sep 11 08:45:06 volumio volumio[9783]: ,establishing connection
Sep 11 08:45:06 volumio sudo[9907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1
Sep 11 08:45:06 volumio sudo[9907]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 08:45:06 volumio sudo[9907]: pam_unix(sudo:session): session closed for user root
Sep 11 08:45:06 volumio volumio-remote-updater[613]: [2025-09-11 08:45:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1757580305 101
Sep 11 08:45:06 volumio volumio[9783]: info: VolumeController:: Volume=85 Mute =false
Sep 11 08:45:06 volumio volumio[9783]: info: CoreStateMachine::pushState
Sep 11 08:45:06 volumio volumio[9783]: info: CorePlayQueue::getTrack 0
Sep 11 08:45:06 volumio volumio[9783]: info: CoreCommandRouter::volumioPushState
Sep 11 08:45:06 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 11 08:45:06 volumio volumio[9783]: info: CoreStateMachine::updateTrackBlock
Sep 11 08:45:06 volumio volumio[9783]: info: CorePlayQueue::getTrackBlock
Sep 11 08:45:06 volumio volumio[9783]: info: CoreCommandRouter::volumioRetrievevolume
Sep 11 08:45:06 volumio volumio[9783]: info:
Sep 11 08:45:06 volumio volumio[9783]: ---------------------------- Client requests Volume 85
Sep 11 08:45:06 volumio volumio[9783]: info: VolumeController::SetAlsaVolume85
Sep 11 08:45:06 volumio volumio[9783]: info: CoreStateMachine::pushState
Sep 11 08:45:06 volumio volumio[9783]: info: CorePlayQueue::getTrack 0
Sep 11 08:45:06 volumio volumio[9783]: info: CoreCommandRouter::volumioPushState
Sep 11 08:45:06 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 11 08:45:07 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 08:45:07 volumio volumio[9783]: info: Volumio called home
Sep 11 08:45:07 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Sep 11 08:45:07 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Sep 11 08:45:07 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Sep 11 08:45:07 volumio volumio[9783]: info: Reloading queue from file
Sep 11 08:45:07 volumio volumio[9783]: error: Failed LSINFO: Error: [50@0] {} No such directory
Sep 11 08:45:08 volumio volumio[9783]: info: CoreCommandRouter::volumioGetState
Sep 11 08:45:08 volumio volumio[9783]: info: CorePlayQueue::getTrack 0
Sep 11 08:45:08 volumio volumio[9783]: info: Setting volume on startup at 85
Sep 11 08:45:08 volumio volumio[9783]: info: CoreStateMachine::setRepeat true single undefined
Sep 11 08:45:08 volumio volumio[9783]: info: CoreStateMachine::pushState
Sep 11 08:45:08 volumio volumio[9783]: info: CorePlayQueue::getTrack 0
Sep 11 08:45:08 volumio volumio[9783]: info: CoreCommandRouter::volumioPushState
Sep 11 08:45:08 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 11 08:45:08 volumio volumio[9783]: info: CoreStateMachine::setRandom true
Sep 11 08:45:08 volumio volumio[9783]: info: CoreStateMachine::pushState
Sep 11 08:45:08 volumio volumio[9783]: info: CorePlayQueue::getTrack 0
Sep 11 08:45:08 volumio volumio[9783]: info: CoreCommandRouter::volumioPushState
Sep 11 08:45:08 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 11 08:45:08 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 11 08:45:08 volumio volumio[9783]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 11 08:45:08 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 11 08:45:08 volumio volumio[9783]: info: Listing playlists
Sep 11 08:45:08 volumio volumio[9783]: info: CoreCommandRouter::volumioGetQueue
Sep 11 08:45:08 volumio volumio[9783]: info: CoreStateMachine::getQueue
Sep 11 08:45:08 volumio volumio[9783]: info: CorePlayQueue::getQueue
Sep 11 08:45:08 volumio volumio[9783]: info: VolumeController:: Volume=85 Mute =false
Sep 11 08:45:08 volumio volumio[9783]: info: CoreStateMachine::pushState
Sep 11 08:45:08 volumio volumio[9783]: info: CorePlayQueue::getTrack 0
Sep 11 08:45:08 volumio volumio[9783]: info: CoreCommandRouter::volumioPushState
Sep 11 08:45:08 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 11 08:45:08 volumio volumio[9783]: info: Starting Shairport Sync
Sep 11 08:45:08 volumio volumio[9783]: info: Starting Shairport Sync
Sep 11 08:45:08 volumio sudo[9924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 11 08:45:08 volumio sudo[9924]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 08:45:08 volumio sudo[9927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 11 08:45:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 11 08:45:08 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Sep 11 08:45:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 11 08:45:08 volumio sudo[9927]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 08:45:08 volumio sudo[9924]: pam_unix(sudo:session): session closed for user root
Sep 11 08:45:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 11 08:45:08 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Sep 11 08:45:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 11 08:45:08 volumio sudo[9927]: pam_unix(sudo:session): session closed for user root
Sep 11 08:45:09 volumio volumio[9783]: info: Shairport-Sync Started
Sep 11 08:45:09 volumio volumio[9783]: Error adding Membership: Error: addMembership EINVAL
Sep 11 08:45:09 volumio volumio[9783]: info: Shairport-Sync Started
Sep 11 08:45:09 volumio volumio[9783]: Discovery: adding 5bd3485b-fff6-4060-95ac-a6276faf7797
Sep 11 08:45:09 volumio volumio[9783]: info: mDNS: Found device Volumio
Sep 11 08:45:09 volumio volumio[9783]: info: CoreCommandRouter::volumioGetState
Sep 11 08:45:09 volumio volumio[9783]: info: CorePlayQueue::getTrack 0
Sep 11 08:45:09 volumio volumio[9783]: info: CoreCommandRouter::volumioGetState
Sep 11 08:45:09 volumio volumio[9783]: info: CorePlayQueue::getTrack 0
Sep 11 08:45:09 volumio volumio[9783]: Discovery: this is already registered, 5bd3485b-fff6-4060-95ac-a6276faf7797
Sep 11 08:45:09 volumio volumio[9783]: info: mDNS: Found device Volumio
Sep 11 08:45:09 volumio volumio[9783]: info: CoreCommandRouter::volumioGetState
Sep 11 08:45:09 volumio volumio[9783]: info: CorePlayQueue::getTrack 0
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Sep 11 08:45:10 volumio volumio[9783]: info: Adding plugin bluetooth to MyMusic Plugins
Sep 11 08:45:10 volumio volumio[9783]: info: Adding plugin cd_controller to MyMusic Plugins
Sep 11 08:45:10 volumio volumio[9783]: info: Adding plugin smart_inputs to MyMusic Plugins
Sep 11 08:45:10 volumio volumio[9783]: info: Adding plugin tidalconnect to MyMusic Plugins
Sep 11 08:45:10 volumio volumio[9783]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Sep 11 08:45:11 volumio volumio[9783]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Sep 11 08:45:12 volumio volumio[9783]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Sep 11 08:45:12 volumio volumio[9783]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Sep 11 08:45:12 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 08:45:12 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 08:45:12 volumio volumio[9783]: info: Starting MyVolumio Remote Streaming Endpoints
Sep 11 08:45:12 volumio volumio[9783]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Sep 11 08:45:12 volumio volumio[9783]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Sep 11 08:45:12 volumio volumio[9783]: info: Streaming services startup
Sep 11 08:45:12 volumio volumio[9783]: info: Starting Streaming Daemon
Sep 11 08:45:12 volumio sudo[9963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Sep 11 08:45:12 volumio sudo[9963]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 08:45:12 volumio systemd[1]: Stopping Volumio Streaming Daemon...
Sep 11 08:45:12 volumio volumio[9783]: info: MyVolumio not started
Sep 11 08:45:12 volumio volumio[9783]: info: Initializing device activation check
Sep 11 08:45:12 volumio volumio[9783]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Sep 11 08:45:12 volumio systemd[1]: Starting Volumio Streaming Daemon...
Sep 11 08:45:12 volumio sudo[9963]: pam_unix(sudo:session): session closed for user root
Sep 11 08:45:12 volumio systemd[1]: Started Volumio Streaming Daemon.
Sep 11 08:45:12 volumio volumio-streaming-daemon[9973]: ############################
Sep 11 08:45:12 volumio volumio-streaming-daemon[9973]: # Volumio Streaming Daemon #
Sep 11 08:45:12 volumio volumio-streaming-daemon[9973]: # Running on port 7777 #
Sep 11 08:45:12 volumio volumio-streaming-daemon[9973]: ############################
Sep 11 08:45:12 volumio volumio-streaming-daemon[9973]: Environment: production
Sep 11 08:45:12 volumio volumio[9783]: info: Cannot mount NAS N5101 at system boot, trial number 3 ,retrying in 5 seconds
Sep 11 08:45:13 volumio volumio[9783]: info: CoreCommandRouter::volumioGetState
Sep 11 08:45:13 volumio volumio[9783]: info: CorePlayQueue::getTrack 0
Sep 11 08:45:13 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 11 08:45:13 volumio volumio[9783]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 11 08:45:13 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 11 08:45:13 volumio volumio[9783]: info: Listing playlists
Sep 11 08:45:13 volumio volumio[9783]: info: CoreCommandRouter::volumioGetQueue
Sep 11 08:45:13 volumio volumio[9783]: info: CoreStateMachine::getQueue
Sep 11 08:45:13 volumio volumio[9783]: info: CorePlayQueue::getQueue
Sep 11 08:45:15 volumio volumio-streaming-daemon[9973]: Environment: production
Sep 11 08:45:15 volumio volumio[9783]: info: Fetching Streaming Services browse cache
Sep 11 08:45:17 volumio volumio[9783]: info: Cannot mount NAS N5101 at system boot, trial number 4 ,retrying in 5 seconds
Sep 11 08:45:22 volumio volumio[9783]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Sep 11 08:45:29 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 11 08:45:29 volumio volumio[9783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 08:45:41 volumio volumio[9783]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 11 08:45:41 volumio volumio[9783]: { Error: connect ETIMEDOUT 69.50.221.20:443
Sep 11 08:45:41 volumio volumio[9783]: at Object._errnoException (util.js:1022:11)
Sep 11 08:45:41 volumio volumio[9783]: at _exceptionWithHostPort (util.js:1044:20)
Sep 11 08:45:41 volumio volumio[9783]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Sep 11 08:45:41 volumio volumio[9783]: code: 'ETIMEDOUT',
Sep 11 08:45:41 volumio volumio[9783]: errno: 'ETIMEDOUT',
Sep 11 08:45:41 volumio volumio[9783]: syscall: 'connect',
Sep 11 08:45:41 volumio volumio[9783]: address: '69.50.221.20',
Sep 11 08:45:41 volumio volumio[9783]: port: 443 }
Sep 11 08:45:41 volumio volumio[9783]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 11 08:45:42 volumio sudo[10015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-11 08:44
Sep 11 08:45:42 volumio sudo[10015]: 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="cd11dc738d0d82822d0aa776d0729686b82e3758"
VOLUMIO_FE_VERSION="77db3ca2a7f5a7023ece8c5b86e997d58abdace6"
VOLUMIO_BE_VERSION="748352701ebc6ec2b59443fcac1ec9aea1f276df"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Jul 2 12:45:33 CEST 2021"
VOLUMIO_VERSION="2.907"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="858e764292794952fe9c14f4c1868f5a"