-- Logs begin at Sat 2025-06-21 11:21:32 CST, end at Fri 2025-06-27 09:23:58 CST. --
Jun 27 09:22:09 volumio sudo[18000]:  volumio : TTY=ttyFIQ0 ; PWD=/volumio ; USER=root ; COMMAND=/bin/systemctl restart volumio.service
Jun 27 09:22:09 volumio sudo[18000]: pam_unix(sudo:session): session opened for user root by volumio(uid=0)
Jun 27 09:22:09 volumio systemd[1]: Stopping Volumio Backend Module...
Jun 27 09:22:09 volumio volumio-remote-updater[275]: [2025-06-27 09:22:09] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jun 27 09:22:09 volumio volumio-remote-updater[275]: [2025-06-27 09:22:09] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jun 27 09:22:09 volumio systemd[1]: volumio.service: Main process exited, code=killed, status=15/TERM
Jun 27 09:22:09 volumio systemd[1]: volumio.service: Succeeded.
Jun 27 09:22:09 volumio systemd[1]: Stopped Volumio Backend Module.
Jun 27 09:22:09 volumio systemd[1]: Started Volumio Backend Module.
Jun 27 09:22:09 volumio sudo[18000]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:12 volumio volumio[18003]: info: -------------------------------------------
Jun 27 09:22:12 volumio volumio[18003]: info: -----            Volumio3              ----
Jun 27 09:22:12 volumio volumio[18003]: info: -------------------------------------------
Jun 27 09:22:12 volumio volumio[18003]: info: -----          System startup          ----
Jun 27 09:22:12 volumio volumio[18003]: info: -------------------------------------------
Jun 27 09:22:14 volumio volumio[18003]: info: MYVOLUMIO Environment detected
Jun 27 09:22:14 volumio volumio[18003]: info: Plugin folders cleanup
Jun 27 09:22:14 volumio volumio[18003]: info: Scanning into folder /volumio/app/plugins/
Jun 27 09:22:14 volumio volumio[18003]: info: Scanning category audio_interface
Jun 27 09:22:14 volumio volumio[18003]: info: Scanning category miscellanea
Jun 27 09:22:14 volumio volumio[18003]: info: Scanning category music_service
Jun 27 09:22:14 volumio volumio[18003]: info: Scanning category plugins.json
Jun 27 09:22:14 volumio volumio[18003]: info: Scanning category system_controller
Jun 27 09:22:14 volumio volumio[18003]: info: Scanning category user_interface
Jun 27 09:22:14 volumio volumio-remote-updater[275]: [2025-06-27 09:22:14] [connect] Successful connection
Jun 27 09:22:14 volumio volumio[18003]: info: Scanning into folder /data/plugins/
Jun 27 09:22:14 volumio volumio[18003]: info: Scanning category audio_interface
Jun 27 09:22:14 volumio volumio[18003]: info: Scanning category music_service
Jun 27 09:22:14 volumio volumio[18003]: info: Scanning category system_controller
Jun 27 09:22:14 volumio volumio[18003]: info: Scanning category user_interface
Jun 27 09:22:14 volumio volumio[18003]: info: Plugin folders cleanup completed
Jun 27 09:22:14 volumio volumio[18003]: info: -------------------------------------------
Jun 27 09:22:14 volumio volumio[18003]: info: -----      Core plugins startup        ----
Jun 27 09:22:14 volumio volumio[18003]: info: -------------------------------------------
Jun 27 09:22:14 volumio volumio[18003]: info: Loading plugins from folder /volumio/app/plugins/
Jun 27 09:22:14 volumio volumio[18003]: info: Adding plugin upnp to MyMusic Plugins
Jun 27 09:22:14 volumio volumio[18003]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 27 09:22:14 volumio volumio[18003]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 27 09:22:14 volumio volumio[18003]: info: Loading plugins from folder /data/plugins/
Jun 27 09:22:14 volumio volumio[18003]: info: Adding plugin smart_inputs to MyMusic Plugins
Jun 27 09:22:14 volumio volumio[18003]: info: Loading plugin "system"...
Jun 27 09:22:14 volumio volumio[18003]: info: Loading plugin "appearance"...
Jun 27 09:22:16 volumio volumio[18003]: info: Loading plugin "network"...
Jun 27 09:22:16 volumio volumio[18003]: info: Refreshing Cached IP Addresses
Jun 27 09:22:16 volumio sudo[18026]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 27 09:22:16 volumio sudo[18026]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:16 volumio sudo[18026]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:16 volumio volumio[18003]: info: Loading plugin "services"...
Jun 27 09:22:16 volumio sudo[18028]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 27 09:22:16 volumio sudo[18028]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:16 volumio volumio[18003]: info: Loading plugin "alsa_controller"...
Jun 27 09:22:16 volumio sudo[18031]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 27 09:22:16 volumio sudo[18031]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:16 volumio sudo[18028]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:16 volumio sudo[18031]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:16 volumio volumio[18003]: aplay: device_list:272: no soundcards found...
Jun 27 09:22:16 volumio volumio[18003]: warn: The ALSA output card is not set, defaulting to card null
Jun 27 09:22:16 volumio volumio[18003]: warn: Unable to locate the audio output device 没有可用的音频设备. Please configure a valid output device.
Jun 27 09:22:16 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 27 09:22:16 volumio volumio[18003]: info: Loading plugin "wizard"...
Jun 27 09:22:16 volumio volumio[18003]: info: Loading plugin "networkfs"...
Jun 27 09:22:16 volumio volumio[18003]: info: Starting Udev Watcher for removable devices
Jun 27 09:22:16 volumio volumio[18003]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:16 volumio volumio[18003]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:16 volumio volumio[18003]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:16 volumio volumio[18003]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:16 volumio volumio[18003]: info: Ignoring mount for partition: 92e52825-456f-44db-b8c7-8d07188bf1a3
Jun 27 09:22:16 volumio volumio[18003]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:16 volumio volumio[18003]: info: Mounting Device 46EA-FA68
Jun 27 09:22:16 volumio sudo[18041]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/46EA-FA68 -o ro,noatime,dmask=0000,fmask=0000,iocharset=utf8
Jun 27 09:22:16 volumio sudo[18041]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:16 volumio sudo[18041]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:16 volumio volumio[18003]: mount: /media/46EA-FA68: /dev/sda1 already mounted on /media/46EA-FA68.
Jun 27 09:22:16 volumio volumio[18003]: error: Failed to mount 46EA-FA68: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/46EA-FA68" -o ro,noatime,dmask=0000,fmask=0000,iocharset=utf8
Jun 27 09:22:16 volumio volumio[18003]: mount: /media/46EA-FA68: /dev/sda1 already mounted on /media/46EA-FA68.
Jun 27 09:22:16 volumio volumio[18003]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:16 volumio volumio[18003]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:16 volumio volumio[18003]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:16 volumio volumio[18003]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:16 volumio volumio[18003]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:16 volumio volumio[18003]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:16 volumio volumio[18003]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:16 volumio volumio[18003]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:16 volumio volumio[18003]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:16 volumio volumio[18003]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:16 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 27 09:22:16 volumio volumio[18003]: info: Loading plugin "volumio_command_line_client"...
Jun 27 09:22:16 volumio volumio[18003]: info: Loading plugin "upnp"...
Jun 27 09:22:16 volumio volumio[18003]: info: [1750987336939] Starting Upmpd Daemon
Jun 27 09:22:16 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 27 09:22:16 volumio volumio[18003]: info: Loading plugin "my_music"...
Jun 27 09:22:16 volumio volumio[18003]: info: Loading plugin "mpd"...
Jun 27 09:22:17 volumio volumio[18003]: info: Loading plugin "upnp_browser"...
Jun 27 09:22:18 volumio volumio[18003]: info: Loading plugin "alarm-clock"...
Jun 27 09:22:18 volumio volumio[18003]: info: Loading plugin "airplay_emulation"...
Jun 27 09:22:18 volumio volumio[18003]: info: Starting Shairport Sync
Jun 27 09:22:18 volumio volumio[18003]: info: Loading plugin "last_100"...
Jun 27 09:22:18 volumio volumio[18003]: info: Loading plugin "webradio"...
Jun 27 09:22:18 volumio volumio[18003]: info: Loading plugin "i2s_dacs"...
Jun 27 09:22:18 volumio volumio[18003]: info: I2S DAC not set, start Auto-detection
Jun 27 09:22:18 volumio volumio[18003]: info: Loading plugin "volumiodiscovery"...
Jun 27 09:22:18 volumio volumio[18003]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 27 09:22:18 volumio volumio[18003]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 27 09:22:18 volumio node[18003]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 27 09:22:18 volumio volumio[18003]: *** WARNING *** For more information see 
Jun 27 09:22:18 volumio volumio[18003]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 27 09:22:18 volumio volumio[18003]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 27 09:22:18 volumio volumio[18003]: *** WARNING *** For more information see 
Jun 27 09:22:18 volumio node[18003]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 27 09:22:18 volumio node[18003]: *** WARNING *** For more information see 
Jun 27 09:22:18 volumio node[18003]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 27 09:22:18 volumio node[18003]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 27 09:22:18 volumio node[18003]: *** WARNING *** For more information see 
Jun 27 09:22:18 volumio volumio[18003]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 27 09:22:18 volumio volumio[18003]: info: Discovery: Started advertising with name: Volumio
Jun 27 09:22:18 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 27 09:22:18 volumio volumio[18003]: info: Plugin autostart is not enabled
Jun 27 09:22:18 volumio volumio[18003]: info: Plugin now_playing is not enabled
Jun 27 09:22:18 volumio volumio[18003]: info: Loading plugin "outputs"...
Jun 27 09:22:18 volumio volumio[18003]: info: Loading plugin "albumart"...
Jun 27 09:22:18 volumio volumio[18003]: info: Loading plugin "example_plugin"...
Jun 27 09:22:18 volumio volumio[18003]: info: Loading plugin "inputs"...
Jun 27 09:22:18 volumio volumio[18003]: info: Loading plugin "updater_comm"...
Jun 27 09:22:19 volumio volumio[18003]: info: Plugin mpdemulation is not enabled
Jun 27 09:22:19 volumio volumio[18003]: info: Loading plugin "rest_api"...
Jun 27 09:22:19 volumio volumio[18003]: info: Loading plugin "websocket"...
Jun 27 09:22:19 volumio volumio[18003]: info: Starting Socket.io Server version 2.3.0
Jun 27 09:22:19 volumio volumio[18003]: info: Plugin fusiondsp is not enabled
Jun 27 09:22:19 volumio volumio[18003]: info: Plugin rad357pl is not enabled
Jun 27 09:22:19 volumio volumio[18003]: info: Plugin rad666pl is not enabled
Jun 27 09:22:19 volumio volumio[18003]: info: Plugin smart_inputs is not enabled
Jun 27 09:22:19 volumio volumio[18003]: info: Plugin touch_display is not enabled
Jun 27 09:22:19 volumio volumio[18003]: info: Loading i18n strings for locale zh
Jun 27 09:22:19 volumio volumio[18003]: Updating browse sources language
Jun 27 09:22:19 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 09:22:19 volumio volumio[18003]: Forking 3 albumart workers
Jun 27 09:22:19 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 27 09:22:19 volumio volumio[18003]: info: CoreCommandRouter::initPlayerControls
Jun 27 09:22:19 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:19 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:19 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:19 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:19 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:19 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:19 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:19 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:19 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 27 09:22:19 volumio volumio[18003]: Express server listening on port 3000
Jun 27 09:22:19 volumio volumio[18003]:  [Metrics]  WebUI:  8s 75.48ms 
Jun 27 09:22:19 volumio volumio[18003]: info: CoreStateMachine::resetVolumioState
Jun 27 09:22:20 volumio volumio[18003]: info: CoreStateMachine::getcurrentVolume
Jun 27 09:22:20 volumio volumio[18003]: info: CoreCommandRouter::volumioRetrievevolume
Jun 27 09:22:20 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:20 volumio volumio[18003]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Jun 27 09:22:20 volumio volumio[18003]: info: Completed loading Core Plugins
Jun 27 09:22:20 volumio volumio[18003]: info: Preparing to generate the ALSA configuration file
Jun 27 09:22:20 volumio volumio[18003]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 27 09:22:20 volumio volumio[18003]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Jun 27 09:22:20 volumio volumio[18003]: wlan0     Interface doesn't support scanning.
Jun 27 09:22:20 volumio volumio[18003]: info: Cannot use regular scanning, forcing with ap-force
Jun 27 09:22:20 volumio sudo[18088]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Jun 27 09:22:20 volumio sudo[18088]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:20 volumio sudo[18088]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:20 volumio volumio[18003]: command failed: No such device (-19)
Jun 27 09:22:20 volumio volumio[18003]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Jun 27 09:22:20 volumio volumio[18003]: command failed: No such device (-19)
Jun 27 09:22:20 volumio volumio[18003]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Jun 27 09:22:20 volumio volumio[18003]: verbose: New Socket.io Connection to 10.0.0.110 from 10.0.0.185 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Jun 27 09:22:20 volumio volumio[18003]: verbose: New Socket.io Connection to 10.0.0.110 from 10.0.0.185 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2
Jun 27 09:22:20 volumio volumio[18003]: verbose: New Socket.io Connection to 10.0.0.110 from 10.0.0.185 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Jun 27 09:22:20 volumio volumio[18003]: info: VolumeController:: Volume=undefined Mute =false
Jun 27 09:22:20 volumio volumio[18003]: info: CoreStateMachine::pushState
Jun 27 09:22:20 volumio volumio[18003]: info: CorePlayQueue::getTrack 0
Jun 27 09:22:20 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 27 09:22:20 volumio volumio[18003]: info: CoreCommandRouter::volumioPushState
Jun 27 09:22:20 volumio volumio[18003]: info: CoreStateMachine::updateTrackBlock
Jun 27 09:22:20 volumio volumio[18003]: info: CorePlayQueue::getTrackBlock
Jun 27 09:22:20 volumio volumio[18003]: info: CoreCommandRouter::volumioRetrievevolume
Jun 27 09:22:20 volumio volumio[18003]: info: Reloading queue from file
Jun 27 09:22:20 volumio volumio[18003]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 27 09:22:20 volumio volumio[18003]: info: Asound.conf file unchanged, so no further update is needed
Jun 27 09:22:20 volumio volumio[18003]: info: Output device has changed, restarting MPD
Jun 27 09:22:21 volumio volumio[18003]: info: Output device has changed, restarting Shairport Sync
Jun 27 09:22:21 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:21 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:21 volumio sudo[18099]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 27 09:22:21 volumio sudo[18099]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:21 volumio sudo[18099]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:21 volumio sudo[18101]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 27 09:22:21 volumio volumio[18003]: aplay: device_list:272: no soundcards found...
Jun 27 09:22:21 volumio volumio[18003]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 27 09:22:21 volumio volumio[18003]: aplay: device_list:272: no soundcards found...
Jun 27 09:22:21 volumio sudo[18101]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:21 volumio volumio[18003]: info: ___________ START PLUGINS ___________
Jun 27 09:22:21 volumio volumio[18003]: info: ControllerMpd::onStart: Initializing MPD
Jun 27 09:22:21 volumio volumio[18003]: info: Creating MPD Configuration file
Jun 27 09:22:21 volumio systemd[1]: Stopping Music Player Daemon...
Jun 27 09:22:21 volumio sudo[18108]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 27 09:22:21 volumio systemd[1]: mpd.service: Succeeded.
Jun 27 09:22:21 volumio sudo[18108]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:21 volumio systemd[1]: Stopped Music Player Daemon.
Jun 27 09:22:21 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 27 09:22:21 volumio volumio[18003]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 27 09:22:21 volumio volumio[18003]: info: [1750987341337] CoreMusicLibrary::Adding element 媒体服务器
Jun 27 09:22:21 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 09:22:21 volumio systemd[1]: Starting Music Player Daemon...
Jun 27 09:22:21 volumio sudo[18108]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:21 volumio sudo[18110]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 27 09:22:21 volumio sudo[18110]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:21 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Jun 27 09:22:21 volumio sudo[18114]:  volumio : TTY=ttyFIQ0 ; PWD=/volumio ; USER=root ; COMMAND=/bin/systemctl restart volumio.service
Jun 27 09:22:21 volumio systemd[1]: mpd.service: Succeeded.
Jun 27 09:22:21 volumio sudo[18114]: pam_unix(sudo:session): session opened for user root by volumio(uid=0)
Jun 27 09:22:21 volumio systemd[1]: Stopped Music Player Daemon.
Jun 27 09:22:21 volumio systemd[1]: Starting Music Player Daemon...
Jun 27 09:22:21 volumio volumio[18003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:21 volumio systemd[1]: Stopping Volumio Backend Module...
Jun 27 09:22:21 volumio sudo[18101]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:21 volumio sudo[18110]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:21 volumio systemd[1]: volumio.service: Main process exited, code=killed, status=15/TERM
Jun 27 09:22:21 volumio systemd[1]: volumio.service: Succeeded.
Jun 27 09:22:21 volumio systemd[1]: Stopped Volumio Backend Module.
Jun 27 09:22:21 volumio systemd[1]: Started Volumio Backend Module.
Jun 27 09:22:21 volumio sudo[18114]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:21 volumio sudo[18116]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 27 09:22:21 volumio sudo[18116]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:21 volumio sudo[18116]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:25 volumio volumio[18119]: info: -------------------------------------------
Jun 27 09:22:25 volumio volumio[18119]: info: -----            Volumio3              ----
Jun 27 09:22:25 volumio volumio[18119]: info: -------------------------------------------
Jun 27 09:22:25 volumio volumio[18119]: info: -----          System startup          ----
Jun 27 09:22:25 volumio volumio[18119]: info: -------------------------------------------
Jun 27 09:22:25 volumio mpd[18126]: Jun 27 09:22 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 27 09:22:25 volumio systemd[1]: Started Music Player Daemon.
Jun 27 09:22:26 volumio volumio[18119]: info: MYVOLUMIO Environment detected
Jun 27 09:22:26 volumio volumio[18119]: info: Plugin folders cleanup
Jun 27 09:22:26 volumio volumio[18119]: info: Scanning into folder /volumio/app/plugins/
Jun 27 09:22:26 volumio volumio[18119]: info: Scanning category audio_interface
Jun 27 09:22:26 volumio volumio[18119]: info: Scanning category miscellanea
Jun 27 09:22:26 volumio volumio[18119]: info: Scanning category music_service
Jun 27 09:22:26 volumio volumio[18119]: info: Scanning category plugins.json
Jun 27 09:22:26 volumio volumio[18119]: info: Scanning category system_controller
Jun 27 09:22:26 volumio volumio[18119]: info: Scanning category user_interface
Jun 27 09:22:26 volumio volumio[18119]: info: Scanning into folder /data/plugins/
Jun 27 09:22:26 volumio volumio[18119]: info: Scanning category audio_interface
Jun 27 09:22:26 volumio volumio[18119]: info: Scanning category music_service
Jun 27 09:22:26 volumio volumio[18119]: info: Scanning category system_controller
Jun 27 09:22:26 volumio volumio[18119]: info: Scanning category user_interface
Jun 27 09:22:26 volumio volumio[18119]: info: Plugin folders cleanup completed
Jun 27 09:22:26 volumio volumio[18119]: info: -------------------------------------------
Jun 27 09:22:26 volumio volumio[18119]: info: -----      Core plugins startup        ----
Jun 27 09:22:26 volumio volumio[18119]: info: -------------------------------------------
Jun 27 09:22:26 volumio volumio[18119]: info: Loading plugins from folder /volumio/app/plugins/
Jun 27 09:22:26 volumio volumio[18119]: info: Adding plugin upnp to MyMusic Plugins
Jun 27 09:22:26 volumio volumio[18119]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 27 09:22:26 volumio volumio[18119]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 27 09:22:26 volumio volumio[18119]: info: Loading plugins from folder /data/plugins/
Jun 27 09:22:26 volumio volumio[18119]: info: Adding plugin smart_inputs to MyMusic Plugins
Jun 27 09:22:26 volumio volumio[18119]: info: Loading plugin "system"...
Jun 27 09:22:26 volumio volumio[18119]: info: No id defined. Creating one
Jun 27 09:22:26 volumio volumio[18119]: info: Loading plugin "appearance"...
Jun 27 09:22:26 volumio volumio-remote-updater[275]: [2025-06-27 09:22:26] [connect] Successful connection
Jun 27 09:22:28 volumio volumio[18119]: info: Loading plugin "network"...
Jun 27 09:22:28 volumio volumio[18119]: info: Refreshing Cached IP Addresses
Jun 27 09:22:28 volumio sudo[18147]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 27 09:22:28 volumio sudo[18147]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:28 volumio sudo[18147]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:28 volumio volumio[18119]: info: Loading plugin "services"...
Jun 27 09:22:28 volumio sudo[18149]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 27 09:22:28 volumio sudo[18149]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:28 volumio volumio[18119]: info: Loading plugin "alsa_controller"...
Jun 27 09:22:28 volumio sudo[18152]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 27 09:22:28 volumio sudo[18152]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:28 volumio sudo[18149]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:28 volumio sudo[18152]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:28 volumio volumio[18119]: aplay: device_list:272: no soundcards found...
Jun 27 09:22:28 volumio volumio[18119]: warn: The ALSA output card is not set, defaulting to card null
Jun 27 09:22:28 volumio volumio[18119]: warn: Unable to locate the audio output device 没有可用的音频设备. Please configure a valid output device.
Jun 27 09:22:28 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 27 09:22:28 volumio volumio[18119]: info: Loading plugin "wizard"...
Jun 27 09:22:28 volumio volumio[18119]: info: Loading plugin "networkfs"...
Jun 27 09:22:29 volumio volumio[18119]: info: Starting Udev Watcher for removable devices
Jun 27 09:22:29 volumio volumio[18119]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:29 volumio volumio[18119]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:29 volumio volumio[18119]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:29 volumio volumio[18119]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:29 volumio volumio[18119]: info: Ignoring mount for partition: 92e52825-456f-44db-b8c7-8d07188bf1a3
Jun 27 09:22:29 volumio volumio[18119]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:29 volumio volumio[18119]: info: Mounting Device 46EA-FA68
Jun 27 09:22:29 volumio sudo[18162]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/46EA-FA68 -o ro,noatime,dmask=0000,fmask=0000,iocharset=utf8
Jun 27 09:22:29 volumio sudo[18162]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:29 volumio sudo[18162]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:29 volumio volumio[18119]: mount: /media/46EA-FA68: /dev/sda1 already mounted on /media/46EA-FA68.
Jun 27 09:22:29 volumio volumio[18119]: error: Failed to mount 46EA-FA68: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/46EA-FA68" -o ro,noatime,dmask=0000,fmask=0000,iocharset=utf8
Jun 27 09:22:29 volumio volumio[18119]: mount: /media/46EA-FA68: /dev/sda1 already mounted on /media/46EA-FA68.
Jun 27 09:22:29 volumio volumio[18119]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:29 volumio volumio[18119]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:29 volumio volumio[18119]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:29 volumio volumio[18119]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:29 volumio volumio[18119]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:29 volumio volumio[18119]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:29 volumio volumio[18119]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:29 volumio volumio[18119]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:29 volumio volumio[18119]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:29 volumio volumio[18119]: error: Cannot associate FS Label, not mounting
Jun 27 09:22:29 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 27 09:22:29 volumio volumio[18119]: info: Loading plugin "volumio_command_line_client"...
Jun 27 09:22:29 volumio volumio[18119]: info: Loading plugin "upnp"...
Jun 27 09:22:29 volumio volumio[18119]: info: [1750987349234] Starting Upmpd Daemon
Jun 27 09:22:29 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 27 09:22:29 volumio volumio[18119]: info: Loading plugin "my_music"...
Jun 27 09:22:29 volumio volumio[18119]: info: Loading plugin "mpd"...
Jun 27 09:22:29 volumio volumio[18119]: info: Loading plugin "upnp_browser"...
Jun 27 09:22:30 volumio volumio[18119]: info: Loading plugin "alarm-clock"...
Jun 27 09:22:30 volumio volumio[18119]: info: Loading plugin "airplay_emulation"...
Jun 27 09:22:30 volumio volumio[18119]: info: Starting Shairport Sync
Jun 27 09:22:30 volumio volumio[18119]: info: Loading plugin "last_100"...
Jun 27 09:22:30 volumio volumio[18119]: info: Loading plugin "webradio"...
Jun 27 09:22:31 volumio volumio[18119]: info: Loading plugin "i2s_dacs"...
Jun 27 09:22:31 volumio volumio[18119]: info: I2S DAC not set, start Auto-detection
Jun 27 09:22:31 volumio volumio[18119]: info: Loading plugin "volumiodiscovery"...
Jun 27 09:22:31 volumio volumio[18119]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 27 09:22:31 volumio volumio[18119]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 27 09:22:31 volumio node[18119]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 27 09:22:31 volumio volumio[18119]: *** WARNING *** For more information see 
Jun 27 09:22:31 volumio volumio[18119]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 27 09:22:31 volumio volumio[18119]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 27 09:22:31 volumio volumio[18119]: *** WARNING *** For more information see 
Jun 27 09:22:31 volumio node[18119]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 27 09:22:31 volumio node[18119]: *** WARNING *** For more information see 
Jun 27 09:22:31 volumio node[18119]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 27 09:22:31 volumio node[18119]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 27 09:22:31 volumio node[18119]: *** WARNING *** For more information see 
Jun 27 09:22:31 volumio volumio[18119]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 27 09:22:31 volumio volumio[18119]: info: Discovery: Started advertising with name: Volumio
Jun 27 09:22:31 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 27 09:22:31 volumio volumio[18119]: info: Plugin autostart is not enabled
Jun 27 09:22:31 volumio volumio[18119]: info: Plugin now_playing is not enabled
Jun 27 09:22:31 volumio volumio[18119]: info: Loading plugin "outputs"...
Jun 27 09:22:31 volumio volumio[18119]: info: Loading plugin "albumart"...
Jun 27 09:22:31 volumio volumio[18119]: info: Loading plugin "example_plugin"...
Jun 27 09:22:31 volumio volumio[18119]: info: Loading plugin "inputs"...
Jun 27 09:22:31 volumio volumio[18119]: info: Loading plugin "updater_comm"...
Jun 27 09:22:31 volumio volumio[18119]: info: Plugin mpdemulation is not enabled
Jun 27 09:22:31 volumio volumio[18119]: info: Loading plugin "rest_api"...
Jun 27 09:22:31 volumio volumio[18119]: info: Loading plugin "websocket"...
Jun 27 09:22:31 volumio volumio[18119]: info: Starting Socket.io Server version 2.3.0
Jun 27 09:22:31 volumio volumio[18119]: info: Plugin fusiondsp is not enabled
Jun 27 09:22:31 volumio volumio[18119]: info: Plugin rad357pl is not enabled
Jun 27 09:22:31 volumio volumio[18119]: info: Plugin rad666pl is not enabled
Jun 27 09:22:31 volumio volumio[18119]: info: Plugin smart_inputs is not enabled
Jun 27 09:22:31 volumio volumio[18119]: info: Plugin touch_display is not enabled
Jun 27 09:22:31 volumio volumio[18119]: info: Loading i18n strings for locale zh
Jun 27 09:22:31 volumio volumio[18119]: Updating browse sources language
Jun 27 09:22:31 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 09:22:32 volumio volumio[18119]: Forking 3 albumart workers
Jun 27 09:22:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 27 09:22:32 volumio volumio[18119]: info: CoreCommandRouter::initPlayerControls
Jun 27 09:22:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 27 09:22:32 volumio volumio[18119]: Express server listening on port 3000
Jun 27 09:22:32 volumio volumio[18119]:  [Metrics]  WebUI:  8s 41.39ms 
Jun 27 09:22:32 volumio volumio[18119]: info: CoreStateMachine::resetVolumioState
Jun 27 09:22:32 volumio volumio[18119]: info: CoreStateMachine::getcurrentVolume
Jun 27 09:22:32 volumio volumio[18119]: info: CoreCommandRouter::volumioRetrievevolume
Jun 27 09:22:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:32 volumio volumio[18119]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Jun 27 09:22:32 volumio volumio[18119]: info: Completed loading Core Plugins
Jun 27 09:22:32 volumio volumio[18119]: info: Preparing to generate the ALSA configuration file
Jun 27 09:22:32 volumio volumio[18119]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 27 09:22:32 volumio volumio[18119]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Jun 27 09:22:32 volumio volumio[18119]: wlan0     Interface doesn't support scanning.
Jun 27 09:22:32 volumio volumio[18119]: info: Cannot use regular scanning, forcing with ap-force
Jun 27 09:22:32 volumio sudo[18209]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Jun 27 09:22:32 volumio sudo[18209]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:32 volumio sudo[18209]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:32 volumio volumio[18119]: command failed: No such device (-19)
Jun 27 09:22:32 volumio volumio[18119]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Jun 27 09:22:32 volumio volumio[18119]: command failed: No such device (-19)
Jun 27 09:22:32 volumio volumio[18119]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Jun 27 09:22:32 volumio volumio[18119]: verbose: New Socket.io Connection to 10.0.0.110 from 10.0.0.185 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Jun 27 09:22:32 volumio volumio[18119]: verbose: New Socket.io Connection to 10.0.0.110 from 10.0.0.185 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2
Jun 27 09:22:32 volumio volumio[18119]: info: VolumeController:: Volume=undefined Mute =false
Jun 27 09:22:32 volumio volumio[18119]: info: CoreStateMachine::pushState
Jun 27 09:22:32 volumio volumio[18119]: info: CorePlayQueue::getTrack 0
Jun 27 09:22:33 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 27 09:22:33 volumio volumio[18119]: info: CoreCommandRouter::volumioPushState
Jun 27 09:22:33 volumio volumio[18119]: info: CoreStateMachine::updateTrackBlock
Jun 27 09:22:33 volumio volumio[18119]: info: CorePlayQueue::getTrackBlock
Jun 27 09:22:33 volumio volumio[18119]: info: CoreCommandRouter::volumioRetrievevolume
Jun 27 09:22:33 volumio volumio[18119]: info: Reloading queue from file
Jun 27 09:22:33 volumio volumio[18119]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 27 09:22:33 volumio volumio[18119]: info: Asound.conf file unchanged, so no further update is needed
Jun 27 09:22:33 volumio volumio[18119]: info: Output device has changed, restarting MPD
Jun 27 09:22:33 volumio volumio[18119]: info: Output device has changed, restarting Shairport Sync
Jun 27 09:22:33 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:33 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:33 volumio sudo[18221]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 27 09:22:33 volumio sudo[18221]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:33 volumio sudo[18221]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:33 volumio sudo[18222]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 27 09:22:33 volumio sudo[18222]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:33 volumio volumio[18119]: aplay: device_list:272: no soundcards found...
Jun 27 09:22:33 volumio volumio[18119]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 27 09:22:33 volumio volumio[18119]: aplay: device_list:272: no soundcards found...
Jun 27 09:22:33 volumio volumio[18119]: info: ___________ START PLUGINS ___________
Jun 27 09:22:33 volumio systemd[1]: Stopping Music Player Daemon...
Jun 27 09:22:33 volumio systemd[1]: mpd.service: Succeeded.
Jun 27 09:22:33 volumio systemd[1]: Stopped Music Player Daemon.
Jun 27 09:22:33 volumio volumio[18119]: info: Setting Hotspot Unique name on first start: Volumio-65035
Jun 27 09:22:33 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: network , getConfigParam
Jun 27 09:22:33 volumio volumio[18119]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getConfigParam] in plugin network
Jun 27 09:22:33 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings
Jun 27 09:22:33 volumio volumio[18119]: info: CoreCommandRouter::Reload Ui
Jun 27 09:22:33 volumio systemd[1]: Starting Music Player Daemon...
Jun 27 09:22:33 volumio volumio[18119]: info: ControllerMpd::onStart: Initializing MPD
Jun 27 09:22:33 volumio volumio[18119]: info: Creating MPD Configuration file
Jun 27 09:22:33 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 27 09:22:33 volumio volumio[18119]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 27 09:22:33 volumio volumio[18119]: info: [1750987353731] CoreMusicLibrary::Adding element 媒体服务器
Jun 27 09:22:33 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 09:22:33 volumio sudo[18232]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 27 09:22:33 volumio sudo[18232]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:33 volumio sudo[18232]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:33 volumio sudo[18234]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 27 09:22:33 volumio sudo[18234]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:33 volumio sudo[18230]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 27 09:22:33 volumio sudo[18230]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:33 volumio sudo[18230]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:33 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:33 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:33 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jun 27 09:22:33 volumio systemd[1]: mpd.service: Succeeded.
Jun 27 09:22:33 volumio systemd[1]: Stopped Music Player Daemon.
Jun 27 09:22:33 volumio systemd[1]: Starting Music Player Daemon...
Jun 27 09:22:34 volumio volumio[18119]: aplay: device_list:272: no soundcards found...
Jun 27 09:22:34 volumio volumio[18119]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 27 09:22:34 volumio volumio[18119]: aplay: device_list:272: no soundcards found...
Jun 27 09:22:34 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:34 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:34 volumio volumio[18119]: Starting albumart workers
Jun 27 09:22:34 volumio volumio[18119]: Starting albumart workers
Jun 27 09:22:34 volumio volumio[18119]: aplay: device_list:272: no soundcards found...
Jun 27 09:22:34 volumio volumio[18119]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 27 09:22:34 volumio volumio[18119]: aplay: device_list:272: no soundcards found...
Jun 27 09:22:34 volumio volumio[18119]: Starting albumart workers
Jun 27 09:22:34 volumio volumio[18119]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 27 09:22:34 volumio volumio[18119]: info: [1750987354141] CoreMusicLibrary::Adding element Last_100
Jun 27 09:22:34 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 09:22:34 volumio volumio[18119]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 27 09:22:34 volumio volumio[18119]: info: [1750987354149] CoreMusicLibrary::Adding element Webradio
Jun 27 09:22:34 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 09:22:34 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 27 09:22:34 volumio volumio[18119]: info: Initializing BBC Radios
Jun 27 09:22:34 volumio sudo[18239]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 27 09:22:34 volumio sudo[18239]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:34 volumio sudo[18239]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:34 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 27 09:22:34 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:34 volumio volumio[18119]: error: Plugin example_plugin failed to start! TypeError: Cannot read property 'volumioAddToBrowseSources' of undefined
Jun 27 09:22:34 volumio volumio[18119]: info: Volumio Calling Home
Jun 27 09:22:35 volumio volumio[18119]: info: CoreStateMachine::setRepeat false single undefined
Jun 27 09:22:35 volumio volumio[18119]: info: CoreStateMachine::pushState
Jun 27 09:22:35 volumio volumio[18119]: info: CorePlayQueue::getTrack 0
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::volumioPushState
Jun 27 09:22:35 volumio volumio[18119]: info: CoreStateMachine::setRandom false
Jun 27 09:22:35 volumio volumio[18119]: info: CoreStateMachine::pushState
Jun 27 09:22:35 volumio volumio[18119]: info: CorePlayQueue::getTrack 0
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::volumioPushState
Jun 27 09:22:35 volumio volumio[18119]: info: MPD Permissions set
Jun 27 09:22:35 volumio volumio[18119]: info: MPD Permissions set
Jun 27 09:22:35 volumio volumio[18119]: info: VolumeController:: Volume=undefined Mute =false
Jun 27 09:22:35 volumio sudo[18279]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf
Jun 27 09:22:35 volumio volumio[18119]: info: CoreStateMachine::pushState
Jun 27 09:22:35 volumio volumio[18119]: info: CorePlayQueue::getTrack 0
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::volumioPushState
Jun 27 09:22:35 volumio sudo[18279]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:35 volumio sudo[18279]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:35 volumio volumio[18119]: info: Discovery: adding undefined
Jun 27 09:22:35 volumio volumio[18119]: info: Discovery: Found device Volumio
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::volumioGetState
Jun 27 09:22:35 volumio volumio[18119]: info: CorePlayQueue::getTrack 0
Jun 27 09:22:35 volumio volumio[18119]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Jun 27 09:22:35 volumio volumio[18119]: info: Permissions for /etc/hostapd/hostapd.conf
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart
Jun 27 09:22:35 volumio volumio[18119]: info: Discovery: Restarting Advertising due to device name change
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio sudo[18294]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service
Jun 27 09:22:35 volumio sudo[18294]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jun 27 09:22:35 volumio systemd[1]: Starting Wireless Services...
Jun 27 09:22:35 volumio rfkill[18300]: block set for type wifi
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:35 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:22:36 volumio volumio[18119]: info: Volumio called home
Jun 27 09:22:36 volumio volumio[18119]: verbose: New Socket.io Connection to 10.0.0.110 from 10.0.0.185 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 27 09:22:36 volumio volumio[18119]: info: Starting Shairport Sync
Jun 27 09:22:36 volumio volumio[18119]: info: Starting Shairport Sync
Jun 27 09:22:36 volumio volumio[18119]: info: Starting Shairport Sync
Jun 27 09:22:36 volumio sudo[18312]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 27 09:22:36 volumio sudo[18312]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:36 volumio sudo[18314]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 27 09:22:36 volumio sudo[18314]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 27 09:22:36 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 27 09:22:36 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 27 09:22:36 volumio volumio[18119]: info: Received Get System Info
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 27 09:22:36 volumio volumio[18119]: info: Discovery: Getting this device information
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::volumioGetState
Jun 27 09:22:36 volumio volumio[18119]: info: CorePlayQueue::getTrack 0
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 09:22:36 volumio sudo[18318]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 27 09:22:36 volumio sudo[18318]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::volumioGetState
Jun 27 09:22:36 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 27 09:22:36 volumio volumio[18119]: info: CorePlayQueue::getTrack 0
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 27 09:22:36 volumio sudo[18312]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:36 volumio volumio[18119]: info: Received Get System Info
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 27 09:22:36 volumio volumio[18119]: info: Discovery: Getting this device information
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::volumioGetState
Jun 27 09:22:36 volumio volumio[18119]: info: CorePlayQueue::getTrack 0
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::volumioGetState
Jun 27 09:22:36 volumio volumio[18119]: info: CorePlayQueue::getTrack 0
Jun 27 09:22:36 volumio volumio[18119]: info: Listing playlists
Jun 27 09:22:36 volumio sudo[18314]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 27 09:22:36 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Jun 27 09:22:36 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 27 09:22:36 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 27 09:22:36 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 27 09:22:36 volumio volumio[18119]: info: CoreCommandRouter::volumioGetState
Jun 27 09:22:36 volumio volumio[18119]: info: CorePlayQueue::getTrack 0
Jun 27 09:22:36 volumio sudo[18318]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:36 volumio volumio[18119]: info: Shairport-Sync Started
Jun 27 09:22:36 volumio volumio[18119]: Error adding Membership: Error: addMembership EINVAL
Jun 27 09:22:36 volumio volumio[18119]: info: Shairport-Sync Started
Jun 27 09:22:36 volumio volumio[18119]: info: Shairport-Sync Started
Jun 27 09:22:36 volumio volumio[18119]: info: Discovery: A device disappeared from network
Jun 27 09:22:36 volumio volumio[18119]: info: Discovery: Device volumio disappeared from network
Jun 27 09:22:37 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Jun 27 09:22:37 volumio mpd[18250]: Jun 27 09:22 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 27 09:22:37 volumio systemd[1]: Started Music Player Daemon.
Jun 27 09:22:37 volumio sudo[18234]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:37 volumio sudo[18222]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:38 volumio volumio[18119]: info: Completed starting Core Plugins
Jun 27 09:22:38 volumio volumio[18119]: info: -------------------------------------------
Jun 27 09:22:38 volumio volumio[18119]: info: -----    MyVolumio plugins startup     ----
Jun 27 09:22:38 volumio volumio[18119]: info: -------------------------------------------
Jun 27 09:22:38 volumio volumio[18119]: info: [MyVolumio PluginManager] Fetching plans data....
Jun 27 09:22:38 volumio volumio[18119]: error: MPD error: The expression evaluated to a falsy value:
Jun 27 09:22:38 volumio volumio[18119]:   assert.ok(self.idling)
Jun 27 09:22:38 volumio volumio[18119]: error: The expression evaluated to a falsy value:
Jun 27 09:22:38 volumio volumio[18119]:   assert.ok(self.idling)
Jun 27 09:22:38 volumio volumio[18119]: error: updateQueue error: null
Jun 27 09:22:38 volumio volumio[18119]: info: MPD running with PID18250
Jun 27 09:22:38 volumio volumio[18119]:  ,establishing connection
Jun 27 09:22:38 volumio volumio[18119]: error: updateQueue error: null
Jun 27 09:22:39 volumio wireless.js[18328]: WIRELESS: No wireless interface, exiting
Jun 27 09:22:39 volumio rfkill[18343]: unblock set for type wifi
Jun 27 09:22:39 volumio systemd[1]: wireless.service: Succeeded.
Jun 27 09:22:39 volumio systemd[1]: Started Wireless Services.
Jun 27 09:22:39 volumio sudo[18294]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:39 volumio sudo[18345]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 27 09:22:39 volumio sudo[18345]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:39 volumio sudo[18345]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:39 volumio sudo[18347]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 27 09:22:39 volumio sudo[18347]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:39 volumio sudo[18350]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jun 27 09:22:39 volumio sudo[18350]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:39 volumio sudo[18347]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:39 volumio sudo[18350]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:39 volumio volumio[18119]: info: Upmpdcli Daemon Started
Jun 27 09:22:40 volumio volumio[18119]: info: Discovery: Started advertising with name: Volumio
Jun 27 09:22:41 volumio volumio[18119]: info: Discovery: adding undefined
Jun 27 09:22:41 volumio volumio[18119]: info: Discovery: Found device Volumio
Jun 27 09:22:41 volumio volumio[18119]: info: CoreCommandRouter::volumioGetState
Jun 27 09:22:41 volumio volumio[18119]: info: CorePlayQueue::getTrack 0
Jun 27 09:22:41 volumio volumio-remote-updater[275]: [2025-06-27 09:22:41] [connect] Successful connection
Jun 27 09:22:41 volumio volumio-remote-updater[275]: [2025-06-27 09:22:41] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1750987361 101
Jun 27 09:22:41 volumio volumio[18119]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 5
Jun 27 09:22:44 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection
Jun 27 09:22:44 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo
Jun 27 09:22:44 volumio sudo[18358]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 27 09:22:44 volumio sudo[18358]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:44 volumio sudo[18358]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:46 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Jun 27 09:22:46 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Jun 27 09:22:46 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Jun 27 09:22:46 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Jun 27 09:22:46 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Jun 27 09:22:46 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Jun 27 09:22:46 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Jun 27 09:22:46 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Jun 27 09:22:46 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Jun 27 09:22:46 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Jun 27 09:22:47 volumio volumio[18119]: info: Adding plugin bluetooth to MyMusic Plugins
Jun 27 09:22:47 volumio volumio[18119]: info: Adding plugin multiroom to MyMusic Plugins
Jun 27 09:22:47 volumio volumio[18119]: info: Adding plugin metavolumio to MyMusic Plugins
Jun 27 09:22:47 volumio volumio[18119]: info: Adding plugin smart_inputs to MyMusic Plugins
Jun 27 09:22:47 volumio volumio[18119]: info: Adding plugin tidalconnect to MyMusic Plugins
Jun 27 09:22:47 volumio volumio[18119]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Jun 27 09:22:48 volumio volumio[18119]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Jun 27 09:22:48 volumio volumio[18119]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Jun 27 09:22:48 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:48 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:48 volumio volumio[18119]: info: Starting MyVolumio Remote Streaming Endpoints
Jun 27 09:22:48 volumio volumio[18119]: info: MyVolumio login type: Token
Jun 27 09:22:48 volumio volumio[18119]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Jun 27 09:22:48 volumio volumio[18119]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Jun 27 09:22:50 volumio volumio[18119]: info: Starting Streaming Service Transparent Proxy
Jun 27 09:22:50 volumio volumio[18119]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Jun 27 09:22:50 volumio volumio[18119]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Jun 27 09:22:50 volumio volumio[18119]: info: Streaming services startup
Jun 27 09:22:50 volumio volumio[18119]: info: Starting Streaming Daemon
Jun 27 09:22:50 volumio sudo[18371]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jun 27 09:22:50 volumio sudo[18371]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:50 volumio sudo[18371]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:50 volumio volumio[18119]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Jun 27 09:22:51 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart
Jun 27 09:22:51 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart
Jun 27 09:22:51 volumio volumio[18119]: info: Refreshing Cached IP Addresses
Jun 27 09:22:51 volumio sudo[18379]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli
Jun 27 09:22:51 volumio sudo[18379]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:51 volumio sudo[18381]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 27 09:22:51 volumio sudo[18381]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:51 volumio systemd[1]: upmpdcli.service: Succeeded.
Jun 27 09:22:51 volumio sudo[18379]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:51 volumio sudo[18381]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:51 volumio sudo[18385]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 27 09:22:51 volumio sudo[18385]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:51 volumio volumio[18119]: error: Cannot start Volumio Streaming Daemon
Jun 27 09:22:51 volumio volumio[18119]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jun 27 09:22:51 volumio volumio[18119]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jun 27 09:22:51 volumio sudo[18385]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:52 volumio volumio[18119]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Jun 27 09:22:53 volumio volumio[18119]: STREAMING PROXY: Starting server on port 3245
Jun 27 09:22:53 volumio volumio[18119]: Node JS runtime: 14
Jun 27 09:22:53 volumio volumio[18119]: info: MyVolumio token set successfully
Jun 27 09:22:53 volumio volumio[18119]: info: MYVOLUMIO: Adding device
Jun 27 09:22:53 volumio volumio[18119]: info: MYVOLUMIO: Evaluating Server
Jun 27 09:22:53 volumio volumio[18119]: info: MyVolumio status changed
Jun 27 09:22:53 volumio volumio[18119]: info: Streaming services startup
Jun 27 09:22:53 volumio volumio[18119]: info: Starting Streaming Daemon
Jun 27 09:22:53 volumio volumio[18119]: info: Removing browser output: myVolumio user plan is not superstar
Jun 27 09:22:53 volumio volumio[18119]: info: Removing audio output:
Jun 27 09:22:53 volumio volumio[18119]: info: Stoppping Tunnel 1
Jun 27 09:22:53 volumio sudo[18419]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jun 27 09:22:53 volumio sudo[18419]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:53 volumio sudo[18419]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:53 volumio sudo[18422]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Jun 27 09:22:53 volumio sudo[18422]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:22:53 volumio sudo[18422]: pam_unix(sudo:session): session closed for user root
Jun 27 09:22:54 volumio volumio[18119]: error: Failed to ping endpoint eu2.myvolumio.org : unknown error
Jun 27 09:22:54 volumio volumio[18119]: error: Failed to ping endpoint eu3.myvolumio.org : unknown error
Jun 27 09:22:54 volumio volumio[18119]: error: Failed to ping endpoint eu4.myvolumio.org : unknown error
Jun 27 09:22:54 volumio volumio[18119]: error: Failed to ping endpoint eu5.myvolumio.org : unknown error
Jun 27 09:22:54 volumio volumio[18119]: error: Failed to ping endpoint eu6.myvolumio.org : unknown error
Jun 27 09:22:54 volumio volumio[18119]: error: Failed to ping endpoint eu7.myvolumio.org : unknown error
Jun 27 09:22:54 volumio volumio[18119]: error: Failed to ping endpoint eu8.myvolumio.org : unknown error
Jun 27 09:22:54 volumio volumio[18119]: error: Failed to ping endpoint eu9.myvolumio.org : unknown error
Jun 27 09:22:54 volumio volumio[18119]: error: Failed to ping endpoint eu10.myvolumio.org : unknown error
Jun 27 09:22:54 volumio volumio[18119]: error: Failed to ping endpoint us1.myvolumio.org : unknown error
Jun 27 09:22:54 volumio volumio[18119]: error: Failed to ping endpoint us2.myvolumio.org : unknown error
Jun 27 09:22:54 volumio volumio[18119]: error: Failed to ping endpoint us3.myvolumio.org : unknown error
Jun 27 09:22:54 volumio volumio[18119]: error: Failed to ping endpoint as1.myvolumio.org : unknown error
Jun 27 09:22:54 volumio volumio[18119]: error: Failed to ping endpoint as2.myvolumio.org : unknown error
Jun 27 09:22:54 volumio volumio[18119]: info: Remote SSH Stopped
Jun 27 09:22:54 volumio volumio[18119]: error: Cannot start Volumio Streaming Daemon
Jun 27 09:22:54 volumio volumio[18119]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jun 27 09:22:54 volumio volumio[18119]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jun 27 09:22:54 volumio volumio[18119]: error: Failed to ping endpoint au1.myvolumio.org : unknown error
Jun 27 09:22:54 volumio volumio[18119]: info: Setting Geolocation for MyVolumio to eu2
Jun 27 09:22:54 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:54 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:54 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:55 volumio volumio[18119]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Jun 27 09:22:55 volumio volumio[18119]: info: Updating MyVolumio device info
Jun 27 09:22:55 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:55 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:55 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:22:56 volumio volumio[18119]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Jun 27 09:22:59 volumio volumio[18119]: info: MYVOLUMIO: Adding device
Jun 27 09:22:59 volumio volumio[18119]: info: MYVOLUMIO: Evaluating Server
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to ping endpoint eu2.myvolumio.org : unknown error
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to ping endpoint eu3.myvolumio.org : unknown error
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to ping endpoint eu4.myvolumio.org : unknown error
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to ping endpoint eu5.myvolumio.org : unknown error
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to ping endpoint eu6.myvolumio.org : unknown error
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to ping endpoint eu7.myvolumio.org : unknown error
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to ping endpoint eu8.myvolumio.org : unknown error
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to ping endpoint eu9.myvolumio.org : unknown error
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to ping endpoint eu10.myvolumio.org : unknown error
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to ping endpoint us1.myvolumio.org : unknown error
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to ping endpoint us2.myvolumio.org : unknown error
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to ping endpoint us3.myvolumio.org : unknown error
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to ping endpoint as1.myvolumio.org : unknown error
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to ping endpoint as2.myvolumio.org : unknown error
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to ping endpoint au1.myvolumio.org : unknown error
Jun 27 09:23:00 volumio volumio[18119]: info: Setting Geolocation for MyVolumio to eu2
Jun 27 09:23:00 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:23:00 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:23:00 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:23:00 volumio volumio[18119]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Jun 27 09:23:01 volumio volumio[18119]: info: Updating MyVolumio device info
Jun 27 09:23:01 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:23:01 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:23:01 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:23:01 volumio sudo[18485]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 27 09:23:01 volumio sudo[18485]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:23:01 volumio sudo[18485]: pam_unix(sudo:session): session closed for user root
Jun 27 09:23:01 volumio sudo[18487]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 27 09:23:01 volumio sudo[18487]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:23:01 volumio sudo[18491]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jun 27 09:23:01 volumio sudo[18487]: pam_unix(sudo:session): session closed for user root
Jun 27 09:23:01 volumio sudo[18491]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:23:01 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Jun 27 09:23:01 volumio sudo[18491]: pam_unix(sudo:session): session closed for user root
Jun 27 09:23:01 volumio volumio[18119]: info: Upmpdcli Daemon Started
Jun 27 09:23:01 volumio volumio[18495]: writing RSA key
Jun 27 09:23:02 volumio volumio[18119]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Jun 27 09:23:03 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 27 09:23:03 volumio volumio[18119]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Jun 27 09:23:03 volumio volumio[18119]: info: CoreCommandRouter::volumioGetState
Jun 27 09:23:03 volumio volumio[18119]: info: CorePlayQueue::getTrack 0
Jun 27 09:23:04 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 27 09:23:04 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:23:04 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 27 09:23:04 volumio volumio-remote-updater[275]: Test mode enabled
Jun 27 09:23:04 volumio volumio-remote-updater[275]: No alpha test mode
Jun 27 09:23:04 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Jun 27 09:23:06 volumio volumio[18119]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nImproved translations
\nFix Multiroom Buffer sizes
\nIncrease results for kana-Kanji conversion
\nFix for streaming interruptions
\n
\nNEW ADDITIONS
\n\nUpdated backend
\n\n","title":"Update v3.779","updateavailable":true}
Jun 27 09:23:06 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jun 27 09:23:08 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:23:08 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:23:08 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Jun 27 09:23:08 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jun 27 09:23:08 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Jun 27 09:23:08 volumio volumio[18119]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 27 09:23:08 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 27 09:23:10 volumio volumio[18119]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Jun 27 09:23:10 volumio volumio[18119]: info: Completed starting MyVolumio Plugin
Jun 27 09:23:10 volumio volumio[18119]: info: BOOT COMPLETED
Jun 27 09:23:10 volumio volumio[18119]:  [Metrics]  CommandRouter:  45s 740.54ms 
Jun 27 09:23:10 volumio volumio[18119]: info: CoreCommandRouter::volumiosetStartupVolume
Jun 27 09:23:10 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 27 09:23:10 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 27 09:23:11 volumio volumio[18119]: info: CoreCommandRouter::Close All Modals sent
Jun 27 09:23:11 volumio volumio[18119]: info: CoreCommandRouter::Close All Modals sent
Jun 27 09:23:11 volumio volumio[18119]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
Jun 27 09:23:11 volumio volumio[18119]: Home directory not accessible: Permission denied
Jun 27 09:23:11 volumio volumio[18119]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card
Jun 27 09:23:11 volumio volumio[18119]: aplay: main:828: audio open error: No such device
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jun 27 09:23:12 volumio volumio[18119]: aplay: device_list:272: no soundcards found...
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jun 27 09:23:12 volumio volumio[18119]: info: Version has changed, forcing UI Reload
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::Reload Ui
Jun 27 09:23:12 volumio sudo[18536]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 27 09:23:12 volumio sudo[18536]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:23:12 volumio sudo[18536]: pam_unix(sudo:session): session closed for user root
Jun 27 09:23:12 volumio sudo[18538]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 27 09:23:12 volumio sudo[18538]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:23:12 volumio sudo[18538]: pam_unix(sudo:session): session closed for user root
Jun 27 09:23:12 volumio volumio[18119]: verbose: New Socket.io Connection to 10.0.0.110 from 10.0.0.185 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Jun 27 09:23:12 volumio volumio[18119]: aplay: device_list:272: no soundcards found...
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
Jun 27 09:23:12 volumio volumio[18119]: info: Received Get System Info
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 27 09:23:12 volumio volumio[18119]: info: Discovery: Getting this device information
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::volumioGetState
Jun 27 09:23:12 volumio volumio[18119]: info: CorePlayQueue::getTrack 0
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 27 09:23:12 volumio volumio-remote-updater[275]: Test mode enabled
Jun 27 09:23:12 volumio volumio-remote-updater[275]: No alpha test mode
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 27 09:23:12 volumio volumio[18119]: info: Retrieving Cloud Streaming UI
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 27 09:23:12 volumio volumio[18119]: info: Getting Tidal Cloud Configuration
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 27 09:23:12 volumio volumio[18119]: info: Getting Qobuz Cloud Configuration
Jun 27 09:23:12 volumio volumio[18119]: info: Asking plugin for UI Config
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 27 09:23:12 volumio volumio[18119]: info: Getting Spotify Cloud Configuration
Jun 27 09:23:12 volumio volumio[18119]: info: Asking plugin for UI Config
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 27 09:23:12 volumio volumio[18119]: info: Saving Spotify Acccount
Jun 27 09:23:12 volumio volumio[18119]: info: Got Tidal Cloud Configuration
Jun 27 09:23:12 volumio volumio[18119]: info: Got it
Jun 27 09:23:12 volumio volumio[18119]: info: Got it
Jun 27 09:23:12 volumio volumio[18119]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Jun 27 09:23:12 volumio volumio[18119]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 27 09:23:12 volumio volumio[18119]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Jun 27 09:23:13 volumio volumio[18119]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nImproved translations
\nFix Multiroom Buffer sizes
\nIncrease results for kana-Kanji conversion
\nFix for streaming interruptions
\n
\nNEW ADDITIONS
\n\nUpdated backend
\n\n","title":"Update v3.779","updateavailable":true}
Jun 27 09:23:13 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jun 27 09:23:13 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Jun 27 09:23:13 volumio volumio[18119]: info: Loading i18n strings for locale zh
Jun 27 09:23:13 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Jun 27 09:23:13 volumio volumio[18119]: info: Setting timezone to Asia/Shanghai
Jun 27 09:23:13 volumio sudo[18550]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Jun 27 09:23:13 volumio sudo[18550]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:23:13 volumio sudo[18550]: pam_unix(sudo:session): session closed for user root
Jun 27 09:23:14 volumio sudo[18553]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Shanghai /etc/localtime
Jun 27 09:23:14 volumio sudo[18553]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:23:14 volumio sudo[18553]: pam_unix(sudo:session): session closed for user root
Jun 27 09:23:14 volumio sudo[18556]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Jun 27 09:23:14 volumio sudo[18556]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:23:14 volumio sudo[18556]: pam_unix(sudo:session): session closed for user root
Jun 27 09:23:14 volumio sudo[18559]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai
Jun 27 09:23:14 volumio sudo[18559]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:23:14 volumio dbus-daemon[272]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.52' (uid=0 pid=18560 comm="/usr/bin/timedatectl set-timezone Asia/Shanghai ")
Jun 27 09:23:14 volumio systemd[1]: Starting Time & Date Service...
Jun 27 09:23:14 volumio dbus-daemon[272]: [system] Successfully activated service 'org.freedesktop.timedate1'
Jun 27 09:23:14 volumio systemd[1]: Started Time & Date Service.
Jun 27 09:23:14 volumio sudo[18559]: pam_unix(sudo:session): session closed for user root
Jun 27 09:23:14 volumio volumio[18119]: info: Fetching Streaming Services browse cache
Jun 27 09:23:14 volumio volumio[18119]: Updating browse sources language
Jun 27 09:23:14 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 09:23:14 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 27 09:23:16 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 27 09:23:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 27 09:23:32 volumio volumio[18119]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jun 27 09:23:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jun 27 09:23:32 volumio volumio[18119]: info: Received Get System Version
Jun 27 09:23:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 27 09:23:32 volumio volumio[18119]: info: Received Get System Info
Jun 27 09:23:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 27 09:23:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 27 09:23:32 volumio volumio[18119]: info: Discovery: Getting this device information
Jun 27 09:23:32 volumio volumio[18119]: info: CoreCommandRouter::volumioGetState
Jun 27 09:23:32 volumio volumio[18119]: info: CorePlayQueue::getTrack 0
Jun 27 09:23:32 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 27 09:23:44 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule
Jun 27 09:23:44 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 27 09:23:44 volumio systemd[1]: systemd-timedated.service: Succeeded.
Jun 27 09:23:44 volumio volumio-remote-updater[275]: Test mode enabled
Jun 27 09:23:44 volumio volumio-remote-updater[275]: No alpha test mode
Jun 27 09:23:44 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Jun 27 09:23:45 volumio volumio[18119]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nImproved translations
\nFix Multiroom Buffer sizes
\nIncrease results for kana-Kanji conversion
\nFix for streaming interruptions
\n
\nNEW ADDITIONS
\n\nUpdated backend
\n\n","title":"Update v3.779","updateavailable":true}
Jun 27 09:23:45 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jun 27 09:23:55 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Jun 27 09:23:55 volumio volumio[18119]: info: Loading i18n strings for locale zh
Jun 27 09:23:55 volumio volumio[18119]: Updating browse sources language
Jun 27 09:23:55 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 27 09:23:55 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Jun 27 09:23:55 volumio volumio[18119]: info: Setting timezone to Asia/Shanghai
Jun 27 09:23:55 volumio sudo[18596]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Jun 27 09:23:55 volumio sudo[18596]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:23:55 volumio sudo[18596]: pam_unix(sudo:session): session closed for user root
Jun 27 09:23:55 volumio sudo[18599]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Shanghai /etc/localtime
Jun 27 09:23:55 volumio sudo[18599]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:23:55 volumio sudo[18599]: pam_unix(sudo:session): session closed for user root
Jun 27 09:23:55 volumio sudo[18602]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Jun 27 09:23:55 volumio sudo[18602]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:23:55 volumio sudo[18602]: pam_unix(sudo:session): session closed for user root
Jun 27 09:23:55 volumio sudo[18605]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai
Jun 27 09:23:55 volumio sudo[18605]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:23:55 volumio dbus-daemon[272]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.54' (uid=0 pid=18606 comm="/usr/bin/timedatectl set-timezone Asia/Shanghai ")
Jun 27 09:23:55 volumio systemd[1]: Starting Time & Date Service...
Jun 27 09:23:55 volumio dbus-daemon[272]: [system] Successfully activated service 'org.freedesktop.timedate1'
Jun 27 09:23:55 volumio systemd[1]: Started Time & Date Service.
Jun 27 09:23:55 volumio sudo[18605]: pam_unix(sudo:session): session closed for user root
Jun 27 09:23:55 volumio volumio[18119]: info: Fetching Streaming Services browse cache
Jun 27 09:23:55 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Jun 27 09:23:55 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Jun 27 09:23:55 volumio sudo[18609]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 27 09:23:55 volumio sudo[18609]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:23:55 volumio sudo[18609]: pam_unix(sudo:session): session closed for user root
Jun 27 09:23:56 volumio volumio[18119]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Jun 27 09:23:56 volumio volumio[18119]: wlan0     Interface doesn't support scanning.
Jun 27 09:23:56 volumio volumio[18119]: info: Cannot use regular scanning, forcing with ap-force
Jun 27 09:23:56 volumio sudo[18614]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Jun 27 09:23:56 volumio sudo[18614]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 27 09:23:56 volumio sudo[18614]: pam_unix(sudo:session): session closed for user root
Jun 27 09:23:56 volumio volumio[18119]: command failed: No such device (-19)
Jun 27 09:23:56 volumio volumio[18119]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Jun 27 09:23:56 volumio volumio[18119]: command failed: No such device (-19)
Jun 27 09:23:57 volumio volumio[18119]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings
Jun 27 09:23:57 volumio volumio[18119]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 27 09:23:57 volumio volumio[18119]: TypeError: Cannot read property 'value' of undefined
Jun 27 09:23:57 volumio volumio[18119]:     at ControllerSystem.saveGeneralSettings (/volumio/app/plugins/system_controller/system/index.js:444:77)
Jun 27 09:23:57 volumio volumio[18119]:     at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1083:32)
Jun 27 09:23:57 volumio volumio[18119]:     at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1683:39)
Jun 27 09:23:57 volumio volumio[18119]:     at Socket.emit (events.js:400:28)
Jun 27 09:23:57 volumio volumio[18119]:     at /volumio/node_modules/socket.io/lib/socket.js:528:12
Jun 27 09:23:57 volumio volumio[18119]:     at processTicksAndRejections (internal/process/task_queues.js:77:11)
Jun 27 09:23:57 volumio volumio[18119]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 27 09:23:58 volumio sudo[18627]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-27 09:22
Jun 27 09:23:58 volumio sudo[18627]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="6e682b9410d28f3874f90b2d7789db824a859264"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="218f986668198768ef5630191ffb17431779722f"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 12 Jun 2024 10:07:52 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="odroidm1s"
VOLUMIO_DEVICENAME="Odroid M1S"
VOLUMIO_HASH="8e8313fb3db92f972e3c67e9a9aee148"