-- Logs begin at Fri 2026-01-09 05:44:24 UTC, end at Fri 2026-01-09 06:07:05 UTC. -- Jan 09 06:06:02 volumio volumio[5042]: info: ------------------------------------------- Jan 09 06:06:02 volumio volumio[5042]: info: ----- Volumio2 ---- Jan 09 06:06:02 volumio volumio[5042]: info: ------------------------------------------- Jan 09 06:06:02 volumio volumio[5042]: info: ----- System startup ---- Jan 09 06:06:02 volumio volumio[5042]: info: ------------------------------------------- Jan 09 06:06:02 volumio volumio[5042]: info: MYVOLUMIO Environment detected Jan 09 06:06:03 volumio volumio[5042]: info: Plugin folders cleanup Jan 09 06:06:03 volumio volumio[5042]: info: Scanning into folder /volumio/app/plugins/ Jan 09 06:06:03 volumio volumio[5042]: info: Scanning category audio_interface Jan 09 06:06:03 volumio volumio[5042]: info: Scanning category miscellanea Jan 09 06:06:03 volumio volumio[5042]: info: Scanning category music_service Jan 09 06:06:03 volumio volumio[5042]: info: Scanning category plugins.json Jan 09 06:06:03 volumio volumio[5042]: info: Scanning category system_controller Jan 09 06:06:03 volumio volumio[5042]: info: Scanning category user_interface Jan 09 06:06:03 volumio volumio[5042]: info: Scanning into folder /data/plugins/ Jan 09 06:06:03 volumio volumio[5042]: info: Scanning category miscellanea Jan 09 06:06:03 volumio volumio[5042]: info: Scanning category music_service Jan 09 06:06:03 volumio volumio[5042]: info: Scanning category system_controller Jan 09 06:06:03 volumio volumio[5042]: info: Plugin folders cleanup completed Jan 09 06:06:03 volumio volumio[5042]: info: ------------------------------------------- Jan 09 06:06:03 volumio volumio[5042]: info: ----- Core plugins startup ---- Jan 09 06:06:03 volumio volumio[5042]: info: ------------------------------------------- Jan 09 06:06:03 volumio volumio[5042]: info: Loading plugins from folder /volumio/app/plugins/ Jan 09 06:06:03 volumio volumio[5042]: info: Adding plugin upnp to MyMusic Plugins Jan 09 06:06:03 volumio volumio[5042]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 09 06:06:03 volumio volumio[5042]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 09 06:06:03 volumio volumio[5042]: info: Loading plugins from folder /data/plugins/ Jan 09 06:06:03 volumio volumio[5042]: info: Loading plugin "system"... Jan 09 06:06:03 volumio volumio[5042]: info: Loading plugin "appearance"... Jan 09 06:06:05 volumio volumio[5042]: info: Loading plugin "network"... Jan 09 06:06:05 volumio volumio[5042]: info: Loading plugin "services"... Jan 09 06:06:05 volumio volumio[5042]: info: Loading plugin "alsa_controller"... Jan 09 06:06:05 volumio volumio[5042]: info: Loading plugin "wizard"... Jan 09 06:06:05 volumio volumio[5042]: info: Loading plugin "volumio_command_line_client"... Jan 09 06:06:05 volumio volumio[5042]: info: Loading plugin "upnp"... Jan 09 06:06:05 volumio volumio[5042]: info: [1767938765952] Starting Upmpd Daemon Jan 09 06:06:05 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 09 06:06:05 volumio volumio[5042]: info: Loading plugin "my_music"... Jan 09 06:06:05 volumio volumio[5042]: info: Loading plugin "mpd"... Jan 09 06:06:06 volumio sudo[5071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 06:06:06 volumio volumio[5042]: info: Loading plugin "upnp_browser"... Jan 09 06:06:06 volumio sudo[5071]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 06:06:06 volumio sudo[5071]: pam_unix(sudo:session): session closed for user root Jan 09 06:06:06 volumio sudo[5074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 06:06:06 volumio sudo[5074]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 06:06:06 volumio systemd[1]: Stopping Music Player Daemon... Jan 09 06:06:07 volumio systemd[1]: Starting Music Player Daemon... Jan 09 06:06:07 volumio volumio[5042]: info: Loading plugin "networkfs"... Jan 09 06:06:07 volumio volumio[5042]: info: Cannot mount NAS SONG at system boot, trial number 1 ,retrying in 5 seconds Jan 09 06:06:07 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 09 06:06:07 volumio volumio[5042]: info: Loading plugin "alarm-clock"... Jan 09 06:06:08 volumio volumio[5042]: info: Loading plugin "airplay_emulation"... Jan 09 06:06:08 volumio volumio[5042]: info: Starting Shairport Sync Jan 09 06:06:08 volumio volumio[5042]: info: Loading plugin "last_100"... Jan 09 06:06:08 volumio volumio[5042]: info: Loading plugin "webradio"... Jan 09 06:06:08 volumio volumio[5042]: info: Loading plugin "i2s_dacs"... Jan 09 06:06:08 volumio volumio[5042]: info: I2S DAC not set, start Auto-detection Jan 09 06:06:08 volumio volumio[5042]: info: Loading plugin "volumiodiscovery"... Jan 09 06:06:08 volumio volumio[5042]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 09 06:06:08 volumio node[5042]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 09 06:06:08 volumio node[5042]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 09 06:06:08 volumio node[5042]: *** WARNING *** For more information see Jan 09 06:06:08 volumio node[5042]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 09 06:06:08 volumio node[5042]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 09 06:06:08 volumio node[5042]: *** WARNING *** For more information see Jan 09 06:06:08 volumio volumio[5042]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 09 06:06:08 volumio volumio[5042]: *** WARNING *** For more information see Jan 09 06:06:08 volumio volumio[5042]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 09 06:06:08 volumio volumio[5042]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 09 06:06:08 volumio volumio[5042]: *** WARNING *** For more information see Jan 09 06:06:08 volumio volumio[5042]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 09 06:06:08 volumio volumio[5042]: Discovery: StartAdv! undefined Jan 09 06:06:08 volumio volumio[5042]: Discovery: Started advertising... Volumio - undefined Jan 09 06:06:08 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 09 06:06:08 volumio volumio[5042]: info: Loading plugin "auto_play"... Jan 09 06:06:08 volumio volumio[5042]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600 Jan 09 06:06:08 volumio volumio[5042]: info: Loading plugin "autostart"... Jan 09 06:06:08 volumio volumio[5042]: info: Applying required configuration parameters for plugin autostart Jan 09 06:06:08 volumio volumio[5042]: info: Loading plugin "outputs"... Jan 09 06:06:08 volumio volumio[5042]: info: Loading plugin "albumart"... Jan 09 06:06:08 volumio volumio[5042]: info: Plugin example_plugin is not enabled Jan 09 06:06:08 volumio volumio[5042]: info: Loading plugin "inputs"... Jan 09 06:06:08 volumio volumio[5042]: info: Loading plugin "updater_comm"... Jan 09 06:06:09 volumio volumio[5042]: info: Plugin mpdemulation is not enabled Jan 09 06:06:09 volumio volumio[5042]: info: Loading plugin "rest_api"... Jan 09 06:06:09 volumio volumio[5042]: info: Loading plugin "websocket"... Jan 09 06:06:09 volumio volumio[5042]: info: Loading plugin "Systeminfo"... Jan 09 06:06:09 volumio volumio[5042]: Forking 3 albumart workers Jan 09 06:06:10 volumio volumio[5042]: info: Loading plugin "hotelradio"... Jan 09 06:06:11 volumio volumio[5042]: Starting albumart workers Jan 09 06:06:11 volumio volumio[5042]: Starting albumart workers Jan 09 06:06:12 volumio volumio[5042]: Starting albumart workers Jan 09 06:06:12 volumio volumio[5042]: info: Plugin personal_radio is not enabled Jan 09 06:06:12 volumio volumio[5042]: info: Loading plugin "radio_paradise"... Jan 09 06:06:13 volumio volumio[5042]: info: Applying required configuration parameters for plugin radio_paradise Jan 09 06:06:13 volumio volumio[5042]: info: [1767938773452] [RadioParadise] API delay: 5 Jan 09 06:06:13 volumio volumio[5042]: info: Loading plugin "backup_restore"... Jan 09 06:06:13 volumio volumio[5042]: info: ___________ START PLUGINS ___________ Jan 09 06:06:13 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 06:06:13 volumio volumio[5042]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 09 06:06:13 volumio volumio[5042]: info: [1767938773964] CoreMusicLibrary::Adding element Media Servers Jan 09 06:06:13 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:14 volumio volumio[5042]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:14 volumio volumio[5042]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 09 06:06:14 volumio volumio[5042]: info: [1767938774216] CoreMusicLibrary::Adding element Last_100 Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 09 06:06:14 volumio volumio[5042]: info: [1767938774224] CoreMusicLibrary::Adding element Webradio Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 09 06:06:14 volumio volumio[5042]: info: [1767938774265] CoreMusicLibrary::Adding element Radio Paradise Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 06:06:14 volumio volumio[5042]: info: ------------------------------------------- Jan 09 06:06:14 volumio volumio[5042]: info: ----- MyVolumio plugins startup ---- Jan 09 06:06:14 volumio volumio[5042]: info: ------------------------------------------- Jan 09 06:06:14 volumio volumio[5042]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 09 06:06:14 volumio volumio[5042]: info: Loading i18n strings for locale ko Jan 09 06:06:14 volumio volumio[5042]: Updating browse sources language Jan 09 06:06:14 volumio volumio[5042]: Cannot find translation for sourceMedia Servers Jan 09 06:06:14 volumio volumio[5042]: Cannot find translation for sourceRadio Paradise Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::initPlayerControls Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 06:06:14 volumio volumio[5042]: info: BOOT COMPLETED Jan 09 06:06:14 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 06:06:19 volumio volumio[5042]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jan 09 06:06:19 volumio volumio[5042]: info: CoreCommandRouter::Close All Modals sent Jan 09 06:06:19 volumio volumio[5042]: info: CoreCommandRouter::Close All Modals sent Jan 09 06:06:19 volumio volumio[5042]: Express server listening on port 3000 Jan 09 06:06:19 volumio volumio[5042]: Volumio Calling Home Jan 09 06:06:19 volumio volumio[5042]: info: CoreStateMachine::resetVolumioState Jan 09 06:06:19 volumio volumio[5042]: info: CoreStateMachine::getcurrentVolume Jan 09 06:06:19 volumio volumio[5042]: info: CoreCommandRouter::volumioRetrievevolume Jan 09 06:06:20 volumio volumio[5042]: info: Cannot mount NAS SONG at system boot, trial number 2 ,retrying in 5 seconds Jan 09 06:06:20 volumio sudo[5157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 09 06:06:20 volumio sudo[5157]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 06:06:20 volumio sudo[5157]: pam_unix(sudo:session): session closed for user root Jan 09 06:06:20 volumio volumio[5042]: info: CoreStateMachine::pushState Jan 09 06:06:20 volumio volumio[5042]: info: CoreStateMachine::getState Jan 09 06:06:20 volumio volumio[5042]: info: CorePlayQueue::getTrack 0 Jan 09 06:06:20 volumio volumio[5042]: info: CoreCommandRouter::volumioPushState Jan 09 06:06:20 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 06:06:20 volumio volumio[5042]: info: CoreStateMachine::updateTrackBlock Jan 09 06:06:20 volumio volumio[5042]: info: CorePlayQueue::getTrackBlock Jan 09 06:06:20 volumio volumio[5042]: info: CoreCommandRouter::volumioRetrievevolume Jan 09 06:06:20 volumio volumio[5042]: info: Setting Device type: Raspberry PI Jan 09 06:06:21 volumio volumio[5042]: info: MPD Permissions set Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 09 06:06:21 volumio sudo[5172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Jan 09 06:06:21 volumio sudo[5172]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 06:06:21 volumio sudo[5172]: pam_unix(sudo:session): session closed for user root Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 06:06:21 volumio volumio[5042]: info: CoreStateMachine::pushState Jan 09 06:06:21 volumio volumio[5042]: info: CoreStateMachine::getState Jan 09 06:06:21 volumio volumio[5042]: info: CorePlayQueue::getTrack 0 Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::volumioPushState Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 06:06:21 volumio volumio[5042]: info: Jan 09 06:06:21 volumio volumio[5042]: ---------------------------- Client requests Volume 40 Jan 09 06:06:21 volumio volumio[5042]: info: VolumeController::SetAlsaVolume40 Jan 09 06:06:21 volumio volumio[5042]: info: CoreStateMachine::pushState Jan 09 06:06:21 volumio volumio[5042]: info: CoreStateMachine::getState Jan 09 06:06:21 volumio volumio[5042]: info: CorePlayQueue::getTrack 0 Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::volumioPushState Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 06:06:21 volumio volumio[5042]: info: Reloading queue from file Jan 09 06:06:21 volumio volumio[5042]: info: Setting volume on startup at 40 Jan 09 06:06:21 volumio volumio[5042]: info: CoreStateMachine::setRepeat null single undefined Jan 09 06:06:21 volumio volumio[5042]: info: CoreStateMachine::pushState Jan 09 06:06:21 volumio volumio[5042]: info: CoreStateMachine::getState Jan 09 06:06:21 volumio volumio[5042]: info: CorePlayQueue::getTrack 0 Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::volumioPushState Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 06:06:21 volumio volumio[5042]: info: CoreStateMachine::setRandom null Jan 09 06:06:21 volumio volumio[5042]: info: CoreStateMachine::pushState Jan 09 06:06:21 volumio volumio[5042]: info: CoreStateMachine::getState Jan 09 06:06:21 volumio volumio[5042]: info: CorePlayQueue::getTrack 0 Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::volumioPushState Jan 09 06:06:21 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 06:06:22 volumio volumio[5042]: info: Starting Shairport Sync Jan 09 06:06:22 volumio volumio[5042]: info: Starting Shairport Sync Jan 09 06:06:22 volumio sudo[5190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 06:06:22 volumio sudo[5190]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 06:06:22 volumio sudo[5192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 06:06:22 volumio sudo[5192]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 06:06:22 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 09 06:06:22 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jan 09 06:06:22 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 09 06:06:22 volumio sudo[5190]: pam_unix(sudo:session): session closed for user root Jan 09 06:06:22 volumio sudo[5200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 09 06:06:22 volumio sudo[5200]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 06:06:22 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 09 06:06:22 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jan 09 06:06:22 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 09 06:06:22 volumio sudo[5192]: pam_unix(sudo:session): session closed for user root Jan 09 06:06:22 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jan 09 06:06:22 volumio sudo[5200]: pam_unix(sudo:session): session closed for user root Jan 09 06:06:22 volumio volumio[5042]: info: Upmpdcli Daemon Started Jan 09 06:06:22 volumio volumio[5042]: info: Shairport-Sync Started Jan 09 06:06:22 volumio volumio[5042]: Error adding Membership: Error: addMembership EINVAL Jan 09 06:06:22 volumio volumio[5042]: info: Shairport-Sync Started Jan 09 06:06:22 volumio volumio[5042]: Discovery: adding 26ad29d7-5bcd-4a70-85fc-1683ad25eafe Jan 09 06:06:22 volumio volumio[5042]: info: mDNS: Found device Volumio Jan 09 06:06:22 volumio sudo[5238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 09 06:06:22 volumio volumio[5042]: Discovery: this is already registered, 26ad29d7-5bcd-4a70-85fc-1683ad25eafe Jan 09 06:06:22 volumio volumio[5042]: info: mDNS: Found device Volumio Jan 09 06:06:22 volumio sudo[5238]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 06:06:22 volumio sudo[5238]: pam_unix(sudo:session): session closed for user root Jan 09 06:06:22 volumio sudo[5246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 09 06:06:22 volumio sudo[5246]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 06:06:22 volumio sudo[5246]: pam_unix(sudo:session): session closed for user root Jan 09 06:06:22 volumio volumio[5042]: info: CALLMETHOD: user_interface websocket broadcastMessage [object Object] Jan 09 06:06:22 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Jan 09 06:06:23 volumio volumio[5042]: info: CoreCommandRouter::volumioGetState Jan 09 06:06:23 volumio volumio[5042]: info: CoreStateMachine::getState Jan 09 06:06:23 volumio volumio[5042]: info: CorePlayQueue::getTrack 0 Jan 09 06:06:23 volumio sudo[5256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 09 06:06:23 volumio sudo[5256]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 06:06:23 volumio sudo[5256]: pam_unix(sudo:session): session closed for user root Jan 09 06:06:23 volumio volumio[5042]: info: CoreCommandRouter::volumioGetVisibleSources Jan 09 06:06:23 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 06:06:23 volumio volumio[5042]: info: CoreCommandRouter::volumioGetState Jan 09 06:06:23 volumio volumio[5042]: info: CoreStateMachine::getState Jan 09 06:06:23 volumio volumio[5042]: info: CorePlayQueue::getTrack 0 Jan 09 06:06:23 volumio sudo[5265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 09 06:06:23 volumio sudo[5265]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 06:06:23 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 09 06:06:23 volumio volumio[5042]: info: Listing playlists Jan 09 06:06:23 volumio sudo[5269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 09 06:06:23 volumio sudo[5265]: pam_unix(sudo:session): session closed for user root Jan 09 06:06:23 volumio sudo[5269]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 06:06:23 volumio sudo[5269]: pam_unix(sudo:session): session closed for user root Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jan 09 06:06:24 volumio volumio[5042]: info: Adding plugin bluetooth to MyMusic Plugins Jan 09 06:06:24 volumio volumio[5042]: info: Adding plugin cd_controller to MyMusic Plugins Jan 09 06:06:24 volumio volumio[5042]: info: Adding plugin smart_inputs to MyMusic Plugins Jan 09 06:06:24 volumio volumio[5042]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jan 09 06:06:27 volumio volumio[5042]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jan 09 06:06:29 volumio volumio[5042]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jan 09 06:06:29 volumio volumio[5042]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jan 09 06:06:29 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 06:06:29 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 06:06:29 volumio volumio[5042]: info: Starting MyVolumio Remote Streaming Endpoints Jan 09 06:06:29 volumio volumio[5042]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 09 06:06:29 volumio volumio[5042]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 09 06:06:29 volumio volumio[5042]: info: Streaming services startup Jan 09 06:06:29 volumio volumio[5042]: info: Starting Streaming Daemon Jan 09 06:06:29 volumio volumio[5042]: info: MyVolumio not started Jan 09 06:06:29 volumio volumio[5042]: info: Initializing device activation check Jan 09 06:06:29 volumio sudo[5285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 09 06:06:29 volumio sudo[5285]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 06:06:29 volumio volumio[5042]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jan 09 06:06:29 volumio systemd[1]: Stopping Volumio Streaming Daemon... Jan 09 06:06:29 volumio systemd[1]: Starting Volumio Streaming Daemon... Jan 09 06:06:29 volumio sudo[5285]: pam_unix(sudo:session): session closed for user root Jan 09 06:06:29 volumio systemd[1]: Started Volumio Streaming Daemon. Jan 09 06:06:29 volumio volumio-streaming-daemon[5291]: ############################ Jan 09 06:06:29 volumio volumio-streaming-daemon[5291]: # Volumio Streaming Daemon # Jan 09 06:06:29 volumio volumio-streaming-daemon[5291]: # Running on port 7777 # Jan 09 06:06:29 volumio volumio-streaming-daemon[5291]: ############################ Jan 09 06:06:29 volumio volumio[5042]: info: Cannot mount NAS SONG at system boot, trial number 3 ,retrying in 5 seconds Jan 09 06:06:29 volumio volumio[5042]: info: AutoStart - getting queue Jan 09 06:06:29 volumio volumio[5042]: info: CoreCommandRouter::volumioGetQueue Jan 09 06:06:29 volumio volumio[5042]: info: CoreStateMachine::getQueue Jan 09 06:06:29 volumio volumio[5042]: info: CorePlayQueue::getQueue Jan 09 06:06:29 volumio volumio[5042]: info: AutoStart - start playing -> queue is not empty Jan 09 06:06:29 volumio volumio[5042]: info: CoreCommandRouter::volumioPlay Jan 09 06:06:29 volumio volumio[5042]: UNSET VOLATILE Jan 09 06:06:29 volumio volumio[5042]: info: CoreStateMachine::play index undefined Jan 09 06:06:29 volumio volumio[5042]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 06:06:29 volumio volumio[5042]: info: CorePlayQueue::getTrack 0 Jan 09 06:06:29 volumio volumio[5042]: info: CoreStateMachine::startPlaybackTimer Jan 09 06:06:29 volumio volumio[5042]: info: CorePlayQueue::getTrack 0 Jan 09 06:06:29 volumio volumio[5042]: info: ControllerMpd::clearAddPlayTracks NAS/SONG/0 Audiophile Sample/0 Compilation/MF Music The Complete Audiophile Collection (2014) (30CD)/CD03 - Bass Ending 1 (K2-038)/01. Mari Boine - I Hear You - Mari Boine.flac Jan 09 06:06:29 volumio volumio[5042]: info: ControllerMpd::sendMpdCommand stop Jan 09 06:06:30 volumio volumio[5042]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.699&uuid=e9497fcb61b2ddda9c88a297b02641ba" http://updates.volumio.org:7070/downloader-v1/track-device Jan 09 06:06:30 volumio volumio[5042]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 09 06:06:30 volumio volumio[5042]: Dload Upload Total Spent Left Speed Jan 09 06:06:30 volumio volumio[5042]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Jan 09 06:06:30 volumio volumio[5042]: retrying in 5 seconds, trial 0 Jan 09 06:06:30 volumio volumio[5042]: Volumio Calling Home Jan 09 06:06:32 volumio volumio[5042]: info: Fetching Streaming Services browse cache Jan 09 06:06:32 volumio volumio[5042]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Jan 09 06:06:32 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 06:06:32 volumio volumio[5042]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Jan 09 06:06:32 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 06:06:34 volumio volumio[5042]: info: Cannot mount NAS SONG at system boot, trial number 4 ,retrying in 5 seconds Jan 09 06:06:39 volumio volumio[5042]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Jan 09 06:06:41 volumio volumio[5042]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.699&uuid=e9497fcb61b2ddda9c88a297b02641ba" http://updates.volumio.org:7070/downloader-v1/track-device Jan 09 06:06:41 volumio volumio[5042]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 09 06:06:41 volumio volumio[5042]: Dload Upload Total Spent Left Speed Jan 09 06:06:41 volumio volumio[5042]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Jan 09 06:06:41 volumio volumio[5042]: retrying in 5 seconds, trial 1 Jan 09 06:06:41 volumio volumio[5042]: Volumio Calling Home Jan 09 06:06:44 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 06:06:44 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 06:06:51 volumio volumio[5042]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.699&uuid=e9497fcb61b2ddda9c88a297b02641ba" http://updates.volumio.org:7070/downloader-v1/track-device Jan 09 06:06:51 volumio volumio[5042]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 09 06:06:51 volumio volumio[5042]: Dload Upload Total Spent Left Speed Jan 09 06:06:51 volumio volumio[5042]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Jan 09 06:06:51 volumio volumio[5042]: retrying in 5 seconds, trial 2 Jan 09 06:06:51 volumio volumio[5042]: Volumio Calling Home Jan 09 06:06:52 volumio volumio[5042]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 09 06:06:52 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 09 06:06:52 volumio volumio[5042]: info: Received Get System Version Jan 09 06:06:52 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 06:06:55 volumio volumio[5042]: info: CoreCommandRouter::Close All Modals sent Jan 09 06:07:00 volumio volumio[5042]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 09 06:07:00 volumio volumio[5042]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 09 06:07:00 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 09 06:07:00 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 09 06:07:00 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 09 06:07:00 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 09 06:07:00 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 06:07:00 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 06:07:00 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 06:07:00 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 06:07:00 volumio volumio[5042]: info: CoreCommandRouter::volumioGetBrowseSources Jan 09 06:07:00 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 09 06:07:00 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 09 06:07:03 volumio volumio[5042]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jan 09 06:07:03 volumio volumio[5042]: info: ControllerMpd::sendMpdCommand update Jan 09 06:07:03 volumio volumio[5042]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 06:07:03 volumio volumio[5042]: TypeError: Cannot read property 'then' of undefined Jan 09 06:07:03 volumio volumio[5042]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:347:10) Jan 09 06:07:04 volumio volumio[5042]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1910:17) Jan 09 06:07:04 volumio volumio[5042]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1078:29) Jan 09 06:07:04 volumio volumio[5042]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:990:24) Jan 09 06:07:04 volumio volumio[5042]: at emitTwo (events.js:126:13) Jan 09 06:07:04 volumio volumio[5042]: at Socket.emit (events.js:214:7) Jan 09 06:07:04 volumio volumio[5042]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Jan 09 06:07:04 volumio volumio[5042]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jan 09 06:07:04 volumio volumio[5042]: at process._tickCallback (internal/process/next_tick.js:180:9) Jan 09 06:07:04 volumio volumio[5042]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 06:07:05 volumio sudo[5327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-09 06:06 Jan 09 06:07:05 volumio sudo[5327]: 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="80e3a7415791a01dac7cd7cc2cc0a3d3fc65ba9d" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="e32e25d68d93383fe73e2a451c032b2661c71694" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Jan 20 19:41:22 CET 2020" VOLUMIO_VERSION="2.699" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="5faefe8928fcf34b6263aec4aa82825a"