-- Logs begin at Thu 2025-07-03 22:12:16 MSK, end at Fri 2025-07-04 14:21:13 MSK. -- Jul 04 14:20:03 volumio volumio[1347]: Upnp client error: Error: This socket has been ended by the other party Jul 04 14:20:07 volumio volumio[1347]: Upnp client error: Error: This socket has been ended by the other party Jul 04 14:20:11 volumio volumio[1347]: Upnp client error: Error: This socket has been ended by the other party Jul 04 14:20:19 volumio volumio[1347]: Upnp client error: Error: This socket has been ended by the other party Jul 04 14:20:25 volumio volumio[1347]: Upnp client error: Error: This socket has been ended by the other party Jul 04 14:20:28 volumio volumio[1347]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 04 14:20:28 volumio volumio[1347]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 04 14:20:28 volumio volumio[1347]: info: Discovery: Getting this device information Jul 04 14:20:28 volumio volumio[1347]: info: CoreCommandRouter::volumioGetState Jul 04 14:20:28 volumio volumio[1347]: info: CorePlayQueue::getTrack 2 Jul 04 14:20:28 volumio volumio[1347]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 04 14:20:32 volumio volumio[1347]: Upnp client error: Error: This socket has been ended by the other party Jul 04 14:20:42 volumio volumio[1347]: info: sendMpdCommand status took 56914 milliseconds Jul 04 14:20:42 volumio volumio[1347]: info: sendMpdCommand status took 56926 milliseconds Jul 04 14:20:42 volumio volumio[1347]: info: sendMpdCommand status took 56924 milliseconds Jul 04 14:20:42 volumio volumio[1347]: verbose: ControllerMpd::parseState Jul 04 14:20:42 volumio volumio[1347]: info: Command Router : Notfying DB Updatefalse Jul 04 14:20:42 volumio volumio[1347]: info: CoreCommandRouter::Close All Modals sent Jul 04 14:20:42 volumio volumio[1347]: verbose: ControllerMpd::parseState Jul 04 14:20:42 volumio volumio[1347]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 04 14:20:42 volumio volumio[1347]: verbose: ControllerMpd::parseState Jul 04 14:20:42 volumio volumio[1347]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 04 14:20:42 volumio volumio[1347]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 04 14:20:42 volumio volumio[1347]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 04 14:20:42 volumio volumio[1347]: info: Discovery: Getting this device information Jul 04 14:20:42 volumio volumio[1347]: info: CoreCommandRouter::volumioGetState Jul 04 14:20:42 volumio volumio[1347]: info: CorePlayQueue::getTrack 2 Jul 04 14:20:42 volumio volumio[1347]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 04 14:20:42 volumio volumio[1347]: Upnp client error: Error: This socket has been ended by the other party Jul 04 14:20:42 volumio volumio[1347]: verbose: New Socket.io Connection to 192.168.1.83:3000 from 192.168.1.63 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Jul 04 14:20:46 volumio volumio[1347]: <--- Last few GCs ---> Jul 04 14:20:46 volumio volumio[1347]: [1347:0x4fd8008] 2580274 ms: Scavenge 103.9 (107.3) -> 103.7 (107.3) MB, 2.7 / 0.0 ms (average mu = 0.903, current mu = 0.872) allocation failure Jul 04 14:20:46 volumio volumio[1347]: [1347:0x4fd8008] 2580342 ms: Scavenge 111.1 (114.5) -> 110.8 (114.5) MB, 1.6 / 0.0 ms (average mu = 0.903, current mu = 0.872) allocation failure Jul 04 14:20:46 volumio volumio[1347]: [1347:0x4fd8008] 2580449 ms: Scavenge (reduce) 118.3 (121.7) -> 118.1 (121.7) MB, 9.6 / 0.0 ms (average mu = 0.903, current mu = 0.872) allocation failure Jul 04 14:20:46 volumio volumio[1347]: <--- JS stacktrace ---> Jul 04 14:20:46 volumio volumio[1347]: FATAL ERROR: MarkCompactCollector: young object promotion failed Allocation failed - JavaScript heap out of memory Jul 04 14:20:46 volumio volumio-remote-updater[805]: [2025-07-04 14:20:46] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 04 14:20:46 volumio volumio-remote-updater[805]: [2025-07-04 14:20:46] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 04 14:20:46 volumio systemd[1]: volumio.service: Main process exited, code=killed, status=6/ABRT Jul 04 14:20:46 volumio systemd[1]: media-01D6F67E0C84F2C0.mount: Succeeded. Jul 04 14:20:46 volumio ntfs-3g[2818]: Unmounting /dev/sda1 () Jul 04 14:20:46 volumio systemd[1]: volumio.service: Failed with result 'signal'. Jul 04 14:20:46 volumio systemd[1]: Started dynamicswap service. Jul 04 14:20:47 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 04 14:20:47 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jul 04 14:20:47 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Jul 04 14:20:47 volumio systemd[1]: Started dynamicswap service. Jul 04 14:20:47 volumio systemd[1]: Stopped Volumio Backend Module. Jul 04 14:20:47 volumio systemd[1]: Started Volumio Backend Module. Jul 04 14:20:47 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 04 14:20:51 volumio volumio-remote-updater[805]: [2025-07-04 14:20:51] [info] asio async_connect error: system:111 (Connection refused) Jul 04 14:20:51 volumio volumio-remote-updater[805]: [2025-07-04 14:20:51] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jul 04 14:20:51 volumio volumio-remote-updater[805]: [2025-07-04 14:20:51] [error] handle_connect error: Underlying Transport Error Jul 04 14:20:53 volumio volumio[8088]: info: ------------------------------------------- Jul 04 14:20:53 volumio volumio[8088]: info: ----- Volumio3 ---- Jul 04 14:20:53 volumio volumio[8088]: info: ------------------------------------------- Jul 04 14:20:53 volumio volumio[8088]: info: ----- System startup ---- Jul 04 14:20:53 volumio volumio[8088]: info: ------------------------------------------- Jul 04 14:20:53 volumio kernel: i2s_clock_board: i2s_clock_board_trigger Jul 04 14:20:53 volumio kernel: i2s_clock_board: i2s_clock_board_hw_free Jul 04 14:20:54 volumio volumio[8088]: info: MYVOLUMIO Environment detected Jul 04 14:20:55 volumio volumio[8088]: info: Plugin folders cleanup Jul 04 14:20:55 volumio volumio[8088]: info: Scanning into folder /volumio/app/plugins/ Jul 04 14:20:55 volumio volumio[8088]: info: Scanning category audio_interface Jul 04 14:20:55 volumio volumio[8088]: info: Scanning category miscellanea Jul 04 14:20:55 volumio volumio[8088]: info: Scanning category music_service Jul 04 14:20:55 volumio volumio[8088]: info: Scanning category plugins.json Jul 04 14:20:55 volumio volumio[8088]: info: Scanning category system_controller Jul 04 14:20:55 volumio volumio[8088]: info: Scanning category user_interface Jul 04 14:20:55 volumio volumio[8088]: info: Scanning into folder /data/plugins/ Jul 04 14:20:55 volumio volumio[8088]: info: Plugin folders cleanup completed Jul 04 14:20:55 volumio volumio[8088]: info: ------------------------------------------- Jul 04 14:20:55 volumio volumio[8088]: info: ----- Core plugins startup ---- Jul 04 14:20:55 volumio volumio[8088]: info: ------------------------------------------- Jul 04 14:20:55 volumio volumio[8088]: info: Loading plugins from folder /volumio/app/plugins/ Jul 04 14:20:55 volumio volumio[8088]: info: Adding plugin upnp to MyMusic Plugins Jul 04 14:20:55 volumio volumio[8088]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 04 14:20:55 volumio volumio[8088]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 04 14:20:55 volumio volumio[8088]: info: Loading plugins from folder /data/plugins/ Jul 04 14:20:55 volumio volumio[8088]: info: Loading plugin "system"... Jul 04 14:20:55 volumio volumio[8088]: info: Loading plugin "appearance"... Jul 04 14:20:57 volumio volumio[8088]: info: Loading plugin "network"... Jul 04 14:20:57 volumio volumio[8088]: info: Refreshing Cached IP Addresses Jul 04 14:20:57 volumio volumio[8088]: info: Loading plugin "services"... Jul 04 14:20:57 volumio volumio[8088]: info: Loading plugin "alsa_controller"... Jul 04 14:20:57 volumio sudo[8117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 04 14:20:57 volumio sudo[8119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 04 14:20:57 volumio sudo[8115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 04 14:20:57 volumio sudo[8119]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 04 14:20:57 volumio sudo[8115]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 04 14:20:57 volumio sudo[8117]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 04 14:20:57 volumio sudo[8117]: pam_unix(sudo:session): session closed for user root Jul 04 14:20:57 volumio sudo[8115]: pam_unix(sudo:session): session closed for user root Jul 04 14:20:58 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 04 14:20:58 volumio volumio[8088]: info: Loading plugin "wizard"... Jul 04 14:20:58 volumio volumio[8088]: info: Loading plugin "networkfs"... Jul 04 14:20:58 volumio volumio[8088]: info: Starting Udev Watcher for removable devices Jul 04 14:20:58 volumio volumio[8088]: info: Ignoring mount for partition: boot Jul 04 14:20:58 volumio volumio[8088]: info: Ignoring mount for partition: volumio Jul 04 14:20:58 volumio volumio[8088]: info: Ignoring mount for partition: volumio_data Jul 04 14:20:58 volumio volumio[8088]: info: Mounting Device 01D6F67E0C84F2C0 Jul 04 14:20:58 volumio sudo[8129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/01D6F67E0C84F2C0 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jul 04 14:20:58 volumio sudo[8129]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 04 14:20:58 volumio volumio-remote-updater[805]: [2025-07-04 14:20:58] [connect] Successful connection Jul 04 14:20:59 volumio ntfs-3g[8132]: Version 2017.3.23AR.3 integrated FUSE 28 Jul 04 14:20:59 volumio sudo[8129]: pam_unix(sudo:session): session closed for user root Jul 04 14:20:59 volumio ntfs-3g[8132]: Mounted /dev/sda1 (Read-Write, label "", NTFS 3.1) Jul 04 14:20:59 volumio ntfs-3g[8132]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Jul 04 14:20:59 volumio ntfs-3g[8132]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Jul 04 14:20:59 volumio ntfs-3g[8132]: Global ownership and permissions enforced, configuration type 7 Jul 04 14:20:59 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 04 14:20:59 volumio volumio[8088]: info: Loading plugin "volumio_command_line_client"... Jul 04 14:20:59 volumio volumio[8088]: info: Loading plugin "upnp"... Jul 04 14:20:59 volumio volumio[8088]: info: [1751628059317] Starting Upmpd Daemon Jul 04 14:20:59 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 04 14:20:59 volumio volumio[8088]: info: Loading plugin "my_music"... Jul 04 14:20:59 volumio volumio[8088]: info: Loading plugin "mpd"... Jul 04 14:20:59 volumio sudo[8119]: pam_unix(sudo:session): session closed for user root Jul 04 14:21:00 volumio volumio[8088]: info: Loading plugin "upnp_browser"... Jul 04 14:21:00 volumio volumio[8088]: info: Loading plugin "alarm-clock"... Jul 04 14:21:01 volumio volumio[8088]: info: Loading plugin "airplay_emulation"... Jul 04 14:21:01 volumio volumio[8088]: info: Starting Shairport Sync Jul 04 14:21:01 volumio volumio[8088]: info: Loading plugin "last_100"... Jul 04 14:21:01 volumio volumio[8088]: info: Loading plugin "webradio"... Jul 04 14:21:01 volumio volumio[8088]: info: Loading plugin "i2s_dacs"... Jul 04 14:21:01 volumio volumio[8088]: info: I2S DAC not set, start Auto-detection Jul 04 14:21:01 volumio volumio[8088]: info: Loading plugin "volumiodiscovery"... Jul 04 14:21:01 volumio volumio[8088]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 04 14:21:01 volumio volumio[8088]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 04 14:21:01 volumio volumio[8088]: *** WARNING *** For more information see Jul 04 14:21:01 volumio node[8088]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 04 14:21:01 volumio volumio[8088]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 04 14:21:01 volumio volumio[8088]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 04 14:21:01 volumio volumio[8088]: *** WARNING *** For more information see Jul 04 14:21:01 volumio node[8088]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 04 14:21:01 volumio node[8088]: *** WARNING *** For more information see Jul 04 14:21:01 volumio node[8088]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 04 14:21:01 volumio node[8088]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 04 14:21:01 volumio node[8088]: *** WARNING *** For more information see Jul 04 14:21:01 volumio volumio[8088]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 04 14:21:01 volumio volumio[8088]: info: Discovery: Started advertising with name: Volumio Jul 04 14:21:01 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 04 14:21:01 volumio volumio[8088]: info: Loading plugin "outputs"... Jul 04 14:21:01 volumio volumio[8088]: info: Loading plugin "albumart"... Jul 04 14:21:01 volumio volumio[8088]: info: Plugin example_plugin is not enabled Jul 04 14:21:01 volumio volumio[8088]: info: Loading plugin "inputs"... Jul 04 14:21:01 volumio volumio[8088]: info: Loading plugin "updater_comm"... Jul 04 14:21:02 volumio volumio[8088]: info: Plugin mpdemulation is not enabled Jul 04 14:21:02 volumio volumio[8088]: info: Loading plugin "rest_api"... Jul 04 14:21:02 volumio volumio[8088]: info: Loading plugin "websocket"... Jul 04 14:21:02 volumio volumio[8088]: info: Starting Socket.io Server version 2.3.0 Jul 04 14:21:02 volumio volumio[8088]: info: Loading i18n strings for locale ru Jul 04 14:21:02 volumio volumio[8088]: Updating browse sources language Jul 04 14:21:02 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 04 14:21:02 volumio volumio[8088]: Forking 3 albumart workers Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::initPlayerControls Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 04 14:21:03 volumio volumio[8088]: Express server listening on port 3000 Jul 04 14:21:03 volumio volumio[8088]: [Metrics] WebUI: 11s 888.97ms Jul 04 14:21:03 volumio volumio[8088]: info: CoreStateMachine::resetVolumioState Jul 04 14:21:03 volumio volumio[8088]: info: CoreStateMachine::getcurrentVolume Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::volumioRetrievevolume Jul 04 14:21:03 volumio volumio[8088]: info: CoreStateMachine::pushState Jul 04 14:21:03 volumio volumio[8088]: info: CorePlayQueue::getTrack 0 Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::volumioPushState Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 04 14:21:03 volumio volumio[8088]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jul 04 14:21:03 volumio volumio[8088]: info: Completed loading Core Plugins Jul 04 14:21:03 volumio volumio[8088]: info: Preparing to generate the ALSA configuration file Jul 04 14:21:03 volumio volumio[8088]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jul 04 14:21:03 volumio volumio[8088]: verbose: New Socket.io Connection to 192.168.1.83:3000 from 192.168.1.63 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Jul 04 14:21:03 volumio volumio-remote-updater[805]: [2025-07-04 14:21:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751628058 101 Jul 04 14:21:03 volumio volumio[8088]: 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 Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 04 14:21:03 volumio volumio[8088]: info: Discovery: Getting this device information Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::volumioGetState Jul 04 14:21:03 volumio volumio[8088]: info: CorePlayQueue::getTrack 0 Jul 04 14:21:03 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 04 14:21:04 volumio volumio[8088]: info: Asound.conf file unchanged, so no further update is needed Jul 04 14:21:04 volumio volumio[8088]: info: Output device has changed, restarting MPD Jul 04 14:21:04 volumio volumio[8088]: info: Output device has changed, restarting Shairport Sync Jul 04 14:21:04 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:04 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 04 14:21:04 volumio sudo[8173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 04 14:21:04 volumio sudo[8173]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 04 14:21:04 volumio sudo[8173]: pam_unix(sudo:session): session closed for user root Jul 04 14:21:04 volumio sudo[8175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 04 14:21:04 volumio sudo[8175]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 04 14:21:04 volumio volumio[8088]: Starting albumart workers Jul 04 14:21:04 volumio volumio[8088]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 04 14:21:04 volumio volumio[8088]: info: ___________ START PLUGINS ___________ Jul 04 14:21:04 volumio systemd[1]: Stopping Music Player Daemon... Jul 04 14:21:04 volumio volumio[8088]: info: ControllerMpd::onStart: Initializing MPD Jul 04 14:21:04 volumio volumio[8088]: info: Creating MPD Configuration file Jul 04 14:21:04 volumio volumio[8088]: Starting albumart workers Jul 04 14:21:04 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 04 14:21:04 volumio volumio[8088]: Starting albumart workers Jul 04 14:21:04 volumio volumio[8088]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 04 14:21:04 volumio volumio[8088]: info: [1751628064586] CoreMusicLibrary::Adding element Медиа-серверы Jul 04 14:21:04 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 04 14:21:04 volumio sudo[8183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 04 14:21:04 volumio sudo[8183]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 04 14:21:04 volumio sudo[8183]: pam_unix(sudo:session): session closed for user root Jul 04 14:21:04 volumio sudo[8184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 04 14:21:04 volumio sudo[8184]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 04 14:21:04 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:04 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 04 14:21:04 volumio volumio[8088]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 04 14:21:04 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:04 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 04 14:21:05 volumio volumio[8088]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 04 14:21:05 volumio volumio[8088]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 04 14:21:05 volumio volumio[8088]: info: [1751628065110] CoreMusicLibrary::Adding element Last_100 Jul 04 14:21:05 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 04 14:21:05 volumio volumio[8088]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 04 14:21:05 volumio volumio[8088]: info: [1751628065122] CoreMusicLibrary::Adding element Webradio Jul 04 14:21:05 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 04 14:21:05 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 04 14:21:05 volumio volumio[8088]: info: Initializing BBC Radios Jul 04 14:21:05 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 04 14:21:05 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 04 14:21:05 volumio volumio[8088]: info: Volumio Calling Home Jul 04 14:21:05 volumio volumio[8088]: info: CoreStateMachine::setRepeat null single undefined Jul 04 14:21:05 volumio volumio[8088]: info: CoreStateMachine::pushState Jul 04 14:21:05 volumio volumio[8088]: info: CorePlayQueue::getTrack 0 Jul 04 14:21:05 volumio volumio[8088]: info: CoreCommandRouter::volumioPushState Jul 04 14:21:05 volumio volumio[8088]: info: CoreStateMachine::setRandom null Jul 04 14:21:05 volumio volumio[8088]: info: CoreStateMachine::pushState Jul 04 14:21:05 volumio volumio[8088]: info: CorePlayQueue::getTrack 0 Jul 04 14:21:05 volumio volumio[8088]: info: CoreCommandRouter::volumioPushState Jul 04 14:21:06 volumio volumio[8088]: info: Reloading queue from file Jul 04 14:21:06 volumio volumio[8088]: verbose: New Socket.io Connection to 192.168.1.83:3000 from 192.168.1.63 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 3 Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::volumioGetState Jul 04 14:21:06 volumio volumio[8088]: info: CorePlayQueue::getTrack 0 Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 04 14:21:06 volumio volumio[8088]: info: MPD Permissions set Jul 04 14:21:06 volumio volumio[8088]: info: MPD Permissions set Jul 04 14:21:06 volumio volumio[8088]: verbose: New Socket.io Connection to 192.168.1.83 from 192.168.1.63 UA: Mozilla/5.0 (Linux; Android 14; KINGKONG POWER 3 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jul 04 14:21:06 volumio volumio[8088]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 04 14:21:06 volumio volumio[8088]: info: Discovery: adding 5a8a5a93-46d0-41c3-a731-5e5cd352313b Jul 04 14:21:06 volumio volumio[8088]: info: Discovery: Found device Volumio Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::volumioGetState Jul 04 14:21:06 volumio volumio[8088]: info: CorePlayQueue::getTrack 0 Jul 04 14:21:06 volumio volumio[8088]: info: Starting Shairport Sync Jul 04 14:21:06 volumio volumio[8088]: info: Starting Shairport Sync Jul 04 14:21:06 volumio volumio[8088]: info: Starting Shairport Sync Jul 04 14:21:06 volumio sudo[8243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 04 14:21:06 volumio sudo[8243]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 04 14:21:06 volumio sudo[8245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 04 14:21:06 volumio sudo[8245]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 04 14:21:06 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 04 14:21:06 volumio sudo[8248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 04 14:21:06 volumio sudo[8248]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 04 14:21:06 volumio volumio[8088]: info: CoreCommandRouter::volumioGetState Jul 04 14:21:06 volumio volumio[8088]: info: CorePlayQueue::getTrack 0 Jul 04 14:21:07 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 04 14:21:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 04 14:21:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 04 14:21:07 volumio sudo[8245]: pam_unix(sudo:session): session closed for user root Jul 04 14:21:07 volumio sudo[8248]: pam_unix(sudo:session): session closed for user root Jul 04 14:21:07 volumio sudo[8243]: pam_unix(sudo:session): session closed for user root Jul 04 14:21:07 volumio volumio[8088]: info: Shairport-Sync Started Jul 04 14:21:07 volumio volumio[8088]: Error adding Membership: Error: addMembership EINVAL Jul 04 14:21:07 volumio volumio[8088]: info: Shairport-Sync Started Jul 04 14:21:07 volumio volumio[8088]: info: Shairport-Sync Started Jul 04 14:21:07 volumio volumio[8088]: verbose: New Socket.io Connection to 192.168.1.83 from 192.168.1.63 UA: Mozilla/5.0 (Linux; Android 14; KINGKONG POWER 3 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jul 04 14:21:07 volumio volumio[8088]: info: CoreCommandRouter::volumioGetState Jul 04 14:21:07 volumio volumio[8088]: info: CorePlayQueue::getTrack 0 Jul 04 14:21:07 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 04 14:21:07 volumio volumio[8088]: info: Listing playlists Jul 04 14:21:07 volumio volumio[8088]: info: CoreCommandRouter::volumioGetVisibleSources Jul 04 14:21:07 volumio volumio[8088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 04 14:21:07 volumio volumio[8088]: info: CoreCommandRouter::volumioGetQueue Jul 04 14:21:07 volumio volumio[8088]: info: CoreStateMachine::getQueue Jul 04 14:21:07 volumio volumio[8088]: info: CorePlayQueue::getQueue Jul 04 14:21:09 volumio volumio[8088]: info: Volumio called home Jul 04 14:21:09 volumio sudo[8256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 04 14:21:09 volumio sudo[8256]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 04 14:21:09 volumio sudo[8256]: pam_unix(sudo:session): session closed for user root Jul 04 14:21:09 volumio sudo[8258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 04 14:21:09 volumio sudo[8258]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 04 14:21:09 volumio sudo[8258]: pam_unix(sudo:session): session closed for user root Jul 04 14:21:09 volumio sudo[8262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 04 14:21:09 volumio sudo[8262]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 04 14:21:09 volumio sudo[8262]: pam_unix(sudo:session): session closed for user root Jul 04 14:21:09 volumio volumio[8088]: info: Upmpdcli Daemon Started Jul 04 14:21:09 volumio systemd[1]: mpd.service: Succeeded. Jul 04 14:21:09 volumio systemd[1]: Stopped Music Player Daemon. Jul 04 14:21:09 volumio systemd[1]: Starting Music Player Daemon... Jul 04 14:21:09 volumio sudo[8264]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 04 14:21:09 volumio sudo[8264]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 04 14:21:09 volumio sudo[8264]: pam_unix(sudo:session): session closed for user root Jul 04 14:21:11 volumio volumio[8088]: info: Preload queue cleared Jul 04 14:21:11 volumio volumio[8088]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 04 14:21:11 volumio volumio[8088]: info: CoreStateMachine::ClearQueue Jul 04 14:21:11 volumio volumio[8088]: info: CoreStateMachine::stop Jul 04 14:21:11 volumio volumio[8088]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 04 14:21:11 volumio volumio[8088]: info: CorePlayQueue::clearPlayQueue Jul 04 14:21:11 volumio volumio[8088]: info: CorePlayQueue::saveQueue Jul 04 14:21:11 volumio volumio[8088]: info: CoreCommandRouter::volumioPushQueue Jul 04 14:21:11 volumio volumio[8088]: info: CoreStateMachine::addQueueItems Jul 04 14:21:11 volumio volumio[8088]: info: CorePlayQueue::addQueueItems Jul 04 14:21:11 volumio volumio[8088]: info: Preload queue cleared Jul 04 14:21:11 volumio volumio[8088]: info: Adding Item to queue: music-library/USB/01D6F67E0C84F2C0/Pantera/The IMPACT ВОЗДЕЙСТВИЕ Документальный фильм. Русская версия.mp4 Jul 04 14:21:11 volumio volumio[8088]: info: Exploding uri music-library/USB/01D6F67E0C84F2C0/Pantera/The IMPACT ВОЗДЕЙСТВИЕ Документальный фильм. Русская версия.mp4 in service mpd Jul 04 14:21:12 volumio volumio[8088]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 04 14:21:12 volumio volumio[8088]: TypeError: Cannot read property 'then' of undefined Jul 04 14:21:12 volumio volumio[8088]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) Jul 04 14:21:12 volumio volumio[8088]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) Jul 04 14:21:12 volumio volumio[8088]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1365:16) Jul 04 14:21:12 volumio volumio[8088]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Jul 04 14:21:12 volumio volumio[8088]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Jul 04 14:21:12 volumio volumio[8088]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Jul 04 14:21:12 volumio volumio[8088]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Jul 04 14:21:12 volumio volumio[8088]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:507:23) Jul 04 14:21:12 volumio volumio[8088]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:483:17) Jul 04 14:21:12 volumio volumio[8088]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Jul 04 14:21:12 volumio volumio[8088]: at Socket.emit (events.js:400:28) Jul 04 14:21:12 volumio volumio[8088]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 04 14:21:12 volumio volumio[8088]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Jul 04 14:21:12 volumio volumio[8088]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 04 14:21:12 volumio mpd[8266]: Jul 04 14:21 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 04 14:21:13 volumio sudo[8276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-04 14:20 Jul 04 14:21:13 volumio sudo[8276]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 21 Sep 2024 12:11:42 AM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="nanopineo2-armbian" VOLUMIO_DEVICENAME="NanoPi Neo2" VOLUMIO_HASH="ff3515680dbe08d0d3746cf9fd89f216"