-- Logs begin at Thu 2019-02-14 15:11:59 +05, end at Sat 2025-06-14 11:54:18 +05. --
Jun 14 11:53:02 volumio volumio[13606]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Jun 14 11:53:02 volumio volumio[13606]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 14 11:53:02 volumio volumio[13606]: TypeError: Cannot read property 'charAt' of undefined
Jun 14 11:53:02 volumio volumio[13606]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:199:24)
Jun 14 11:53:02 volumio volumio[13606]: at listOnTimeout (internal/timers.js:554:17)
Jun 14 11:53:02 volumio volumio[13606]: at processTimers (internal/timers.js:497:7)
Jun 14 11:53:02 volumio volumio[13606]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 14 11:53:02 volumio sudo[13856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-14 11:52
Jun 14 11:53:02 volumio sudo[13856]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:02 volumio sudo[13856]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:03 volumio volumio-remote-updater[558]: [2025-06-14 11:53:03] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jun 14 11:53:03 volumio volumio-remote-updater[558]: [2025-06-14 11:53:03] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jun 14 11:53:03 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Jun 14 11:53:03 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Jun 14 11:53:03 volumio systemd[1]: Started dynamicswap service.
Jun 14 11:53:03 volumio systemd[1]: dynamicswap.service: Succeeded.
Jun 14 11:53:03 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Jun 14 11:53:03 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 52.
Jun 14 11:53:03 volumio systemd[1]: Started dynamicswap service.
Jun 14 11:53:03 volumio systemd[1]: Stopped Volumio Backend Module.
Jun 14 11:53:03 volumio systemd[1]: Started Volumio Backend Module.
Jun 14 11:53:03 volumio systemd[1]: dynamicswap.service: Succeeded.
Jun 14 11:53:05 volumio volumio[13870]: info: -------------------------------------------
Jun 14 11:53:05 volumio volumio[13870]: info: ----- Volumio3 ----
Jun 14 11:53:05 volumio volumio[13870]: info: -------------------------------------------
Jun 14 11:53:05 volumio volumio[13870]: info: ----- System startup ----
Jun 14 11:53:05 volumio volumio[13870]: info: -------------------------------------------
Jun 14 11:53:05 volumio volumio[13870]: info: MYVOLUMIO Environment detected
Jun 14 11:53:05 volumio volumio[13870]: info: Plugin folders cleanup
Jun 14 11:53:05 volumio volumio[13870]: info: Scanning into folder /volumio/app/plugins/
Jun 14 11:53:05 volumio volumio[13870]: info: Scanning category audio_interface
Jun 14 11:53:05 volumio volumio[13870]: info: Scanning category miscellanea
Jun 14 11:53:05 volumio volumio[13870]: info: Scanning category music_service
Jun 14 11:53:05 volumio volumio[13870]: info: Scanning category plugins.json
Jun 14 11:53:05 volumio volumio[13870]: info: Scanning category system_controller
Jun 14 11:53:05 volumio volumio[13870]: info: Scanning category user_interface
Jun 14 11:53:05 volumio volumio[13870]: info: Scanning into folder /data/plugins/
Jun 14 11:53:05 volumio volumio[13870]: info: Scanning category audio_interface
Jun 14 11:53:05 volumio volumio[13870]: info: Scanning category music_service
Jun 14 11:53:05 volumio volumio[13870]: info: Scanning category system_controller
Jun 14 11:53:05 volumio volumio[13870]: info: Scanning category user_interface
Jun 14 11:53:05 volumio volumio[13870]: info: Plugin folders cleanup completed
Jun 14 11:53:05 volumio volumio[13870]: info: -------------------------------------------
Jun 14 11:53:05 volumio volumio[13870]: info: ----- Core plugins startup ----
Jun 14 11:53:05 volumio volumio[13870]: info: -------------------------------------------
Jun 14 11:53:05 volumio volumio[13870]: info: Loading plugins from folder /volumio/app/plugins/
Jun 14 11:53:05 volumio volumio[13870]: info: Adding plugin upnp to MyMusic Plugins
Jun 14 11:53:05 volumio volumio[13870]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 14 11:53:05 volumio volumio[13870]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 14 11:53:05 volumio volumio[13870]: info: Loading plugins from folder /data/plugins/
Jun 14 11:53:05 volumio volumio[13870]: info: Loading plugin "system"...
Jun 14 11:53:05 volumio volumio[13870]: info: Loading plugin "appearance"...
Jun 14 11:53:06 volumio volumio[13870]: info: Loading plugin "network"...
Jun 14 11:53:06 volumio volumio[13870]: info: Refreshing Cached IP Addresses
Jun 14 11:53:06 volumio sudo[13896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 14 11:53:06 volumio sudo[13896]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:07 volumio sudo[13896]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:07 volumio sudo[13898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 14 11:53:07 volumio sudo[13898]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:07 volumio sudo[13898]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:07 volumio volumio[13870]: info: Loading plugin "services"...
Jun 14 11:53:07 volumio volumio[13870]: info: Loading plugin "alsa_controller"...
Jun 14 11:53:07 volumio sudo[13910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 14 11:53:07 volumio sudo[13910]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:07 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 14 11:53:07 volumio volumio[13870]: info: Loading plugin "wizard"...
Jun 14 11:53:07 volumio volumio[13870]: info: Loading plugin "networkfs"...
Jun 14 11:53:07 volumio volumio[13870]: info: Starting Udev Watcher for removable devices
Jun 14 11:53:07 volumio volumio[13870]: info: Ignoring mount for partition: boot
Jun 14 11:53:07 volumio volumio[13870]: info: Ignoring mount for partition: volumio
Jun 14 11:53:07 volumio volumio[13870]: info: Ignoring mount for partition: volumio_data
Jun 14 11:53:07 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 14 11:53:07 volumio volumio[13870]: info: Loading plugin "volumio_command_line_client"...
Jun 14 11:53:07 volumio volumio[13870]: info: Loading plugin "upnp"...
Jun 14 11:53:07 volumio volumio[13870]: info: [1749883987223] Starting Upmpd Daemon
Jun 14 11:53:07 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 14 11:53:07 volumio volumio[13870]: info: Loading plugin "my_music"...
Jun 14 11:53:07 volumio volumio[13870]: info: Loading plugin "mpd"...
Jun 14 11:53:07 volumio volumio[13870]: info: Loading plugin "upnp_browser"...
Jun 14 11:53:07 volumio volumio[13870]: info: Loading plugin "alarm-clock"...
Jun 14 11:53:07 volumio sudo[13910]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:08 volumio volumio-remote-updater[558]: [2025-06-14 11:53:08] [connect] Successful connection
Jun 14 11:53:08 volumio volumio[13870]: info: Loading plugin "airplay_emulation"...
Jun 14 11:53:08 volumio volumio[13870]: info: Starting Shairport Sync
Jun 14 11:53:08 volumio volumio[13870]: info: Loading plugin "last_100"...
Jun 14 11:53:08 volumio volumio[13870]: info: Loading plugin "webradio"...
Jun 14 11:53:08 volumio volumio[13870]: info: Loading plugin "i2s_dacs"...
Jun 14 11:53:08 volumio volumio[13870]: info: Loading plugin "volumiodiscovery"...
Jun 14 11:53:08 volumio volumio[13870]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:08 volumio volumio[13870]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:08 volumio volumio[13870]: *** WARNING *** For more information see
Jun 14 11:53:08 volumio node[13870]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:08 volumio volumio[13870]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:08 volumio volumio[13870]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:08 volumio volumio[13870]: *** WARNING *** For more information see
Jun 14 11:53:08 volumio node[13870]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:08 volumio node[13870]: *** WARNING *** For more information see
Jun 14 11:53:08 volumio node[13870]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:08 volumio node[13870]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:08 volumio node[13870]: *** WARNING *** For more information see
Jun 14 11:53:08 volumio volumio[13870]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 14 11:53:08 volumio volumio[13870]: info: Discovery: Started advertising with name: undefined
Jun 14 11:53:08 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 14 11:53:08 volumio volumio[13870]: info: Plugin autostart is not enabled
Jun 14 11:53:08 volumio volumio[13870]: info: Loading plugin "outputs"...
Jun 14 11:53:08 volumio volumio[13870]: info: Loading plugin "albumart"...
Jun 14 11:53:08 volumio volumio[13870]: info: Plugin example_plugin is not enabled
Jun 14 11:53:08 volumio volumio[13870]: info: Loading plugin "inputs"...
Jun 14 11:53:08 volumio volumio[13870]: info: Loading plugin "updater_comm"...
Jun 14 11:53:08 volumio volumio[13870]: info: Plugin mpdemulation is not enabled
Jun 14 11:53:08 volumio volumio[13870]: info: Loading plugin "rest_api"...
Jun 14 11:53:08 volumio volumio[13870]: info: Loading plugin "websocket"...
Jun 14 11:53:08 volumio volumio[13870]: info: Starting Socket.io Server version 2.3.0
Jun 14 11:53:08 volumio volumio[13870]: info: Plugin fusiondsp is not enabled
Jun 14 11:53:08 volumio volumio[13870]: info: Plugin yandex_music is not enabled
Jun 14 11:53:08 volumio volumio[13870]: info: Plugin touch_display is not enabled
Jun 14 11:53:08 volumio volumio[13870]: info: Loading i18n strings for locale ru
Jun 14 11:53:08 volumio volumio[13870]: Updating browse sources language
Jun 14 11:53:08 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:08 volumio volumio[13870]: Forking 3 albumart workers
Jun 14 11:53:08 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 14 11:53:08 volumio volumio[13870]: info: CoreCommandRouter::initPlayerControls
Jun 14 11:53:08 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:08 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:08 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:08 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:08 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:08 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:08 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:08 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 14 11:53:08 volumio volumio[13870]: Express server listening on port 3000
Jun 14 11:53:08 volumio volumio[13870]: [Metrics] WebUI: 4s 301.56ms
Jun 14 11:53:08 volumio volumio[13870]: info: CoreStateMachine::resetVolumioState
Jun 14 11:53:08 volumio volumio[13870]: info: CoreStateMachine::getcurrentVolume
Jun 14 11:53:08 volumio volumio[13870]: info: CoreCommandRouter::volumioRetrievevolume
Jun 14 11:53:08 volumio volumio[13870]: info: Volumio Network Manager: Network status updated: 2
Jun 14 11:53:09 volumio volumio[13870]: verbose: New Socket.io Connection to 192.168.88.13 from 192.168.88.27 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Jun 14 11:53:09 volumio volumio[13870]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2
Jun 14 11:53:09 volumio volumio-remote-updater[558]: [2025-06-14 11:53:09] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1749883988 101
Jun 14 11:53:09 volumio volumio[13870]: 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: 3
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:09 volumio volumio[13870]: info: Reloading queue from file
Jun 14 11:53:09 volumio volumio[13870]: info: VolumeController:: Volume=96 Mute =false
Jun 14 11:53:09 volumio volumio[13870]: info: CoreStateMachine::pushState
Jun 14 11:53:09 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:09 volumio volumio[13870]: info: CoreStateMachine::updateTrackBlock
Jun 14 11:53:09 volumio volumio[13870]: info: CorePlayQueue::getTrackBlock
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::volumioRetrievevolume
Jun 14 11:53:09 volumio volumio[13870]: info: Setting Device type: Raspberry PI
Jun 14 11:53:09 volumio volumio[13870]: info: CoreStateMachine::setRepeat null single undefined
Jun 14 11:53:09 volumio volumio[13870]: info: CoreStateMachine::pushState
Jun 14 11:53:09 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:09 volumio volumio[13870]: info: CoreStateMachine::setRandom null
Jun 14 11:53:09 volumio volumio[13870]: info: CoreStateMachine::pushState
Jun 14 11:53:09 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:09 volumio volumio[13870]: info: Completed loading Core Plugins
Jun 14 11:53:09 volumio volumio[13870]: info: Preparing to generate the ALSA configuration file
Jun 14 11:53:09 volumio volumio[13870]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Jun 14 11:53:09 volumio volumio[13870]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082
Jun 14 11:53:09 volumio volumio[13870]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Jun 14 11:53:09 volumio volumio[13870]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Jun 14 11:53:09 volumio volumio[13870]: info: Reading ALSA contributions from plugins.
Jun 14 11:53:09 volumio volumio[13870]: info: Discovery: adding 8d09537b-2a8b-40c5-aafd-b4ed981ad133
Jun 14 11:53:09 volumio volumio[13870]: info: Discovery: Found device Volumio
Jun 14 11:53:09 volumio volumio[13870]: info: Discovery: Connecting to remote: 192.168.88.16
Jun 14 11:53:09 volumio volumio[13870]: info: VolumeController:: Volume=96 Mute =false
Jun 14 11:53:09 volumio volumio[13870]: info: CoreStateMachine::pushState
Jun 14 11:53:09 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:09 volumio volumio[13870]: info: Asound.conf file unchanged, so no further update is needed
Jun 14 11:53:09 volumio volumio[13870]: info: Output device has changed, restarting MPD
Jun 14 11:53:09 volumio volumio[13870]: info: Output device has changed, restarting Shairport Sync
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:09 volumio sudo[13965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 14 11:53:09 volumio sudo[13965]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:09 volumio sudo[13965]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:09 volumio sudo[13967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 14 11:53:09 volumio sudo[13967]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:09 volumio systemd[1]: Stopping Music Player Daemon...
Jun 14 11:53:09 volumio volumio[13870]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 14 11:53:09 volumio volumio[13870]: info: ___________ START PLUGINS ___________
Jun 14 11:53:09 volumio systemd[1]: mpd.service: Succeeded.
Jun 14 11:53:09 volumio systemd[1]: Stopped Music Player Daemon.
Jun 14 11:53:09 volumio volumio[13870]: info: ControllerMpd::onStart: Initializing MPD
Jun 14 11:53:09 volumio volumio[13870]: info: Creating MPD Configuration file
Jun 14 11:53:09 volumio systemd[1]: Starting Music Player Daemon...
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 14 11:53:09 volumio volumio[13870]: info: [1749883989806] CoreMusicLibrary::Adding element Медиа-серверы
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:09 volumio sudo[13975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 14 11:53:09 volumio sudo[13977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 14 11:53:09 volumio sudo[13977]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:09 volumio sudo[13975]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:09 volumio sudo[13975]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:09 volumio volumio[13870]: Starting albumart workers
Jun 14 11:53:09 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Jun 14 11:53:09 volumio systemd[1]: mpd.service: Succeeded.
Jun 14 11:53:09 volumio systemd[1]: Stopped Music Player Daemon.
Jun 14 11:53:09 volumio systemd[1]: Starting Music Player Daemon...
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:09 volumio volumio[13870]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 14 11:53:09 volumio volumio[13870]: Starting albumart workers
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:09 volumio volumio[13870]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 14 11:53:09 volumio volumio[13870]: info: [1749883989988] CoreMusicLibrary::Adding element Last_100
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 14 11:53:09 volumio volumio[13870]: info: [1749883989995] CoreMusicLibrary::Adding element Webradio
Jun 14 11:53:09 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 14 11:53:10 volumio sudo[13980]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 14 11:53:10 volumio sudo[13980]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:10 volumio volumio[13870]: info: Initializing BBC Radios
Jun 14 11:53:10 volumio sudo[13980]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:10 volumio volumio[13870]: Starting albumart workers
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:10 volumio volumio[13870]: info: Volumio Calling Home
Jun 14 11:53:10 volumio volumio[13870]: info: Discovery: Connected to remote: 192.168.88.16
Jun 14 11:53:10 volumio volumio[13870]: info: MPD Permissions set
Jun 14 11:53:10 volumio volumio[13870]: info: MPD Permissions set
Jun 14 11:53:10 volumio volumio[13870]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Jun 14 11:53:10 volumio volumio[13870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:10 volumio volumio[13870]: verbose: New Socket.io Connection to 192.168.88.13 from 192.168.88.27 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Jun 14 11:53:10 volumio volumio[13870]: info: Received Get System Info
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:10 volumio volumio[13870]: info: Discovery: Getting this device information
Jun 14 11:53:10 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:10 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 14 11:53:11 volumio volumio[13870]: info: Received Get System Info
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:11 volumio volumio[13870]: info: Discovery: Getting this device information
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: Listing playlists
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetQueue
Jun 14 11:53:11 volumio volumio[13870]: info: CoreStateMachine::getQueue
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getQueue
Jun 14 11:53:11 volumio volumio[13870]: info: Received Get System Info
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:11 volumio volumio[13870]: info: Discovery: Getting this device information
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 14 11:53:11 volumio volumio[13870]: info: Received Get System Info
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:11 volumio volumio[13870]: info: Discovery: Getting this device information
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: Listing playlists
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetQueue
Jun 14 11:53:11 volumio volumio[13870]: info: CoreStateMachine::getQueue
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getQueue
Jun 14 11:53:11 volumio volumio[13870]: info: Received Get System Info
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:11 volumio volumio[13870]: info: Discovery: Getting this device information
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 14 11:53:11 volumio volumio[13870]: info: Received Get System Info
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:11 volumio volumio[13870]: info: Discovery: Getting this device information
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: Listing playlists
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetQueue
Jun 14 11:53:11 volumio volumio[13870]: info: CoreStateMachine::getQueue
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getQueue
Jun 14 11:53:11 volumio volumio[13870]: info: Received Get System Info
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:11 volumio volumio[13870]: info: Discovery: Getting this device information
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio volumio[13870]: info: Starting Shairport Sync
Jun 14 11:53:11 volumio volumio[13870]: info: Starting Shairport Sync
Jun 14 11:53:11 volumio volumio[13870]: info: Starting Shairport Sync
Jun 14 11:53:11 volumio sudo[14035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 14 11:53:11 volumio sudo[14035]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:11 volumio sudo[14037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 14 11:53:11 volumio sudo[14037]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:11 volumio sudo[14040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 14 11:53:11 volumio sudo[14040]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:11 volumio volumio[13870]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:11 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 14 11:53:11 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:53:11 volumio volumio[13870]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 14 11:53:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:53:11 volumio sudo[14037]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:11 volumio sudo[14035]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:11 volumio sudo[14040]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:12 volumio mpd[13988]: Jun 14 11:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 14 11:53:12 volumio systemd[1]: Started Music Player Daemon.
Jun 14 11:53:12 volumio sudo[13977]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:12 volumio sudo[13967]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:12 volumio volumio[13870]: info: Shairport-Sync Started
Jun 14 11:53:12 volumio volumio[13870]: Error adding Membership: Error: addMembership EINVAL
Jun 14 11:53:12 volumio volumio[13870]: info: Shairport-Sync Started
Jun 14 11:53:12 volumio volumio[13870]: info: Completed starting Core Plugins
Jun 14 11:53:12 volumio volumio[13870]: info: -------------------------------------------
Jun 14 11:53:12 volumio volumio[13870]: info: ----- MyVolumio plugins startup ----
Jun 14 11:53:12 volumio volumio[13870]: info: -------------------------------------------
Jun 14 11:53:12 volumio volumio[13870]: info: [MyVolumio PluginManager] Fetching plans data....
Jun 14 11:53:12 volumio volumio[13870]: error: MPD error: The expression evaluated to a falsy value:
Jun 14 11:53:12 volumio volumio[13870]: assert.ok(self.idling)
Jun 14 11:53:12 volumio volumio[13870]: error: The expression evaluated to a falsy value:
Jun 14 11:53:12 volumio volumio[13870]: assert.ok(self.idling)
Jun 14 11:53:12 volumio volumio[13870]: error: updateQueue error: null
Jun 14 11:53:12 volumio volumio[13870]: info: MPD running with PID13988
Jun 14 11:53:12 volumio volumio[13870]: ,establishing connection
Jun 14 11:53:12 volumio volumio[13870]: error: updateQueue error: null
Jun 14 11:53:13 volumio volumio[13870]: error: Discovery: Generic error: TypeError: argument 8 must be an integer (port)
Jun 14 11:53:13 volumio volumio[13870]: info: Discovery: Started advertising with name: undefined
Jun 14 11:53:17 volumio volumio[13870]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 14 11:53:17 volumio volumio[13870]: TypeError: Cannot read property 'charAt' of undefined
Jun 14 11:53:17 volumio volumio[13870]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:199:24)
Jun 14 11:53:17 volumio volumio[13870]: at listOnTimeout (internal/timers.js:554:17)
Jun 14 11:53:17 volumio volumio[13870]: at processTimers (internal/timers.js:497:7)
Jun 14 11:53:17 volumio volumio[13870]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 14 11:53:17 volumio sudo[14074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-14 11:52
Jun 14 11:53:17 volumio sudo[14074]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:17 volumio sudo[14074]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:18 volumio volumio-remote-updater[558]: [2025-06-14 11:53:18] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jun 14 11:53:18 volumio volumio-remote-updater[558]: [2025-06-14 11:53:18] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jun 14 11:53:18 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Jun 14 11:53:18 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Jun 14 11:53:18 volumio systemd[1]: Started dynamicswap service.
Jun 14 11:53:18 volumio systemd[1]: dynamicswap.service: Succeeded.
Jun 14 11:53:18 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Jun 14 11:53:18 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 53.
Jun 14 11:53:18 volumio systemd[1]: Started dynamicswap service.
Jun 14 11:53:18 volumio systemd[1]: Stopped Volumio Backend Module.
Jun 14 11:53:18 volumio systemd[1]: Started Volumio Backend Module.
Jun 14 11:53:18 volumio systemd[1]: dynamicswap.service: Succeeded.
Jun 14 11:53:20 volumio volumio[14088]: info: -------------------------------------------
Jun 14 11:53:20 volumio volumio[14088]: info: ----- Volumio3 ----
Jun 14 11:53:20 volumio volumio[14088]: info: -------------------------------------------
Jun 14 11:53:20 volumio volumio[14088]: info: ----- System startup ----
Jun 14 11:53:20 volumio volumio[14088]: info: -------------------------------------------
Jun 14 11:53:20 volumio volumio[14088]: info: MYVOLUMIO Environment detected
Jun 14 11:53:20 volumio volumio[14088]: info: Plugin folders cleanup
Jun 14 11:53:20 volumio volumio[14088]: info: Scanning into folder /volumio/app/plugins/
Jun 14 11:53:20 volumio volumio[14088]: info: Scanning category audio_interface
Jun 14 11:53:20 volumio volumio[14088]: info: Scanning category miscellanea
Jun 14 11:53:20 volumio volumio[14088]: info: Scanning category music_service
Jun 14 11:53:20 volumio volumio[14088]: info: Scanning category plugins.json
Jun 14 11:53:20 volumio volumio[14088]: info: Scanning category system_controller
Jun 14 11:53:20 volumio volumio[14088]: info: Scanning category user_interface
Jun 14 11:53:20 volumio volumio[14088]: info: Scanning into folder /data/plugins/
Jun 14 11:53:20 volumio volumio[14088]: info: Scanning category audio_interface
Jun 14 11:53:20 volumio volumio[14088]: info: Scanning category music_service
Jun 14 11:53:20 volumio volumio[14088]: info: Scanning category system_controller
Jun 14 11:53:20 volumio volumio[14088]: info: Scanning category user_interface
Jun 14 11:53:20 volumio volumio[14088]: info: Plugin folders cleanup completed
Jun 14 11:53:20 volumio volumio[14088]: info: -------------------------------------------
Jun 14 11:53:20 volumio volumio[14088]: info: ----- Core plugins startup ----
Jun 14 11:53:20 volumio volumio[14088]: info: -------------------------------------------
Jun 14 11:53:20 volumio volumio[14088]: info: Loading plugins from folder /volumio/app/plugins/
Jun 14 11:53:20 volumio volumio[14088]: info: Adding plugin upnp to MyMusic Plugins
Jun 14 11:53:20 volumio volumio[14088]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 14 11:53:20 volumio volumio[14088]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 14 11:53:20 volumio volumio[14088]: info: Loading plugins from folder /data/plugins/
Jun 14 11:53:20 volumio volumio[14088]: info: Loading plugin "system"...
Jun 14 11:53:20 volumio volumio[14088]: info: Loading plugin "appearance"...
Jun 14 11:53:21 volumio volumio[14088]: info: Loading plugin "network"...
Jun 14 11:53:21 volumio volumio[14088]: info: Refreshing Cached IP Addresses
Jun 14 11:53:21 volumio sudo[14114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 14 11:53:21 volumio sudo[14114]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:21 volumio sudo[14114]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:21 volumio sudo[14116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 14 11:53:22 volumio sudo[14116]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:22 volumio volumio[14088]: info: Loading plugin "services"...
Jun 14 11:53:22 volumio sudo[14116]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:22 volumio volumio[14088]: info: Loading plugin "alsa_controller"...
Jun 14 11:53:22 volumio sudo[14125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 14 11:53:22 volumio sudo[14125]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:22 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 14 11:53:22 volumio volumio[14088]: info: Loading plugin "wizard"...
Jun 14 11:53:22 volumio volumio[14088]: info: Loading plugin "networkfs"...
Jun 14 11:53:22 volumio volumio[14088]: info: Starting Udev Watcher for removable devices
Jun 14 11:53:22 volumio volumio[14088]: info: Ignoring mount for partition: boot
Jun 14 11:53:22 volumio volumio[14088]: info: Ignoring mount for partition: volumio
Jun 14 11:53:22 volumio volumio[14088]: info: Ignoring mount for partition: volumio_data
Jun 14 11:53:22 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 14 11:53:22 volumio volumio[14088]: info: Loading plugin "volumio_command_line_client"...
Jun 14 11:53:22 volumio volumio[14088]: info: Loading plugin "upnp"...
Jun 14 11:53:22 volumio volumio[14088]: info: [1749884002213] Starting Upmpd Daemon
Jun 14 11:53:22 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 14 11:53:22 volumio volumio[14088]: info: Loading plugin "my_music"...
Jun 14 11:53:22 volumio volumio[14088]: info: Loading plugin "mpd"...
Jun 14 11:53:22 volumio volumio[14088]: info: Loading plugin "upnp_browser"...
Jun 14 11:53:22 volumio volumio[14088]: info: Loading plugin "alarm-clock"...
Jun 14 11:53:22 volumio sudo[14125]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:23 volumio volumio[14088]: info: Loading plugin "airplay_emulation"...
Jun 14 11:53:23 volumio volumio[14088]: info: Starting Shairport Sync
Jun 14 11:53:23 volumio volumio[14088]: info: Loading plugin "last_100"...
Jun 14 11:53:23 volumio volumio[14088]: info: Loading plugin "webradio"...
Jun 14 11:53:23 volumio volumio-remote-updater[558]: [2025-06-14 11:53:23] [connect] Successful connection
Jun 14 11:53:23 volumio volumio[14088]: info: Loading plugin "i2s_dacs"...
Jun 14 11:53:23 volumio volumio[14088]: info: Loading plugin "volumiodiscovery"...
Jun 14 11:53:23 volumio volumio[14088]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:23 volumio volumio[14088]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:23 volumio volumio[14088]: *** WARNING *** For more information see
Jun 14 11:53:23 volumio node[14088]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:23 volumio volumio[14088]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:23 volumio volumio[14088]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:23 volumio volumio[14088]: *** WARNING *** For more information see
Jun 14 11:53:23 volumio node[14088]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:23 volumio node[14088]: *** WARNING *** For more information see
Jun 14 11:53:23 volumio node[14088]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:23 volumio node[14088]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:23 volumio node[14088]: *** WARNING *** For more information see
Jun 14 11:53:23 volumio volumio[14088]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 14 11:53:23 volumio volumio[14088]: info: Discovery: Started advertising with name: undefined
Jun 14 11:53:23 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 14 11:53:23 volumio volumio[14088]: info: Plugin autostart is not enabled
Jun 14 11:53:23 volumio volumio[14088]: info: Loading plugin "outputs"...
Jun 14 11:53:23 volumio volumio[14088]: info: Loading plugin "albumart"...
Jun 14 11:53:23 volumio volumio[14088]: info: Plugin example_plugin is not enabled
Jun 14 11:53:23 volumio volumio[14088]: info: Loading plugin "inputs"...
Jun 14 11:53:23 volumio volumio[14088]: info: Loading plugin "updater_comm"...
Jun 14 11:53:23 volumio volumio[14088]: info: Plugin mpdemulation is not enabled
Jun 14 11:53:23 volumio volumio[14088]: info: Loading plugin "rest_api"...
Jun 14 11:53:23 volumio volumio[14088]: info: Loading plugin "websocket"...
Jun 14 11:53:23 volumio volumio[14088]: info: Starting Socket.io Server version 2.3.0
Jun 14 11:53:23 volumio volumio[14088]: info: Plugin fusiondsp is not enabled
Jun 14 11:53:23 volumio volumio[14088]: info: Plugin yandex_music is not enabled
Jun 14 11:53:23 volumio volumio[14088]: info: Plugin touch_display is not enabled
Jun 14 11:53:23 volumio volumio[14088]: info: Loading i18n strings for locale ru
Jun 14 11:53:23 volumio volumio[14088]: Updating browse sources language
Jun 14 11:53:23 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:23 volumio volumio[14088]: Forking 3 albumart workers
Jun 14 11:53:23 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 14 11:53:23 volumio volumio[14088]: info: CoreCommandRouter::initPlayerControls
Jun 14 11:53:23 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:23 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:23 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:23 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:23 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:23 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:23 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:23 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:23 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 14 11:53:23 volumio volumio[14088]: Express server listening on port 3000
Jun 14 11:53:23 volumio volumio[14088]: [Metrics] WebUI: 4s 309.12ms
Jun 14 11:53:23 volumio volumio[14088]: info: CoreStateMachine::resetVolumioState
Jun 14 11:53:23 volumio volumio[14088]: info: CoreStateMachine::getcurrentVolume
Jun 14 11:53:23 volumio volumio[14088]: info: CoreCommandRouter::volumioRetrievevolume
Jun 14 11:53:23 volumio volumio[14088]: info: Volumio Network Manager: Network status updated: 2
Jun 14 11:53:24 volumio volumio[14088]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Jun 14 11:53:24 volumio volumio-remote-updater[558]: [2025-06-14 11:53:24] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1749884003 101
Jun 14 11:53:24 volumio volumio[14088]: 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: 2
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:24 volumio volumio[14088]: info: Reloading queue from file
Jun 14 11:53:24 volumio volumio[14088]: info: VolumeController:: Volume=96 Mute =false
Jun 14 11:53:24 volumio volumio[14088]: info: CoreStateMachine::pushState
Jun 14 11:53:24 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:24 volumio volumio[14088]: info: CoreStateMachine::updateTrackBlock
Jun 14 11:53:24 volumio volumio[14088]: info: CorePlayQueue::getTrackBlock
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::volumioRetrievevolume
Jun 14 11:53:24 volumio volumio[14088]: info: CoreStateMachine::setRepeat null single undefined
Jun 14 11:53:24 volumio volumio[14088]: info: CoreStateMachine::pushState
Jun 14 11:53:24 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:24 volumio volumio[14088]: info: CoreStateMachine::setRandom null
Jun 14 11:53:24 volumio volumio[14088]: info: CoreStateMachine::pushState
Jun 14 11:53:24 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:24 volumio volumio[14088]: info: Setting Device type: Raspberry PI
Jun 14 11:53:24 volumio volumio[14088]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Jun 14 11:53:24 volumio volumio[14088]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082
Jun 14 11:53:24 volumio volumio[14088]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Jun 14 11:53:24 volumio volumio[14088]: info: Completed loading Core Plugins
Jun 14 11:53:24 volumio volumio[14088]: info: Preparing to generate the ALSA configuration file
Jun 14 11:53:24 volumio volumio[14088]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Jun 14 11:53:24 volumio volumio[14088]: info: Reading ALSA contributions from plugins.
Jun 14 11:53:24 volumio volumio[14088]: info: Asound.conf file unchanged, so no further update is needed
Jun 14 11:53:24 volumio volumio[14088]: info: Output device has changed, restarting MPD
Jun 14 11:53:24 volumio sudo[14187]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 14 11:53:24 volumio sudo[14187]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:24 volumio volumio[14088]: info: Output device has changed, restarting Shairport Sync
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:24 volumio sudo[14187]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:24 volumio sudo[14188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 14 11:53:24 volumio sudo[14188]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:24 volumio volumio[14088]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 14 11:53:24 volumio systemd[1]: Stopping Music Player Daemon...
Jun 14 11:53:24 volumio volumio[14088]: info: ___________ START PLUGINS ___________
Jun 14 11:53:24 volumio volumio[14088]: info: ControllerMpd::onStart: Initializing MPD
Jun 14 11:53:24 volumio volumio[14088]: info: Creating MPD Configuration file
Jun 14 11:53:24 volumio systemd[1]: mpd.service: Succeeded.
Jun 14 11:53:24 volumio systemd[1]: Stopped Music Player Daemon.
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 14 11:53:24 volumio volumio[14088]: info: [1749884004659] CoreMusicLibrary::Adding element Медиа-серверы
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:24 volumio sudo[14195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 14 11:53:24 volumio sudo[14195]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:24 volumio systemd[1]: Starting Music Player Daemon...
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:24 volumio sudo[14195]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:24 volumio sudo[14198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 14 11:53:24 volumio sudo[14198]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:24 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Jun 14 11:53:24 volumio systemd[1]: mpd.service: Succeeded.
Jun 14 11:53:24 volumio systemd[1]: Stopped Music Player Daemon.
Jun 14 11:53:24 volumio systemd[1]: Starting Music Player Daemon...
Jun 14 11:53:24 volumio volumio[14088]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:24 volumio volumio[14088]: Starting albumart workers
Jun 14 11:53:24 volumio volumio[14088]: Starting albumart workers
Jun 14 11:53:24 volumio sudo[14204]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 14 11:53:24 volumio sudo[14204]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:24 volumio sudo[14204]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:24 volumio volumio[14088]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 14 11:53:24 volumio volumio[14088]: info: [1749884004963] CoreMusicLibrary::Adding element Last_100
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 14 11:53:24 volumio volumio[14088]: info: [1749884004966] CoreMusicLibrary::Adding element Webradio
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:24 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 14 11:53:24 volumio volumio[14088]: info: Initializing BBC Radios
Jun 14 11:53:24 volumio volumio[14088]: Starting albumart workers
Jun 14 11:53:25 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 14 11:53:25 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:25 volumio volumio[14088]: info: Volumio Calling Home
Jun 14 11:53:25 volumio volumio[14088]: info: Discovery: adding 8d09537b-2a8b-40c5-aafd-b4ed981ad133
Jun 14 11:53:25 volumio volumio[14088]: info: Discovery: Found device Volumio
Jun 14 11:53:25 volumio volumio[14088]: info: Discovery: Connecting to remote: 192.168.88.16
Jun 14 11:53:25 volumio volumio[14088]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Jun 14 11:53:25 volumio volumio[14088]: info: MPD Permissions set
Jun 14 11:53:25 volumio volumio[14088]: info: MPD Permissions set
Jun 14 11:53:25 volumio volumio[14088]: info: VolumeController:: Volume=96 Mute =false
Jun 14 11:53:25 volumio volumio[14088]: info: CoreStateMachine::pushState
Jun 14 11:53:25 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:25 volumio volumio[14088]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:25 volumio volumio[14088]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:53:25 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:25 volumio volumio[14088]: 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 14 11:53:25 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:25 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:25 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:25 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:25 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:26 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:26 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:26 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:26 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:26 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:26 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:26 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:26 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:26 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:26 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:26 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:26 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:26 volumio volumio[14088]: info: Discovery: Connected to remote: 192.168.88.16
Jun 14 11:53:26 volumio volumio[14088]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 14 11:53:26 volumio volumio[14088]: info: Starting Shairport Sync
Jun 14 11:53:26 volumio volumio[14088]: info: Starting Shairport Sync
Jun 14 11:53:26 volumio volumio[14088]: info: Starting Shairport Sync
Jun 14 11:53:26 volumio sudo[14256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 14 11:53:26 volumio sudo[14256]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:26 volumio sudo[14258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 14 11:53:26 volumio sudo[14258]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:26 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 14 11:53:26 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 14 11:53:26 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:53:26 volumio sudo[14261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 14 11:53:26 volumio sudo[14261]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:26 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:26 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:26 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:53:26 volumio sudo[14256]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:26 volumio volumio[14088]: info: Shairport-Sync Started
Jun 14 11:53:26 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 14 11:53:26 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Jun 14 11:53:26 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 14 11:53:26 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:53:26 volumio volumio[14088]: Error adding Membership: Error: addMembership EINVAL
Jun 14 11:53:26 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:53:26 volumio sudo[14258]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:26 volumio sudo[14261]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:26 volumio volumio[14088]: info: Shairport-Sync Started
Jun 14 11:53:26 volumio volumio[14088]: info: Shairport-Sync Started
Jun 14 11:53:26 volumio mpd[14209]: Jun 14 11:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 14 11:53:26 volumio systemd[1]: Started Music Player Daemon.
Jun 14 11:53:26 volumio sudo[14198]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:26 volumio sudo[14188]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:27 volumio volumio[14088]: info: Completed starting Core Plugins
Jun 14 11:53:27 volumio volumio[14088]: info: -------------------------------------------
Jun 14 11:53:27 volumio volumio[14088]: info: ----- MyVolumio plugins startup ----
Jun 14 11:53:27 volumio volumio[14088]: info: -------------------------------------------
Jun 14 11:53:27 volumio volumio[14088]: info: [MyVolumio PluginManager] Fetching plans data....
Jun 14 11:53:27 volumio volumio[14088]: error: MPD error: The expression evaluated to a falsy value:
Jun 14 11:53:27 volumio volumio[14088]: assert.ok(self.idling)
Jun 14 11:53:27 volumio volumio[14088]: error: The expression evaluated to a falsy value:
Jun 14 11:53:27 volumio volumio[14088]: assert.ok(self.idling)
Jun 14 11:53:27 volumio volumio[14088]: error: updateQueue error: null
Jun 14 11:53:27 volumio volumio[14088]: info: MPD running with PID14209
Jun 14 11:53:27 volumio volumio[14088]: ,establishing connection
Jun 14 11:53:27 volumio volumio[14088]: error: updateQueue error: null
Jun 14 11:53:28 volumio volumio[14088]: error: Discovery: Generic error: TypeError: argument 8 must be an integer (port)
Jun 14 11:53:28 volumio volumio[14088]: info: Discovery: Started advertising with name: undefined
Jun 14 11:53:28 volumio volumio[14088]: verbose: New Socket.io Connection to 192.168.88.13 from 192.168.88.27 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Jun 14 11:53:28 volumio volumio[14088]: info: Received Get System Info
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:28 volumio volumio[14088]: info: Discovery: Getting this device information
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:28 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:28 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:28 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 14 11:53:28 volumio volumio[14088]: info: Received Get System Info
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:28 volumio volumio[14088]: info: Discovery: Getting this device information
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:28 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:28 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:28 volumio volumio[14088]: info: Listing playlists
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::volumioGetQueue
Jun 14 11:53:28 volumio volumio[14088]: info: CoreStateMachine::getQueue
Jun 14 11:53:28 volumio volumio[14088]: info: CorePlayQueue::getQueue
Jun 14 11:53:28 volumio volumio[14088]: info: Received Get System Info
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:28 volumio volumio[14088]: info: Discovery: Getting this device information
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:28 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:28 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:28 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 14 11:53:28 volumio volumio[14088]: info: Received Get System Info
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:28 volumio volumio[14088]: info: Discovery: Getting this device information
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:28 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:28 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:28 volumio volumio[14088]: info: Listing playlists
Jun 14 11:53:28 volumio volumio[14088]: info: CoreCommandRouter::volumioGetQueue
Jun 14 11:53:28 volumio volumio[14088]: info: CoreStateMachine::getQueue
Jun 14 11:53:28 volumio volumio[14088]: info: CorePlayQueue::getQueue
Jun 14 11:53:29 volumio volumio[14088]: info: Received Get System Info
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:29 volumio volumio[14088]: info: Discovery: Getting this device information
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:29 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:29 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:29 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 14 11:53:29 volumio volumio[14088]: info: Received Get System Info
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:29 volumio volumio[14088]: info: Discovery: Getting this device information
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:29 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:29 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:29 volumio volumio[14088]: info: Listing playlists
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::volumioGetQueue
Jun 14 11:53:29 volumio volumio[14088]: info: CoreStateMachine::getQueue
Jun 14 11:53:29 volumio volumio[14088]: info: CorePlayQueue::getQueue
Jun 14 11:53:29 volumio volumio[14088]: info: Received Get System Info
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:29 volumio volumio[14088]: info: Discovery: Getting this device information
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:29 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:29 volumio volumio[14088]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:29 volumio volumio[14088]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:32 volumio volumio[14088]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Jun 14 11:53:32 volumio volumio[14088]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 14 11:53:32 volumio volumio[14088]: TypeError: Cannot read property 'charAt' of undefined
Jun 14 11:53:32 volumio volumio[14088]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:199:24)
Jun 14 11:53:32 volumio volumio[14088]: at listOnTimeout (internal/timers.js:554:17)
Jun 14 11:53:32 volumio volumio[14088]: at processTimers (internal/timers.js:497:7)
Jun 14 11:53:32 volumio volumio[14088]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 14 11:53:32 volumio sudo[14295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-14 11:52
Jun 14 11:53:32 volumio sudo[14295]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:33 volumio sudo[14295]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:33 volumio volumio-remote-updater[558]: [2025-06-14 11:53:33] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jun 14 11:53:33 volumio volumio-remote-updater[558]: [2025-06-14 11:53:33] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jun 14 11:53:33 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Jun 14 11:53:33 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Jun 14 11:53:33 volumio systemd[1]: Started dynamicswap service.
Jun 14 11:53:33 volumio systemd[1]: dynamicswap.service: Succeeded.
Jun 14 11:53:33 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Jun 14 11:53:33 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 54.
Jun 14 11:53:33 volumio systemd[1]: Stopped Volumio Backend Module.
Jun 14 11:53:33 volumio systemd[1]: Started Volumio Backend Module.
Jun 14 11:53:33 volumio systemd[1]: Started dynamicswap service.
Jun 14 11:53:33 volumio systemd[1]: dynamicswap.service: Succeeded.
Jun 14 11:53:35 volumio volumio[14308]: info: -------------------------------------------
Jun 14 11:53:35 volumio volumio[14308]: info: ----- Volumio3 ----
Jun 14 11:53:35 volumio volumio[14308]: info: -------------------------------------------
Jun 14 11:53:35 volumio volumio[14308]: info: ----- System startup ----
Jun 14 11:53:35 volumio volumio[14308]: info: -------------------------------------------
Jun 14 11:53:35 volumio volumio[14308]: info: MYVOLUMIO Environment detected
Jun 14 11:53:35 volumio volumio[14308]: info: Plugin folders cleanup
Jun 14 11:53:35 volumio volumio[14308]: info: Scanning into folder /volumio/app/plugins/
Jun 14 11:53:35 volumio volumio[14308]: info: Scanning category audio_interface
Jun 14 11:53:35 volumio volumio[14308]: info: Scanning category miscellanea
Jun 14 11:53:35 volumio volumio[14308]: info: Scanning category music_service
Jun 14 11:53:35 volumio volumio[14308]: info: Scanning category plugins.json
Jun 14 11:53:35 volumio volumio[14308]: info: Scanning category system_controller
Jun 14 11:53:35 volumio volumio[14308]: info: Scanning category user_interface
Jun 14 11:53:35 volumio volumio[14308]: info: Scanning into folder /data/plugins/
Jun 14 11:53:35 volumio volumio[14308]: info: Scanning category audio_interface
Jun 14 11:53:35 volumio volumio[14308]: info: Scanning category music_service
Jun 14 11:53:35 volumio volumio[14308]: info: Scanning category system_controller
Jun 14 11:53:35 volumio volumio[14308]: info: Scanning category user_interface
Jun 14 11:53:35 volumio volumio[14308]: info: Plugin folders cleanup completed
Jun 14 11:53:35 volumio volumio[14308]: info: -------------------------------------------
Jun 14 11:53:35 volumio volumio[14308]: info: ----- Core plugins startup ----
Jun 14 11:53:35 volumio volumio[14308]: info: -------------------------------------------
Jun 14 11:53:35 volumio volumio[14308]: info: Loading plugins from folder /volumio/app/plugins/
Jun 14 11:53:35 volumio volumio[14308]: info: Adding plugin upnp to MyMusic Plugins
Jun 14 11:53:35 volumio volumio[14308]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 14 11:53:35 volumio volumio[14308]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 14 11:53:35 volumio volumio[14308]: info: Loading plugins from folder /data/plugins/
Jun 14 11:53:35 volumio volumio[14308]: info: Loading plugin "system"...
Jun 14 11:53:35 volumio volumio[14308]: info: Loading plugin "appearance"...
Jun 14 11:53:36 volumio volumio[14308]: info: Loading plugin "network"...
Jun 14 11:53:36 volumio volumio[14308]: info: Refreshing Cached IP Addresses
Jun 14 11:53:36 volumio sudo[14336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 14 11:53:36 volumio sudo[14336]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:36 volumio sudo[14336]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:36 volumio sudo[14338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 14 11:53:36 volumio sudo[14338]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:36 volumio sudo[14338]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:36 volumio volumio[14308]: info: Loading plugin "services"...
Jun 14 11:53:36 volumio volumio[14308]: info: Loading plugin "alsa_controller"...
Jun 14 11:53:36 volumio sudo[14351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 14 11:53:36 volumio sudo[14351]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:37 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 14 11:53:37 volumio volumio[14308]: info: Loading plugin "wizard"...
Jun 14 11:53:37 volumio volumio[14308]: info: Loading plugin "networkfs"...
Jun 14 11:53:37 volumio volumio[14308]: info: Starting Udev Watcher for removable devices
Jun 14 11:53:37 volumio volumio[14308]: info: Ignoring mount for partition: boot
Jun 14 11:53:37 volumio volumio[14308]: info: Ignoring mount for partition: volumio
Jun 14 11:53:37 volumio volumio[14308]: info: Ignoring mount for partition: volumio_data
Jun 14 11:53:37 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 14 11:53:37 volumio volumio[14308]: info: Loading plugin "volumio_command_line_client"...
Jun 14 11:53:37 volumio volumio[14308]: info: Loading plugin "upnp"...
Jun 14 11:53:37 volumio volumio[14308]: info: [1749884017154] Starting Upmpd Daemon
Jun 14 11:53:37 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 14 11:53:37 volumio volumio[14308]: info: Loading plugin "my_music"...
Jun 14 11:53:37 volumio volumio[14308]: info: Loading plugin "mpd"...
Jun 14 11:53:37 volumio volumio[14308]: info: Loading plugin "upnp_browser"...
Jun 14 11:53:37 volumio volumio[14308]: info: Loading plugin "alarm-clock"...
Jun 14 11:53:37 volumio sudo[14351]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:37 volumio volumio[14308]: info: Loading plugin "airplay_emulation"...
Jun 14 11:53:37 volumio volumio[14308]: info: Starting Shairport Sync
Jun 14 11:53:37 volumio volumio[14308]: info: Loading plugin "last_100"...
Jun 14 11:53:38 volumio volumio[14308]: info: Loading plugin "webradio"...
Jun 14 11:53:38 volumio volumio[14308]: info: Loading plugin "i2s_dacs"...
Jun 14 11:53:38 volumio volumio[14308]: info: Loading plugin "volumiodiscovery"...
Jun 14 11:53:38 volumio volumio-remote-updater[558]: [2025-06-14 11:53:38] [connect] Successful connection
Jun 14 11:53:38 volumio volumio[14308]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:38 volumio volumio[14308]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:38 volumio volumio[14308]: *** WARNING *** For more information see
Jun 14 11:53:38 volumio node[14308]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:38 volumio volumio[14308]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:38 volumio volumio[14308]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:38 volumio volumio[14308]: *** WARNING *** For more information see
Jun 14 11:53:38 volumio node[14308]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:38 volumio node[14308]: *** WARNING *** For more information see
Jun 14 11:53:38 volumio node[14308]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:38 volumio node[14308]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:38 volumio node[14308]: *** WARNING *** For more information see
Jun 14 11:53:38 volumio volumio[14308]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 14 11:53:38 volumio volumio[14308]: info: Discovery: Started advertising with name: undefined
Jun 14 11:53:38 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 14 11:53:38 volumio volumio[14308]: info: Plugin autostart is not enabled
Jun 14 11:53:38 volumio volumio[14308]: info: Loading plugin "outputs"...
Jun 14 11:53:38 volumio volumio[14308]: info: Loading plugin "albumart"...
Jun 14 11:53:38 volumio volumio[14308]: info: Plugin example_plugin is not enabled
Jun 14 11:53:38 volumio volumio[14308]: info: Loading plugin "inputs"...
Jun 14 11:53:38 volumio volumio[14308]: info: Loading plugin "updater_comm"...
Jun 14 11:53:38 volumio volumio[14308]: info: Plugin mpdemulation is not enabled
Jun 14 11:53:38 volumio volumio[14308]: info: Loading plugin "rest_api"...
Jun 14 11:53:38 volumio volumio[14308]: info: Loading plugin "websocket"...
Jun 14 11:53:38 volumio volumio[14308]: info: Starting Socket.io Server version 2.3.0
Jun 14 11:53:38 volumio volumio[14308]: info: Plugin fusiondsp is not enabled
Jun 14 11:53:38 volumio volumio[14308]: info: Plugin yandex_music is not enabled
Jun 14 11:53:38 volumio volumio[14308]: info: Plugin touch_display is not enabled
Jun 14 11:53:38 volumio volumio[14308]: info: Loading i18n strings for locale ru
Jun 14 11:53:38 volumio volumio[14308]: Updating browse sources language
Jun 14 11:53:38 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:38 volumio volumio[14308]: Forking 3 albumart workers
Jun 14 11:53:38 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 14 11:53:38 volumio volumio[14308]: info: CoreCommandRouter::initPlayerControls
Jun 14 11:53:38 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:38 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:38 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:38 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:38 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:38 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:38 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:38 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:38 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 14 11:53:38 volumio volumio[14308]: Express server listening on port 3000
Jun 14 11:53:38 volumio volumio[14308]: [Metrics] WebUI: 4s 426.36ms
Jun 14 11:53:38 volumio volumio[14308]: info: CoreStateMachine::resetVolumioState
Jun 14 11:53:38 volumio volumio[14308]: info: CoreStateMachine::getcurrentVolume
Jun 14 11:53:38 volumio volumio[14308]: info: CoreCommandRouter::volumioRetrievevolume
Jun 14 11:53:39 volumio volumio[14308]: info: Volumio Network Manager: Network status updated: 2
Jun 14 11:53:39 volumio volumio[14308]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Jun 14 11:53:39 volumio volumio[14308]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2
Jun 14 11:53:39 volumio volumio-remote-updater[558]: [2025-06-14 11:53:39] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1749884018 101
Jun 14 11:53:39 volumio volumio[14308]: 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: 3
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:39 volumio volumio[14308]: info: Reloading queue from file
Jun 14 11:53:39 volumio volumio[14308]: info: CoreStateMachine::setRepeat null single undefined
Jun 14 11:53:39 volumio volumio[14308]: info: CoreStateMachine::pushState
Jun 14 11:53:39 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:39 volumio volumio[14308]: info: CoreStateMachine::setRandom null
Jun 14 11:53:39 volumio volumio[14308]: info: CoreStateMachine::pushState
Jun 14 11:53:39 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:39 volumio volumio[14308]: info: Setting Device type: Raspberry PI
Jun 14 11:53:39 volumio volumio[14308]: info: Completed loading Core Plugins
Jun 14 11:53:39 volumio volumio[14308]: info: Preparing to generate the ALSA configuration file
Jun 14 11:53:39 volumio volumio[14308]: info: VolumeController:: Volume=96 Mute =false
Jun 14 11:53:39 volumio volumio[14308]: info: CoreStateMachine::pushState
Jun 14 11:53:39 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:39 volumio volumio[14308]: info: CoreStateMachine::updateTrackBlock
Jun 14 11:53:39 volumio volumio[14308]: info: CorePlayQueue::getTrackBlock
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::volumioRetrievevolume
Jun 14 11:53:39 volumio volumio[14308]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Jun 14 11:53:39 volumio volumio[14308]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082
Jun 14 11:53:39 volumio volumio[14308]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Jun 14 11:53:39 volumio volumio[14308]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Jun 14 11:53:39 volumio volumio[14308]: info: Reading ALSA contributions from plugins.
Jun 14 11:53:39 volumio volumio[14308]: info: Discovery: adding 8d09537b-2a8b-40c5-aafd-b4ed981ad133
Jun 14 11:53:39 volumio volumio[14308]: info: Discovery: Found device Volumio
Jun 14 11:53:39 volumio volumio[14308]: info: Discovery: Connecting to remote: 192.168.88.16
Jun 14 11:53:39 volumio volumio[14308]: info: Asound.conf file unchanged, so no further update is needed
Jun 14 11:53:39 volumio volumio[14308]: info: Output device has changed, restarting MPD
Jun 14 11:53:39 volumio volumio[14308]: info: Output device has changed, restarting Shairport Sync
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:39 volumio sudo[14407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 14 11:53:39 volumio sudo[14407]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:39 volumio sudo[14405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 14 11:53:39 volumio sudo[14405]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:39 volumio sudo[14405]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:39 volumio volumio[14308]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 14 11:53:39 volumio volumio[14308]: info: ___________ START PLUGINS ___________
Jun 14 11:53:39 volumio volumio[14308]: info: ControllerMpd::onStart: Initializing MPD
Jun 14 11:53:39 volumio systemd[1]: Starting Cleanup of Temporary Directories...
Jun 14 11:53:39 volumio volumio[14308]: info: Creating MPD Configuration file
Jun 14 11:53:39 volumio systemd[1]: Stopping Music Player Daemon...
Jun 14 11:53:39 volumio volumio[14308]: Starting albumart workers
Jun 14 11:53:39 volumio systemd[1]: mpd.service: Succeeded.
Jun 14 11:53:39 volumio systemd[1]: Stopped Music Player Daemon.
Jun 14 11:53:39 volumio sudo[14415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 14 11:53:39 volumio systemd[1]: Starting Music Player Daemon...
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 14 11:53:39 volumio sudo[14415]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 14 11:53:39 volumio volumio[14308]: info: [1749884019813] CoreMusicLibrary::Adding element Медиа-серверы
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:39 volumio sudo[14419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 14 11:53:39 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded.
Jun 14 11:53:39 volumio systemd[1]: Started Cleanup of Temporary Directories.
Jun 14 11:53:39 volumio sudo[14419]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:39 volumio sudo[14415]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:39 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Jun 14 11:53:39 volumio systemd[1]: mpd.service: Succeeded.
Jun 14 11:53:39 volumio systemd[1]: Stopped Music Player Daemon.
Jun 14 11:53:39 volumio volumio[14308]: Starting albumart workers
Jun 14 11:53:39 volumio volumio[14308]: Starting albumart workers
Jun 14 11:53:39 volumio volumio[14308]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:39 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:39 volumio systemd[1]: Starting Music Player Daemon...
Jun 14 11:53:40 volumio volumio[14308]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 14 11:53:40 volumio volumio[14308]: info: [1749884020055] CoreMusicLibrary::Adding element Last_100
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 14 11:53:40 volumio volumio[14308]: info: [1749884020059] CoreMusicLibrary::Adding element Webradio
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 14 11:53:40 volumio volumio[14308]: info: Initializing BBC Radios
Jun 14 11:53:40 volumio sudo[14425]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 14 11:53:40 volumio sudo[14425]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:40 volumio sudo[14425]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:40 volumio volumio[14308]: info: Volumio Calling Home
Jun 14 11:53:40 volumio volumio[14308]: info: Discovery: Connected to remote: 192.168.88.16
Jun 14 11:53:40 volumio volumio[14308]: info: MPD Permissions set
Jun 14 11:53:40 volumio volumio[14308]: info: MPD Permissions set
Jun 14 11:53:40 volumio volumio[14308]: info: VolumeController:: Volume=96 Mute =false
Jun 14 11:53:40 volumio volumio[14308]: info: CoreStateMachine::pushState
Jun 14 11:53:40 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:40 volumio volumio[14308]: 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 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:40 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:41 volumio volumio[14308]: info: Starting Shairport Sync
Jun 14 11:53:41 volumio volumio[14308]: info: Starting Shairport Sync
Jun 14 11:53:41 volumio volumio[14308]: info: Starting Shairport Sync
Jun 14 11:53:41 volumio sudo[14477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 14 11:53:41 volumio sudo[14477]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:41 volumio sudo[14479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 14 11:53:41 volumio sudo[14479]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:41 volumio sudo[14482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 14 11:53:41 volumio sudo[14482]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:41 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 14 11:53:41 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 14 11:53:41 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:53:41 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:41 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:41 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:53:41 volumio sudo[14477]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:41 volumio sudo[14479]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:41 volumio volumio[14308]: info: Shairport-Sync Started
Jun 14 11:53:41 volumio volumio[14308]: Error adding Membership: Error: addMembership EINVAL
Jun 14 11:53:41 volumio volumio[14308]: info: Shairport-Sync Started
Jun 14 11:53:41 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 14 11:53:41 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Jun 14 11:53:41 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 14 11:53:41 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:53:41 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:53:41 volumio sudo[14482]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:41 volumio volumio[14308]: info: Shairport-Sync Started
Jun 14 11:53:41 volumio volumio[14308]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Jun 14 11:53:41 volumio volumio[14308]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:53:41 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:41 volumio volumio[14308]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 14 11:53:42 volumio mpd[14431]: Jun 14 11:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 14 11:53:42 volumio systemd[1]: Started Music Player Daemon.
Jun 14 11:53:42 volumio sudo[14407]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:42 volumio sudo[14419]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:42 volumio volumio[14308]: info: Completed starting Core Plugins
Jun 14 11:53:42 volumio volumio[14308]: info: -------------------------------------------
Jun 14 11:53:42 volumio volumio[14308]: info: ----- MyVolumio plugins startup ----
Jun 14 11:53:42 volumio volumio[14308]: info: -------------------------------------------
Jun 14 11:53:42 volumio volumio[14308]: info: [MyVolumio PluginManager] Fetching plans data....
Jun 14 11:53:42 volumio volumio[14308]: error: MPD error: The expression evaluated to a falsy value:
Jun 14 11:53:42 volumio volumio[14308]: assert.ok(self.idling)
Jun 14 11:53:42 volumio volumio[14308]: error: The expression evaluated to a falsy value:
Jun 14 11:53:42 volumio volumio[14308]: assert.ok(self.idling)
Jun 14 11:53:42 volumio volumio[14308]: info: MPD running with PID14431
Jun 14 11:53:42 volumio volumio[14308]: ,establishing connection
Jun 14 11:53:42 volumio volumio[14308]: error: updateQueue error: null
Jun 14 11:53:42 volumio volumio[14308]: error: updateQueue error: null
Jun 14 11:53:43 volumio volumio[14308]: error: Discovery: Generic error: TypeError: argument 8 must be an integer (port)
Jun 14 11:53:43 volumio volumio[14308]: info: Discovery: Started advertising with name: undefined
Jun 14 11:53:46 volumio volumio[14308]: verbose: New Socket.io Connection to 192.168.88.13 from 192.168.88.27 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Jun 14 11:53:46 volumio volumio[14308]: info: Received Get System Info
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:46 volumio volumio[14308]: info: Discovery: Getting this device information
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:46 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:46 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:46 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 14 11:53:46 volumio volumio[14308]: info: Received Get System Info
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:46 volumio volumio[14308]: info: Discovery: Getting this device information
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:46 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:46 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:46 volumio volumio[14308]: info: Listing playlists
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::volumioGetQueue
Jun 14 11:53:46 volumio volumio[14308]: info: CoreStateMachine::getQueue
Jun 14 11:53:46 volumio volumio[14308]: info: CorePlayQueue::getQueue
Jun 14 11:53:46 volumio volumio[14308]: info: Received Get System Info
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:46 volumio volumio[14308]: info: Discovery: Getting this device information
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:46 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:46 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:46 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 14 11:53:46 volumio volumio[14308]: info: Received Get System Info
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:46 volumio volumio[14308]: info: Discovery: Getting this device information
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:46 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:46 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:46 volumio volumio[14308]: info: Listing playlists
Jun 14 11:53:46 volumio volumio[14308]: info: CoreCommandRouter::volumioGetQueue
Jun 14 11:53:46 volumio volumio[14308]: info: CoreStateMachine::getQueue
Jun 14 11:53:46 volumio volumio[14308]: info: CorePlayQueue::getQueue
Jun 14 11:53:47 volumio volumio[14308]: info: Received Get System Info
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:47 volumio volumio[14308]: info: Discovery: Getting this device information
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:47 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:47 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:47 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 14 11:53:47 volumio volumio[14308]: info: Received Get System Info
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:47 volumio volumio[14308]: info: Discovery: Getting this device information
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:47 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:47 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:47 volumio volumio[14308]: info: Listing playlists
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::volumioGetQueue
Jun 14 11:53:47 volumio volumio[14308]: info: CoreStateMachine::getQueue
Jun 14 11:53:47 volumio volumio[14308]: info: CorePlayQueue::getQueue
Jun 14 11:53:47 volumio volumio[14308]: info: Received Get System Info
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:47 volumio volumio[14308]: info: Discovery: Getting this device information
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:47 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:47 volumio volumio[14308]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:47 volumio volumio[14308]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:47 volumio volumio[14308]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 14 11:53:47 volumio volumio[14308]: TypeError: Cannot read property 'charAt' of undefined
Jun 14 11:53:47 volumio volumio[14308]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:199:24)
Jun 14 11:53:47 volumio volumio[14308]: at listOnTimeout (internal/timers.js:554:17)
Jun 14 11:53:47 volumio volumio[14308]: at processTimers (internal/timers.js:497:7)
Jun 14 11:53:47 volumio volumio[14308]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 14 11:53:47 volumio sudo[14519]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-14 11:52
Jun 14 11:53:47 volumio sudo[14519]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:48 volumio sudo[14519]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:48 volumio volumio-remote-updater[558]: [2025-06-14 11:53:48] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jun 14 11:53:48 volumio volumio-remote-updater[558]: [2025-06-14 11:53:48] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jun 14 11:53:48 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Jun 14 11:53:48 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Jun 14 11:53:48 volumio systemd[1]: Started dynamicswap service.
Jun 14 11:53:48 volumio systemd[1]: dynamicswap.service: Succeeded.
Jun 14 11:53:48 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Jun 14 11:53:48 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 55.
Jun 14 11:53:48 volumio systemd[1]: Stopped Volumio Backend Module.
Jun 14 11:53:48 volumio systemd[1]: Started Volumio Backend Module.
Jun 14 11:53:48 volumio systemd[1]: Started dynamicswap service.
Jun 14 11:53:48 volumio systemd[1]: dynamicswap.service: Succeeded.
Jun 14 11:53:50 volumio volumio[14532]: info: -------------------------------------------
Jun 14 11:53:50 volumio volumio[14532]: info: ----- Volumio3 ----
Jun 14 11:53:50 volumio volumio[14532]: info: -------------------------------------------
Jun 14 11:53:50 volumio volumio[14532]: info: ----- System startup ----
Jun 14 11:53:50 volumio volumio[14532]: info: -------------------------------------------
Jun 14 11:53:51 volumio volumio[14532]: info: MYVOLUMIO Environment detected
Jun 14 11:53:51 volumio volumio[14532]: info: Plugin folders cleanup
Jun 14 11:53:51 volumio volumio[14532]: info: Scanning into folder /volumio/app/plugins/
Jun 14 11:53:51 volumio volumio[14532]: info: Scanning category audio_interface
Jun 14 11:53:51 volumio volumio[14532]: info: Scanning category miscellanea
Jun 14 11:53:51 volumio volumio[14532]: info: Scanning category music_service
Jun 14 11:53:51 volumio volumio[14532]: info: Scanning category plugins.json
Jun 14 11:53:51 volumio volumio[14532]: info: Scanning category system_controller
Jun 14 11:53:51 volumio volumio[14532]: info: Scanning category user_interface
Jun 14 11:53:51 volumio volumio[14532]: info: Scanning into folder /data/plugins/
Jun 14 11:53:51 volumio volumio[14532]: info: Scanning category audio_interface
Jun 14 11:53:51 volumio volumio[14532]: info: Scanning category music_service
Jun 14 11:53:51 volumio volumio[14532]: info: Scanning category system_controller
Jun 14 11:53:51 volumio volumio[14532]: info: Scanning category user_interface
Jun 14 11:53:51 volumio volumio[14532]: info: Plugin folders cleanup completed
Jun 14 11:53:51 volumio volumio[14532]: info: -------------------------------------------
Jun 14 11:53:51 volumio volumio[14532]: info: ----- Core plugins startup ----
Jun 14 11:53:51 volumio volumio[14532]: info: -------------------------------------------
Jun 14 11:53:51 volumio volumio[14532]: info: Loading plugins from folder /volumio/app/plugins/
Jun 14 11:53:51 volumio volumio[14532]: info: Adding plugin upnp to MyMusic Plugins
Jun 14 11:53:51 volumio volumio[14532]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 14 11:53:51 volumio volumio[14532]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 14 11:53:51 volumio volumio[14532]: info: Loading plugins from folder /data/plugins/
Jun 14 11:53:51 volumio volumio[14532]: info: Loading plugin "system"...
Jun 14 11:53:51 volumio volumio[14532]: info: Loading plugin "appearance"...
Jun 14 11:53:52 volumio volumio[14532]: info: Loading plugin "network"...
Jun 14 11:53:52 volumio volumio[14532]: info: Refreshing Cached IP Addresses
Jun 14 11:53:52 volumio sudo[14559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 14 11:53:52 volumio sudo[14559]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:52 volumio sudo[14559]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:52 volumio sudo[14561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 14 11:53:52 volumio sudo[14561]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:52 volumio sudo[14561]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:52 volumio volumio[14532]: info: Loading plugin "services"...
Jun 14 11:53:52 volumio volumio[14532]: info: Loading plugin "alsa_controller"...
Jun 14 11:53:52 volumio sudo[14570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 14 11:53:52 volumio sudo[14570]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:52 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 14 11:53:52 volumio volumio[14532]: info: Loading plugin "wizard"...
Jun 14 11:53:52 volumio volumio[14532]: info: Loading plugin "networkfs"...
Jun 14 11:53:52 volumio volumio[14532]: info: Starting Udev Watcher for removable devices
Jun 14 11:53:52 volumio volumio[14532]: info: Ignoring mount for partition: boot
Jun 14 11:53:52 volumio volumio[14532]: info: Ignoring mount for partition: volumio
Jun 14 11:53:52 volumio volumio[14532]: info: Ignoring mount for partition: volumio_data
Jun 14 11:53:52 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 14 11:53:52 volumio volumio[14532]: info: Loading plugin "volumio_command_line_client"...
Jun 14 11:53:52 volumio volumio[14532]: info: Loading plugin "upnp"...
Jun 14 11:53:52 volumio volumio[14532]: info: [1749884032450] Starting Upmpd Daemon
Jun 14 11:53:52 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 14 11:53:52 volumio volumio[14532]: info: Loading plugin "my_music"...
Jun 14 11:53:52 volumio volumio[14532]: info: Loading plugin "mpd"...
Jun 14 11:53:52 volumio volumio[14532]: info: Loading plugin "upnp_browser"...
Jun 14 11:53:53 volumio volumio[14532]: info: Loading plugin "alarm-clock"...
Jun 14 11:53:53 volumio sudo[14570]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:53 volumio volumio-remote-updater[558]: [2025-06-14 11:53:53] [connect] Successful connection
Jun 14 11:53:53 volumio volumio[14532]: info: Loading plugin "airplay_emulation"...
Jun 14 11:53:53 volumio volumio[14532]: info: Starting Shairport Sync
Jun 14 11:53:53 volumio volumio[14532]: info: Loading plugin "last_100"...
Jun 14 11:53:53 volumio volumio[14532]: info: Loading plugin "webradio"...
Jun 14 11:53:53 volumio volumio[14532]: info: Loading plugin "i2s_dacs"...
Jun 14 11:53:53 volumio volumio[14532]: info: Loading plugin "volumiodiscovery"...
Jun 14 11:53:53 volumio volumio[14532]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:53 volumio volumio[14532]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:53 volumio volumio[14532]: *** WARNING *** For more information see
Jun 14 11:53:53 volumio node[14532]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:53 volumio volumio[14532]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:53 volumio volumio[14532]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:53 volumio volumio[14532]: *** WARNING *** For more information see
Jun 14 11:53:53 volumio node[14532]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:53 volumio node[14532]: *** WARNING *** For more information see
Jun 14 11:53:53 volumio node[14532]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:53:53 volumio node[14532]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:53:53 volumio node[14532]: *** WARNING *** For more information see
Jun 14 11:53:53 volumio volumio[14532]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 14 11:53:53 volumio volumio[14532]: info: Discovery: Started advertising with name: undefined
Jun 14 11:53:53 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 14 11:53:53 volumio volumio[14532]: info: Plugin autostart is not enabled
Jun 14 11:53:53 volumio volumio[14532]: info: Loading plugin "outputs"...
Jun 14 11:53:53 volumio volumio[14532]: info: Loading plugin "albumart"...
Jun 14 11:53:53 volumio volumio[14532]: info: Plugin example_plugin is not enabled
Jun 14 11:53:53 volumio volumio[14532]: info: Loading plugin "inputs"...
Jun 14 11:53:53 volumio volumio[14532]: info: Loading plugin "updater_comm"...
Jun 14 11:53:53 volumio volumio[14532]: info: Plugin mpdemulation is not enabled
Jun 14 11:53:53 volumio volumio[14532]: info: Loading plugin "rest_api"...
Jun 14 11:53:53 volumio volumio[14532]: info: Loading plugin "websocket"...
Jun 14 11:53:53 volumio volumio[14532]: info: Starting Socket.io Server version 2.3.0
Jun 14 11:53:53 volumio volumio[14532]: info: Plugin fusiondsp is not enabled
Jun 14 11:53:53 volumio volumio[14532]: info: Plugin yandex_music is not enabled
Jun 14 11:53:53 volumio volumio[14532]: info: Plugin touch_display is not enabled
Jun 14 11:53:53 volumio volumio[14532]: info: Loading i18n strings for locale ru
Jun 14 11:53:53 volumio volumio[14532]: Updating browse sources language
Jun 14 11:53:53 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:53 volumio volumio[14532]: Forking 3 albumart workers
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::initPlayerControls
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 14 11:53:54 volumio volumio[14532]: Express server listening on port 3000
Jun 14 11:53:54 volumio volumio[14532]: [Metrics] WebUI: 4s 350.40ms
Jun 14 11:53:54 volumio volumio[14532]: info: CoreStateMachine::resetVolumioState
Jun 14 11:53:54 volumio volumio[14532]: info: CoreStateMachine::getcurrentVolume
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::volumioRetrievevolume
Jun 14 11:53:54 volumio volumio[14532]: info: Volumio Network Manager: Network status updated: 2
Jun 14 11:53:54 volumio volumio[14532]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Jun 14 11:53:54 volumio volumio-remote-updater[558]: [2025-06-14 11:53:54] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1749884033 101
Jun 14 11:53:54 volumio volumio[14532]: 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: 2
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:54 volumio volumio[14532]: info: Reloading queue from file
Jun 14 11:53:54 volumio volumio[14532]: info: CoreStateMachine::setRepeat null single undefined
Jun 14 11:53:54 volumio volumio[14532]: info: CoreStateMachine::pushState
Jun 14 11:53:54 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:54 volumio volumio[14532]: info: CoreStateMachine::setRandom null
Jun 14 11:53:54 volumio volumio[14532]: info: CoreStateMachine::pushState
Jun 14 11:53:54 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:54 volumio volumio[14532]: info: Setting Device type: Raspberry PI
Jun 14 11:53:54 volumio volumio[14532]: info: Completed loading Core Plugins
Jun 14 11:53:54 volumio volumio[14532]: info: Preparing to generate the ALSA configuration file
Jun 14 11:53:54 volumio volumio[14532]: info: VolumeController:: Volume=96 Mute =false
Jun 14 11:53:54 volumio volumio[14532]: info: CoreStateMachine::pushState
Jun 14 11:53:54 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:54 volumio volumio[14532]: info: CoreStateMachine::updateTrackBlock
Jun 14 11:53:54 volumio volumio[14532]: info: CorePlayQueue::getTrackBlock
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::volumioRetrievevolume
Jun 14 11:53:54 volumio volumio[14532]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Jun 14 11:53:54 volumio volumio[14532]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082
Jun 14 11:53:54 volumio volumio[14532]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Jun 14 11:53:54 volumio volumio[14532]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Jun 14 11:53:54 volumio volumio[14532]: info: Reading ALSA contributions from plugins.
Jun 14 11:53:54 volumio volumio[14532]: info: Discovery: adding 8d09537b-2a8b-40c5-aafd-b4ed981ad133
Jun 14 11:53:54 volumio volumio[14532]: info: Discovery: Found device Volumio
Jun 14 11:53:54 volumio volumio[14532]: info: Discovery: Connecting to remote: 192.168.88.16
Jun 14 11:53:54 volumio volumio[14532]: info: Asound.conf file unchanged, so no further update is needed
Jun 14 11:53:54 volumio volumio[14532]: info: Output device has changed, restarting MPD
Jun 14 11:53:54 volumio volumio[14532]: info: Output device has changed, restarting Shairport Sync
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:54 volumio sudo[14628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 14 11:53:54 volumio sudo[14628]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:54 volumio sudo[14628]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:54 volumio sudo[14630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 14 11:53:54 volumio sudo[14630]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:54 volumio systemd[1]: Stopping Music Player Daemon...
Jun 14 11:53:54 volumio volumio[14532]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 14 11:53:54 volumio volumio[14532]: info: ___________ START PLUGINS ___________
Jun 14 11:53:54 volumio volumio[14532]: info: ControllerMpd::onStart: Initializing MPD
Jun 14 11:53:54 volumio volumio[14532]: info: Creating MPD Configuration file
Jun 14 11:53:54 volumio systemd[1]: mpd.service: Succeeded.
Jun 14 11:53:54 volumio systemd[1]: Stopped Music Player Daemon.
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 14 11:53:54 volumio volumio[14532]: info: [1749884034957] CoreMusicLibrary::Adding element Медиа-серверы
Jun 14 11:53:54 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:54 volumio sudo[14637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 14 11:53:54 volumio sudo[14637]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:54 volumio systemd[1]: Starting Music Player Daemon...
Jun 14 11:53:54 volumio sudo[14640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 14 11:53:54 volumio sudo[14640]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:55 volumio sudo[14637]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:55 volumio volumio[14532]: Starting albumart workers
Jun 14 11:53:55 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Jun 14 11:53:55 volumio systemd[1]: mpd.service: Succeeded.
Jun 14 11:53:55 volumio systemd[1]: Stopped Music Player Daemon.
Jun 14 11:53:55 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:55 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:55 volumio systemd[1]: Starting Music Player Daemon...
Jun 14 11:53:55 volumio volumio[14532]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 14 11:53:55 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:55 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:55 volumio volumio[14532]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 14 11:53:55 volumio sudo[14643]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 14 11:53:55 volumio sudo[14643]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:55 volumio volumio[14532]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 14 11:53:55 volumio volumio[14532]: Starting albumart workers
Jun 14 11:53:55 volumio volumio[14532]: info: [1749884035191] CoreMusicLibrary::Adding element Last_100
Jun 14 11:53:55 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:55 volumio volumio[14532]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 14 11:53:55 volumio volumio[14532]: info: [1749884035199] CoreMusicLibrary::Adding element Webradio
Jun 14 11:53:55 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:55 volumio sudo[14643]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:55 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 14 11:53:55 volumio volumio[14532]: info: Initializing BBC Radios
Jun 14 11:53:55 volumio volumio[14532]: Starting albumart workers
Jun 14 11:53:55 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 14 11:53:55 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:55 volumio volumio[14532]: info: Volumio Calling Home
Jun 14 11:53:56 volumio volumio[14532]: info: Discovery: Connected to remote: 192.168.88.16
Jun 14 11:53:56 volumio volumio[14532]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Jun 14 11:53:56 volumio volumio[14532]: verbose: New Socket.io Connection to 192.168.88.13 from 192.168.88.27 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Jun 14 11:53:56 volumio volumio[14532]: info: MPD Permissions set
Jun 14 11:53:56 volumio volumio[14532]: info: VolumeController:: Volume=96 Mute =false
Jun 14 11:53:56 volumio volumio[14532]: info: CoreStateMachine::pushState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioPushState
Jun 14 11:53:56 volumio volumio[14532]: info: Received Get System Info
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:56 volumio volumio[14532]: info: Discovery: Getting this device information
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 14 11:53:56 volumio volumio[14532]: info: Received Get System Info
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:56 volumio volumio[14532]: info: Discovery: Getting this device information
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: Listing playlists
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetQueue
Jun 14 11:53:56 volumio volumio[14532]: info: CoreStateMachine::getQueue
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getQueue
Jun 14 11:53:56 volumio volumio[14532]: info: Received Get System Info
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:56 volumio volumio[14532]: info: Discovery: Getting this device information
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 14 11:53:56 volumio volumio[14532]: info: Received Get System Info
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:56 volumio volumio[14532]: info: Discovery: Getting this device information
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: Listing playlists
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetQueue
Jun 14 11:53:56 volumio volumio[14532]: info: CoreStateMachine::getQueue
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getQueue
Jun 14 11:53:56 volumio volumio[14532]: info: Received Get System Info
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:56 volumio volumio[14532]: info: Discovery: Getting this device information
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 14 11:53:56 volumio volumio[14532]: info: Received Get System Info
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:56 volumio volumio[14532]: info: Discovery: Getting this device information
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: Listing playlists
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetQueue
Jun 14 11:53:56 volumio volumio[14532]: info: CoreStateMachine::getQueue
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getQueue
Jun 14 11:53:56 volumio volumio[14532]: info: Received Get System Info
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:53:56 volumio volumio[14532]: info: Discovery: Getting this device information
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:56 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:56 volumio volumio[14532]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:53:56 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:53:57 volumio volumio[14532]: info: Starting Shairport Sync
Jun 14 11:53:57 volumio volumio[14532]: info: Starting Shairport Sync
Jun 14 11:53:57 volumio sudo[14715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 14 11:53:57 volumio sudo[14715]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:57 volumio volumio[14532]: info: Starting Shairport Sync
Jun 14 11:53:57 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 14 11:53:57 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 14 11:53:57 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:53:57 volumio sudo[14726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 14 11:53:57 volumio sudo[14726]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:57 volumio mpd[14651]: Jun 14 11:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 14 11:53:57 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:53:57 volumio sudo[14736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 14 11:53:57 volumio sudo[14736]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:53:57 volumio systemd[1]: Started Music Player Daemon.
Jun 14 11:53:57 volumio sudo[14640]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:57 volumio sudo[14630]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:57 volumio sudo[14715]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:57 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 14 11:53:57 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 14 11:53:57 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:53:57 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:53:57 volumio sudo[14726]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:57 volumio sudo[14736]: pam_unix(sudo:session): session closed for user root
Jun 14 11:53:58 volumio volumio[14532]: info: CoreCommandRouter::volumioGetState
Jun 14 11:53:58 volumio volumio[14532]: info: CorePlayQueue::getTrack 0
Jun 14 11:53:58 volumio volumio[14532]: info: Shairport-Sync Started
Jun 14 11:53:58 volumio volumio[14532]: Error adding Membership: Error: addMembership EINVAL
Jun 14 11:53:58 volumio volumio[14532]: info: Shairport-Sync Started
Jun 14 11:53:58 volumio volumio[14532]: info: Shairport-Sync Started
Jun 14 11:53:58 volumio volumio[14532]: info: Completed starting Core Plugins
Jun 14 11:53:58 volumio volumio[14532]: info: -------------------------------------------
Jun 14 11:53:58 volumio volumio[14532]: info: ----- MyVolumio plugins startup ----
Jun 14 11:53:58 volumio volumio[14532]: info: -------------------------------------------
Jun 14 11:53:58 volumio volumio[14532]: info: [MyVolumio PluginManager] Fetching plans data....
Jun 14 11:53:58 volumio volumio[14532]: error: MPD error: The expression evaluated to a falsy value:
Jun 14 11:53:58 volumio volumio[14532]: assert.ok(self.idling)
Jun 14 11:53:58 volumio volumio[14532]: error: The expression evaluated to a falsy value:
Jun 14 11:53:58 volumio volumio[14532]: assert.ok(self.idling)
Jun 14 11:53:58 volumio volumio[14532]: info: MPD running with PID14651
Jun 14 11:53:58 volumio volumio[14532]: ,establishing connection
Jun 14 11:53:58 volumio volumio[14532]: error: updateQueue error: null
Jun 14 11:53:58 volumio volumio[14532]: error: Discovery: Generic error: TypeError: argument 8 must be an integer (port)
Jun 14 11:53:58 volumio volumio[14532]: info: Discovery: Started advertising with name: undefined
Jun 14 11:53:58 volumio volumio[14532]: error: updateQueue error: null
Jun 14 11:54:00 volumio volumio[14532]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Jun 14 11:54:00 volumio volumio[14532]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:54:00 volumio volumio[14532]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:54:00 volumio volumio[14532]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 14 11:54:02 volumio volumio[14532]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 14 11:54:02 volumio volumio[14532]: TypeError: Cannot read property 'charAt' of undefined
Jun 14 11:54:02 volumio volumio[14532]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:199:24)
Jun 14 11:54:02 volumio volumio[14532]: at listOnTimeout (internal/timers.js:554:17)
Jun 14 11:54:02 volumio volumio[14532]: at processTimers (internal/timers.js:497:7)
Jun 14 11:54:02 volumio volumio[14532]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 14 11:54:03 volumio sudo[14784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-14 11:53
Jun 14 11:54:03 volumio sudo[14784]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:54:03 volumio sudo[14784]: pam_unix(sudo:session): session closed for user root
Jun 14 11:54:03 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Jun 14 11:54:03 volumio volumio-remote-updater[558]: [2025-06-14 11:54:03] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jun 14 11:54:03 volumio volumio-remote-updater[558]: [2025-06-14 11:54:03] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jun 14 11:54:03 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Jun 14 11:54:03 volumio systemd[1]: Started dynamicswap service.
Jun 14 11:54:03 volumio systemd[1]: dynamicswap.service: Succeeded.
Jun 14 11:54:03 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Jun 14 11:54:03 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 56.
Jun 14 11:54:03 volumio systemd[1]: Stopped Volumio Backend Module.
Jun 14 11:54:03 volumio systemd[1]: Started Volumio Backend Module.
Jun 14 11:54:03 volumio systemd[1]: Started dynamicswap service.
Jun 14 11:54:03 volumio systemd[1]: dynamicswap.service: Succeeded.
Jun 14 11:54:05 volumio volumio[14797]: info: -------------------------------------------
Jun 14 11:54:05 volumio volumio[14797]: info: ----- Volumio3 ----
Jun 14 11:54:05 volumio volumio[14797]: info: -------------------------------------------
Jun 14 11:54:05 volumio volumio[14797]: info: ----- System startup ----
Jun 14 11:54:05 volumio volumio[14797]: info: -------------------------------------------
Jun 14 11:54:06 volumio volumio[14797]: info: MYVOLUMIO Environment detected
Jun 14 11:54:06 volumio volumio[14797]: info: Plugin folders cleanup
Jun 14 11:54:06 volumio volumio[14797]: info: Scanning into folder /volumio/app/plugins/
Jun 14 11:54:06 volumio volumio[14797]: info: Scanning category audio_interface
Jun 14 11:54:06 volumio volumio[14797]: info: Scanning category miscellanea
Jun 14 11:54:06 volumio volumio[14797]: info: Scanning category music_service
Jun 14 11:54:06 volumio volumio[14797]: info: Scanning category plugins.json
Jun 14 11:54:06 volumio volumio[14797]: info: Scanning category system_controller
Jun 14 11:54:06 volumio volumio[14797]: info: Scanning category user_interface
Jun 14 11:54:06 volumio volumio[14797]: info: Scanning into folder /data/plugins/
Jun 14 11:54:06 volumio volumio[14797]: info: Scanning category audio_interface
Jun 14 11:54:06 volumio volumio[14797]: info: Scanning category music_service
Jun 14 11:54:06 volumio volumio[14797]: info: Scanning category system_controller
Jun 14 11:54:06 volumio volumio[14797]: info: Scanning category user_interface
Jun 14 11:54:06 volumio volumio[14797]: info: Plugin folders cleanup completed
Jun 14 11:54:06 volumio volumio[14797]: info: -------------------------------------------
Jun 14 11:54:06 volumio volumio[14797]: info: ----- Core plugins startup ----
Jun 14 11:54:06 volumio volumio[14797]: info: -------------------------------------------
Jun 14 11:54:06 volumio volumio[14797]: info: Loading plugins from folder /volumio/app/plugins/
Jun 14 11:54:06 volumio volumio[14797]: info: Adding plugin upnp to MyMusic Plugins
Jun 14 11:54:06 volumio volumio[14797]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 14 11:54:06 volumio volumio[14797]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 14 11:54:06 volumio volumio[14797]: info: Loading plugins from folder /data/plugins/
Jun 14 11:54:06 volumio volumio[14797]: info: Loading plugin "system"...
Jun 14 11:54:06 volumio volumio[14797]: info: Loading plugin "appearance"...
Jun 14 11:54:07 volumio volumio[14797]: info: Loading plugin "network"...
Jun 14 11:54:07 volumio volumio[14797]: info: Refreshing Cached IP Addresses
Jun 14 11:54:07 volumio sudo[14852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 14 11:54:07 volumio sudo[14852]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:54:07 volumio sudo[14852]: pam_unix(sudo:session): session closed for user root
Jun 14 11:54:07 volumio sudo[14854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 14 11:54:07 volumio sudo[14854]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:54:07 volumio sudo[14854]: pam_unix(sudo:session): session closed for user root
Jun 14 11:54:07 volumio volumio[14797]: info: Loading plugin "services"...
Jun 14 11:54:07 volumio volumio[14797]: info: Loading plugin "alsa_controller"...
Jun 14 11:54:07 volumio sudo[14867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 14 11:54:07 volumio sudo[14867]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:54:07 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 14 11:54:07 volumio volumio[14797]: info: Loading plugin "wizard"...
Jun 14 11:54:07 volumio volumio[14797]: info: Loading plugin "networkfs"...
Jun 14 11:54:07 volumio volumio[14797]: info: Starting Udev Watcher for removable devices
Jun 14 11:54:07 volumio volumio[14797]: info: Ignoring mount for partition: boot
Jun 14 11:54:07 volumio volumio[14797]: info: Ignoring mount for partition: volumio
Jun 14 11:54:07 volumio volumio[14797]: info: Ignoring mount for partition: volumio_data
Jun 14 11:54:07 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 14 11:54:07 volumio volumio[14797]: info: Loading plugin "volumio_command_line_client"...
Jun 14 11:54:07 volumio volumio[14797]: info: Loading plugin "upnp"...
Jun 14 11:54:07 volumio volumio[14797]: info: [1749884047483] Starting Upmpd Daemon
Jun 14 11:54:07 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 14 11:54:07 volumio volumio[14797]: info: Loading plugin "my_music"...
Jun 14 11:54:07 volumio volumio[14797]: info: Loading plugin "mpd"...
Jun 14 11:54:07 volumio volumio[14797]: info: Loading plugin "upnp_browser"...
Jun 14 11:54:08 volumio volumio[14797]: info: Loading plugin "alarm-clock"...
Jun 14 11:54:08 volumio sudo[14867]: pam_unix(sudo:session): session closed for user root
Jun 14 11:54:08 volumio volumio[14797]: info: Loading plugin "airplay_emulation"...
Jun 14 11:54:08 volumio volumio-remote-updater[558]: [2025-06-14 11:54:08] [connect] Successful connection
Jun 14 11:54:08 volumio volumio[14797]: info: Starting Shairport Sync
Jun 14 11:54:08 volumio volumio[14797]: info: Loading plugin "last_100"...
Jun 14 11:54:08 volumio volumio[14797]: info: Loading plugin "webradio"...
Jun 14 11:54:08 volumio volumio[14797]: info: Loading plugin "i2s_dacs"...
Jun 14 11:54:08 volumio volumio[14797]: info: Loading plugin "volumiodiscovery"...
Jun 14 11:54:08 volumio volumio[14797]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:54:08 volumio volumio[14797]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:54:08 volumio volumio[14797]: *** WARNING *** For more information see
Jun 14 11:54:08 volumio node[14797]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:54:08 volumio volumio[14797]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:54:08 volumio volumio[14797]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:54:08 volumio volumio[14797]: *** WARNING *** For more information see
Jun 14 11:54:08 volumio node[14797]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:54:08 volumio node[14797]: *** WARNING *** For more information see
Jun 14 11:54:08 volumio node[14797]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 14 11:54:08 volumio node[14797]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 14 11:54:08 volumio node[14797]: *** WARNING *** For more information see
Jun 14 11:54:08 volumio volumio[14797]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 14 11:54:08 volumio volumio[14797]: info: Discovery: Started advertising with name: undefined
Jun 14 11:54:08 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 14 11:54:08 volumio volumio[14797]: info: Plugin autostart is not enabled
Jun 14 11:54:08 volumio volumio[14797]: info: Loading plugin "outputs"...
Jun 14 11:54:08 volumio volumio[14797]: info: Loading plugin "albumart"...
Jun 14 11:54:08 volumio volumio[14797]: info: Plugin example_plugin is not enabled
Jun 14 11:54:08 volumio volumio[14797]: info: Loading plugin "inputs"...
Jun 14 11:54:08 volumio volumio[14797]: info: Loading plugin "updater_comm"...
Jun 14 11:54:08 volumio volumio[14797]: info: Plugin mpdemulation is not enabled
Jun 14 11:54:08 volumio volumio[14797]: info: Loading plugin "rest_api"...
Jun 14 11:54:08 volumio volumio[14797]: info: Loading plugin "websocket"...
Jun 14 11:54:08 volumio volumio[14797]: info: Starting Socket.io Server version 2.3.0
Jun 14 11:54:08 volumio volumio[14797]: info: Plugin fusiondsp is not enabled
Jun 14 11:54:08 volumio volumio[14797]: info: Plugin yandex_music is not enabled
Jun 14 11:54:08 volumio volumio[14797]: info: Plugin touch_display is not enabled
Jun 14 11:54:08 volumio volumio[14797]: info: Loading i18n strings for locale ru
Jun 14 11:54:08 volumio volumio[14797]: Updating browse sources language
Jun 14 11:54:08 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:54:08 volumio volumio[14797]: Forking 3 albumart workers
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::initPlayerControls
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 14 11:54:09 volumio volumio[14797]: Express server listening on port 3000
Jun 14 11:54:09 volumio volumio[14797]: [Metrics] WebUI: 4s 338.94ms
Jun 14 11:54:09 volumio volumio[14797]: info: CoreStateMachine::resetVolumioState
Jun 14 11:54:09 volumio volumio[14797]: info: CoreStateMachine::getcurrentVolume
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::volumioRetrievevolume
Jun 14 11:54:09 volumio volumio[14797]: info: Volumio Network Manager: Network status updated: 2
Jun 14 11:54:09 volumio volumio[14797]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Jun 14 11:54:09 volumio volumio-remote-updater[558]: [2025-06-14 11:54:09] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1749884048 101
Jun 14 11:54:09 volumio volumio[14797]: 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: 2
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:54:09 volumio volumio[14797]: info: Reloading queue from file
Jun 14 11:54:09 volumio volumio[14797]: info: VolumeController:: Volume=96 Mute =false
Jun 14 11:54:09 volumio volumio[14797]: info: CoreStateMachine::pushState
Jun 14 11:54:09 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::volumioPushState
Jun 14 11:54:09 volumio volumio[14797]: info: CoreStateMachine::updateTrackBlock
Jun 14 11:54:09 volumio volumio[14797]: info: CorePlayQueue::getTrackBlock
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::volumioRetrievevolume
Jun 14 11:54:09 volumio volumio[14797]: info: CoreStateMachine::setRepeat null single undefined
Jun 14 11:54:09 volumio volumio[14797]: info: CoreStateMachine::pushState
Jun 14 11:54:09 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::volumioPushState
Jun 14 11:54:09 volumio volumio[14797]: info: CoreStateMachine::setRandom null
Jun 14 11:54:09 volumio volumio[14797]: info: CoreStateMachine::pushState
Jun 14 11:54:09 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::volumioPushState
Jun 14 11:54:09 volumio volumio[14797]: info: Setting Device type: Raspberry PI
Jun 14 11:54:09 volumio volumio[14797]: info: Completed loading Core Plugins
Jun 14 11:54:09 volumio volumio[14797]: info: Preparing to generate the ALSA configuration file
Jun 14 11:54:09 volumio volumio[14797]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Jun 14 11:54:09 volumio volumio[14797]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082
Jun 14 11:54:09 volumio volumio[14797]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Jun 14 11:54:09 volumio volumio[14797]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Jun 14 11:54:09 volumio volumio[14797]: info: Reading ALSA contributions from plugins.
Jun 14 11:54:09 volumio volumio[14797]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
Jun 14 11:54:09 volumio volumio[14797]: info: Asound.conf file unchanged, so no further update is needed
Jun 14 11:54:09 volumio volumio[14797]: info: Output device has changed, restarting MPD
Jun 14 11:54:09 volumio sudo[14921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 14 11:54:09 volumio sudo[14921]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:54:09 volumio sudo[14921]: pam_unix(sudo:session): session closed for user root
Jun 14 11:54:09 volumio volumio[14797]: info: Output device has changed, restarting Shairport Sync
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:54:09 volumio sudo[14924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 14 11:54:09 volumio sudo[14924]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:54:09 volumio systemd[1]: Stopping Music Player Daemon...
Jun 14 11:54:09 volumio volumio[14797]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 14 11:54:09 volumio volumio[14797]: info: ___________ START PLUGINS ___________
Jun 14 11:54:09 volumio volumio[14797]: info: ControllerMpd::onStart: Initializing MPD
Jun 14 11:54:09 volumio volumio[14797]: info: Creating MPD Configuration file
Jun 14 11:54:09 volumio systemd[1]: mpd.service: Succeeded.
Jun 14 11:54:09 volumio systemd[1]: Stopped Music Player Daemon.
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 14 11:54:09 volumio sudo[14930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 14 11:54:09 volumio sudo[14930]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 14 11:54:09 volumio volumio[14797]: info: [1749884049869] CoreMusicLibrary::Adding element Медиа-серверы
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:54:09 volumio sudo[14933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 14 11:54:09 volumio systemd[1]: Starting Music Player Daemon...
Jun 14 11:54:09 volumio sudo[14933]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:54:09 volumio sudo[14930]: pam_unix(sudo:session): session closed for user root
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:09 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:54:09 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Jun 14 11:54:09 volumio systemd[1]: mpd.service: Succeeded.
Jun 14 11:54:09 volumio systemd[1]: Stopped Music Player Daemon.
Jun 14 11:54:09 volumio systemd[1]: Starting Music Player Daemon...
Jun 14 11:54:09 volumio volumio[14797]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 14 11:54:10 volumio volumio[14797]: info: [1749884050065] CoreMusicLibrary::Adding element Last_100
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 14 11:54:10 volumio volumio[14797]: info: [1749884050069] CoreMusicLibrary::Adding element Webradio
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 14 11:54:10 volumio volumio[14797]: info: Initializing BBC Radios
Jun 14 11:54:10 volumio sudo[14939]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 14 11:54:10 volumio sudo[14939]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:54:10 volumio sudo[14939]: pam_unix(sudo:session): session closed for user root
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: Volumio Calling Home
Jun 14 11:54:10 volumio volumio[14797]: Starting albumart workers
Jun 14 11:54:10 volumio volumio[14797]: Starting albumart workers
Jun 14 11:54:10 volumio volumio[14797]: Starting albumart workers
Jun 14 11:54:10 volumio volumio[14797]: info: MPD Permissions set
Jun 14 11:54:10 volumio volumio[14797]: info: MPD Permissions set
Jun 14 11:54:10 volumio volumio[14797]: info: VolumeController:: Volume=96 Mute =false
Jun 14 11:54:10 volumio volumio[14797]: info: CoreStateMachine::pushState
Jun 14 11:54:10 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::volumioPushState
Jun 14 11:54:10 volumio volumio[14797]: 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 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 14 11:54:10 volumio volumio[14797]: info: Volumio called home
Jun 14 11:54:10 volumio volumio[14797]: info: Starting Shairport Sync
Jun 14 11:54:10 volumio volumio[14797]: info: Starting Shairport Sync
Jun 14 11:54:10 volumio sudo[14967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 14 11:54:10 volumio sudo[14967]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:54:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 14 11:54:10 volumio volumio[14797]: info: Starting Shairport Sync
Jun 14 11:54:10 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 14 11:54:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:54:10 volumio sudo[14970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 14 11:54:10 volumio sudo[14970]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:54:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:54:11 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:11 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 14 11:54:11 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 14 11:54:11 volumio sudo[14967]: pam_unix(sudo:session): session closed for user root
Jun 14 11:54:11 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:54:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:54:11 volumio sudo[14970]: pam_unix(sudo:session): session closed for user root
Jun 14 11:54:11 volumio sudo[14974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 14 11:54:11 volumio sudo[14974]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 14 11:54:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 14 11:54:11 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 14 11:54:11 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:54:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 14 11:54:11 volumio sudo[14974]: pam_unix(sudo:session): session closed for user root
Jun 14 11:54:11 volumio volumio[14797]: info: Shairport-Sync Started
Jun 14 11:54:11 volumio volumio[14797]: Error adding Membership: Error: addMembership EINVAL
Jun 14 11:54:11 volumio volumio[14797]: info: Shairport-Sync Started
Jun 14 11:54:11 volumio volumio[14797]: info: Shairport-Sync Started
Jun 14 11:54:12 volumio mpd[14945]: Jun 14 11:54 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 14 11:54:12 volumio systemd[1]: Started Music Player Daemon.
Jun 14 11:54:12 volumio sudo[14933]: pam_unix(sudo:session): session closed for user root
Jun 14 11:54:12 volumio sudo[14924]: pam_unix(sudo:session): session closed for user root
Jun 14 11:54:12 volumio volumio[14797]: info: Completed starting Core Plugins
Jun 14 11:54:12 volumio volumio[14797]: info: -------------------------------------------
Jun 14 11:54:12 volumio volumio[14797]: info: ----- MyVolumio plugins startup ----
Jun 14 11:54:12 volumio volumio[14797]: info: -------------------------------------------
Jun 14 11:54:12 volumio volumio[14797]: info: [MyVolumio PluginManager] Fetching plans data....
Jun 14 11:54:12 volumio volumio[14797]: error: MPD error: The expression evaluated to a falsy value:
Jun 14 11:54:12 volumio volumio[14797]: assert.ok(self.idling)
Jun 14 11:54:12 volumio volumio[14797]: error: The expression evaluated to a falsy value:
Jun 14 11:54:12 volumio volumio[14797]: assert.ok(self.idling)
Jun 14 11:54:12 volumio volumio[14797]: info: MPD running with PID14945
Jun 14 11:54:12 volumio volumio[14797]: ,establishing connection
Jun 14 11:54:12 volumio volumio[14797]: error: updateQueue error: null
Jun 14 11:54:12 volumio volumio[14797]: error: updateQueue error: null
Jun 14 11:54:12 volumio volumio[14797]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Jun 14 11:54:12 volumio volumio[14797]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:54:12 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:54:12 volumio volumio[14797]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 14 11:54:13 volumio volumio[14797]: error: Discovery: Generic error: TypeError: argument 8 must be an integer (port)
Jun 14 11:54:13 volumio volumio[14797]: info: Discovery: Started advertising with name: undefined
Jun 14 11:54:15 volumio volumio[14797]: verbose: New Socket.io Connection to 192.168.88.13 from 192.168.88.27 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Jun 14 11:54:15 volumio volumio[14797]: info: Received Get System Info
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:54:15 volumio volumio[14797]: info: Discovery: Getting this device information
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:15 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:15 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:15 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 14 11:54:15 volumio volumio[14797]: info: Received Get System Info
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:54:15 volumio volumio[14797]: info: Discovery: Getting this device information
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:15 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:15 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:15 volumio volumio[14797]: info: Listing playlists
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::volumioGetQueue
Jun 14 11:54:15 volumio volumio[14797]: info: CoreStateMachine::getQueue
Jun 14 11:54:15 volumio volumio[14797]: info: CorePlayQueue::getQueue
Jun 14 11:54:15 volumio volumio[14797]: info: Received Get System Info
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:54:15 volumio volumio[14797]: info: Discovery: Getting this device information
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:15 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:15 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:15 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 14 11:54:15 volumio volumio[14797]: info: Received Get System Info
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:54:15 volumio volumio[14797]: info: Discovery: Getting this device information
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:15 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:15 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:15 volumio volumio[14797]: info: Listing playlists
Jun 14 11:54:15 volumio volumio[14797]: info: CoreCommandRouter::volumioGetQueue
Jun 14 11:54:15 volumio volumio[14797]: info: CoreStateMachine::getQueue
Jun 14 11:54:15 volumio volumio[14797]: info: CorePlayQueue::getQueue
Jun 14 11:54:16 volumio volumio[14797]: info: Received Get System Info
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:54:16 volumio volumio[14797]: info: Discovery: Getting this device information
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:16 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:16 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:16 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 14 11:54:16 volumio volumio[14797]: info: Received Get System Info
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:54:16 volumio volumio[14797]: info: Discovery: Getting this device information
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:16 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:16 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:16 volumio volumio[14797]: info: Listing playlists
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::volumioGetQueue
Jun 14 11:54:16 volumio volumio[14797]: info: CoreStateMachine::getQueue
Jun 14 11:54:16 volumio volumio[14797]: info: CorePlayQueue::getQueue
Jun 14 11:54:16 volumio volumio[14797]: info: Received Get System Info
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 14 11:54:16 volumio volumio[14797]: info: Discovery: Getting this device information
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:16 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 14 11:54:16 volumio volumio[14797]: info: CoreCommandRouter::volumioGetState
Jun 14 11:54:16 volumio volumio[14797]: info: CorePlayQueue::getTrack 0
Jun 14 11:54:17 volumio volumio[14797]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Jun 14 11:54:17 volumio volumio[14797]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 14 11:54:17 volumio volumio[14797]: TypeError: Cannot read property 'charAt' of undefined
Jun 14 11:54:17 volumio volumio[14797]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:199:24)
Jun 14 11:54:17 volumio volumio[14797]: at listOnTimeout (internal/timers.js:554:17)
Jun 14 11:54:17 volumio volumio[14797]: at processTimers (internal/timers.js:497:7)
Jun 14 11:54:17 volumio volumio[14797]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 14 11:54:18 volumio sudo[15039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-14 11:53
Jun 14 11:54:18 volumio sudo[15039]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"