-- Logs begin at Mon 2025-12-29 20:14:22 MSK, end at Tue 2025-12-30 05:44:08 MSK. -- Dec 30 05:43:04 volumio-rpi-201 sudo[19914]: volumio : TTY=pts/1 ; PWD=/data/plugins/music_service/ru-radio ; USER=root ; COMMAND=/bin/systemctl stop volumio.service Dec 30 05:43:04 volumio-rpi-201 sudo[19914]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:04 volumio-rpi-201 systemd[1]: Stopping Volumio Backend Module... Dec 30 05:43:04 volumio-rpi-201 volumio-remote-updater[601]: [2025-12-30 05:43:04] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 30 05:43:04 volumio-rpi-201 volumio-remote-updater[601]: [2025-12-30 05:43:04] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 30 05:43:04 volumio-rpi-201 go-librespot[18612]: time="2025-12-30T05:43:04+03:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Dec 30 05:43:04 volumio-rpi-201 systemd[1]: volumio.service: Main process exited, code=killed, status=15/TERM Dec 30 05:43:04 volumio-rpi-201 systemd[1]: volumio.service: Succeeded. Dec 30 05:43:04 volumio-rpi-201 systemd[1]: Stopped Volumio Backend Module. Dec 30 05:43:04 volumio-rpi-201 sudo[19914]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:04 volumio-rpi-201 sudo[19917]: volumio : TTY=pts/1 ; PWD=/data/plugins/music_service/ru-radio ; USER=root ; COMMAND=/bin/systemctl start volumio.service Dec 30 05:43:04 volumio-rpi-201 sudo[19917]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:04 volumio-rpi-201 systemd[1]: Started dynamicswap service. Dec 30 05:43:04 volumio-rpi-201 systemd[1]: Started Volumio Backend Module. Dec 30 05:43:04 volumio-rpi-201 sudo[19917]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:04 volumio-rpi-201 systemd[1]: dynamicswap.service: Succeeded. Dec 30 05:43:07 volumio-rpi-201 volumio[19921]: info: ------------------------------------------- Dec 30 05:43:07 volumio-rpi-201 volumio[19921]: info: ----- Volumio3 ---- Dec 30 05:43:07 volumio-rpi-201 volumio[19921]: info: ------------------------------------------- Dec 30 05:43:07 volumio-rpi-201 volumio[19921]: info: ----- System startup ---- Dec 30 05:43:07 volumio-rpi-201 volumio[19921]: info: ------------------------------------------- Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: MYVOLUMIO Environment detected Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Plugin folders cleanup Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Scanning into folder /volumio/app/plugins/ Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Scanning category audio_interface Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Scanning category miscellanea Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Scanning category music_service Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Scanning category plugins.json Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Scanning category system_controller Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Scanning category user_interface Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Scanning into folder /data/plugins/ Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Scanning category audio_interface Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Scanning category music_service Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Scanning category plugins.json Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Scanning category system_controller Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Scanning category system_hardware Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Scanning category user_interface Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Plugin folders cleanup completed Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: ------------------------------------------- Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: ----- Core plugins startup ---- Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: ------------------------------------------- Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Loading plugins from folder /volumio/app/plugins/ Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Adding plugin upnp to MyMusic Plugins Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Loading plugins from folder /data/plugins/ Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Loading plugin "system"... Dec 30 05:43:09 volumio-rpi-201 volumio[19921]: info: Loading plugin "appearance"... Dec 30 05:43:09 volumio-rpi-201 volumio-remote-updater[601]: [2025-12-30 05:43:09] [connect] Successful connection Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: Loading plugin "network"... Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: Refreshing Cached IP Addresses Dec 30 05:43:11 volumio-rpi-201 sudo[19952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 30 05:43:11 volumio-rpi-201 sudo[19952]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:11 volumio-rpi-201 sudo[19952]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:11 volumio-rpi-201 sudo[19954]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 30 05:43:11 volumio-rpi-201 sudo[19954]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:11 volumio-rpi-201 sudo[19954]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: Loading plugin "services"... Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: Loading plugin "alsa_controller"... Dec 30 05:43:11 volumio-rpi-201 sudo[19963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 30 05:43:11 volumio-rpi-201 sudo[19963]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: Loading plugin "wizard"... Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: Loading plugin "networkfs"... Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: Starting Udev Watcher for removable devices Dec 30 05:43:11 volumio-rpi-201 sudo[19978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.0.124/Internal Storage /mnt/NAS/Internal_Storage Dec 30 05:43:11 volumio-rpi-201 sudo[19978]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:11 volumio-rpi-201 kernel: CIFS: Attempting to mount //192.168.0.124/Internal Storage Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: Ignoring mount for partition: boot Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: Ignoring mount for partition: volumio Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: Ignoring mount for partition: volumio_data Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: Loading plugin "volumio_command_line_client"... Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: Loading plugin "upnp"... Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: [1767062591769] Starting Upmpd Daemon Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: Loading plugin "my_music"... Dec 30 05:43:11 volumio-rpi-201 volumio[19921]: info: Loading plugin "mpd"... Dec 30 05:43:12 volumio-rpi-201 volumio[19921]: info: Loading plugin "upnp_browser"... Dec 30 05:43:12 volumio-rpi-201 sudo[19963]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:12 volumio-rpi-201 volumio[19921]: info: Loading plugin "alarm-clock"... Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: info: Loading plugin "airplay_emulation"... Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: info: Starting Shairport Sync Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: info: Loading plugin "last_100"... Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: info: Loading plugin "webradio"... Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: info: Loading plugin "i2s_dacs"... Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: info: I2S DAC not set, start Auto-detection Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: info: Loading plugin "volumiodiscovery"... Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: *** WARNING *** For more information see Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 30 05:43:13 volumio-rpi-201 node[19921]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: *** WARNING *** For more information see Dec 30 05:43:13 volumio-rpi-201 node[19921]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 30 05:43:13 volumio-rpi-201 node[19921]: *** WARNING *** For more information see Dec 30 05:43:13 volumio-rpi-201 node[19921]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 30 05:43:13 volumio-rpi-201 node[19921]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 30 05:43:13 volumio-rpi-201 node[19921]: *** WARNING *** For more information see Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: info: Discovery: Started advertising with name: Volumio-RPi-201 Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 30 05:43:13 volumio-rpi-201 volumio[19921]: info: Loading plugin "bandcamp"... Dec 30 05:43:15 volumio-rpi-201 volumio[19921]: info: Loading plugin "calmradio"... Dec 30 05:43:17 volumio-rpi-201 volumio[19921]: info: Loading plugin "emby_client"... Dec 30 05:43:17 volumio-rpi-201 volumio[19921]: info: Loading plugin "spop"... Dec 30 05:43:17 volumio-rpi-201 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 30 05:43:17 volumio-rpi-201 kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Dec 30 05:43:17 volumio-rpi-201 sudo[19978]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:19 volumio-rpi-201 volumio[19921]: info: Loading plugin "autostart"... Dec 30 05:43:19 volumio-rpi-201 volumio[19921]: info: Applying required configuration parameters for plugin autostart Dec 30 05:43:19 volumio-rpi-201 volumio[19921]: info: AutoStart - onVolumioStart - read config.json Dec 30 05:43:19 volumio-rpi-201 volumio[19921]: info: Loading plugin "now_playing"... Dec 30 05:43:21 volumio-rpi-201 volumio[19921]: info: Loading plugin "outputs"... Dec 30 05:43:21 volumio-rpi-201 volumio[19921]: info: Loading plugin "albumart"... Dec 30 05:43:22 volumio-rpi-201 volumio[19921]: info: Plugin example_plugin is not enabled Dec 30 05:43:22 volumio-rpi-201 volumio[19921]: info: Loading plugin "inputs"... Dec 30 05:43:22 volumio-rpi-201 volumio[19921]: info: Loading plugin "updater_comm"... Dec 30 05:43:22 volumio-rpi-201 volumio-remote-updater[601]: [2025-12-30 05:43:22] [connect] Successful connection Dec 30 05:43:22 volumio-rpi-201 volumio[19921]: info: Plugin mpdemulation is not enabled Dec 30 05:43:22 volumio-rpi-201 volumio[19921]: info: Loading plugin "rest_api"... Dec 30 05:43:22 volumio-rpi-201 volumio[19921]: info: Loading plugin "websocket"... Dec 30 05:43:22 volumio-rpi-201 volumio[19921]: info: Starting Socket.io Server version 2.3.0 Dec 30 05:43:22 volumio-rpi-201 volumio[19921]: info: Plugin fusiondsp is not enabled Dec 30 05:43:22 volumio-rpi-201 volumio[19921]: info: Loading plugin "80s80s"... Dec 30 05:43:22 volumio-rpi-201 volumio[19921]: Forking 3 albumart workers Dec 30 05:43:22 volumio-rpi-201 volumio[19921]: info: Applying required configuration parameters for plugin 80s80s Dec 30 05:43:22 volumio-rpi-201 volumio[19921]: info: [1767062602907] [80s80s] API delay: 30 Dec 30 05:43:22 volumio-rpi-201 volumio[19921]: info: Loading plugin "controradio"... Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: error: !!!! WARNING !!!! Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: error: The plugin music_service/controradio failed to load, setting it to stopped. Error: Error: Cannot find module 'fast-xml-parser' Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: Require stack: Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: - /data/plugins/music_service/controradio/index.js Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: - /volumio/app/pluginmanager.js Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: - /volumio/app/index.js Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: - /volumio/index.js Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: error: Stack trace: Error: Cannot find module 'fast-xml-parser' Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: Require stack: Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: - /data/plugins/music_service/controradio/index.js Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: - /volumio/app/pluginmanager.js Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: - /volumio/app/index.js Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: - /volumio/index.js Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:880:15) Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at Function.Module._load (internal/modules/cjs/loader.js:725:27) Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at Module.require (internal/modules/cjs/loader.js:952:19) Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at require (internal/modules/cjs/helpers.js:88:18) Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at Object. (/data/plugins/music_service/controradio/index.js:5:21) Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at Module.load (internal/modules/cjs/loader.js:928:32) Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at Module.require (internal/modules/cjs/loader.js:952:19) Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at require (internal/modules/cjs/helpers.js:88:18) Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at /volumio/app/pluginmanager.js:338:34 Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at Array.forEach () Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at HashMap. (/volumio/app/pluginmanager.js:337:20) Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: error: !!!! WARNING !!!! Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: info: Loading plugin "motherearthradio"... Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: info: Applying required configuration parameters for plugin motherearthradio Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: info: [1767062603583] [MotherEarth] API delay: 5 Dec 30 05:43:23 volumio-rpi-201 volumio[19921]: info: Loading plugin "podcast"... Dec 30 05:43:24 volumio-rpi-201 volumio[19921]: info: ControllerPodcast::constructor Dec 30 05:43:24 volumio-rpi-201 volumio[19921]: info: Loading plugin "radio_paradise"... Dec 30 05:43:24 volumio-rpi-201 volumio[19921]: Starting albumart workers Dec 30 05:43:24 volumio-rpi-201 volumio[19921]: Starting albumart workers Dec 30 05:43:24 volumio-rpi-201 volumio[19921]: Starting albumart workers Dec 30 05:43:24 volumio-rpi-201 volumio[19921]: info: Applying required configuration parameters for plugin radio_paradise Dec 30 05:43:24 volumio-rpi-201 volumio[19921]: info: [1767062604648] [RadioParadise] API delay: 5 Dec 30 05:43:24 volumio-rpi-201 volumio[19921]: info: Loading plugin "ru-radio"... Dec 30 05:43:24 volumio-rpi-201 volumio[19921]: info: ru-radio onVolumioStart() Dec 30 05:43:25 volumio-rpi-201 volumio[19921]: error: Russian Radio Plugin: Error during initialization - this.loadStations(...).then(...).catch is not a function Dec 30 05:43:25 volumio-rpi-201 volumio[19921]: info: Loading plugin "yandex_music"... Dec 30 05:43:26 volumio-rpi-201 volumio[19921]: info: Applying required configuration parameters for plugin yandex_music Dec 30 05:43:26 volumio-rpi-201 volumio[19921]: info: Loading plugin "ir_controller"... Dec 30 05:43:27 volumio-rpi-201 volumio[19921]: info: Applying required configuration parameters for plugin ir_controller Dec 30 05:43:27 volumio-rpi-201 volumio[19921]: info: Loading plugin "Systeminfo"... Dec 30 05:43:27 volumio-rpi-201 volumio[19921]: info: Loading plugin "randomizer"... Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: Applying required configuration parameters for plugin randomizer Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: Loading i18n strings for locale ru Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: error: ir_controller: Fetching language file: Error: i18n file complementing the system language not found. Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: Updating browse sources language Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::initPlayerControls Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: Express server listening on port 3000 Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: [Metrics] WebUI: 21s 995.21ms Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: Completed loading Core Plugins Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::resetVolumioState Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::getcurrentVolume Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioRetrievevolume Dec 30 05:43:28 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: info: Preparing to generate the ALSA configuration file Dec 30 05:43:29 volumio-rpi-201 sudo[20057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 30 05:43:29 volumio-rpi-201 sudo[20057]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:29 volumio-rpi-201 sudo[20057]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:29 volumio-rpi-201 sudo[20060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 30 05:43:29 volumio-rpi-201 sudo[20060]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:29 volumio-rpi-201 sudo[20060]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: info: Volumio Network Manager: Network status updated: 3 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: info: Cannot mount NAS Internal_Storage at system boot, trial number 1 ,retrying in 5 seconds Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 17 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 18 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 19 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 20 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 21 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 22 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 23 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 24 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113:3000 from 192.168.0.135 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 25 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113:3000 from 192.168.0.135 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 26 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113:3000 from 192.168.0.135 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 27 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 28 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 29 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 30 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 31 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 32 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 33 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 34 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 35 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 36 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 37 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 38 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 39 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 40 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 41 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 42 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 43 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 44 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 45 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 46 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 47 Dec 30 05:43:29 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 48 Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 49 Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 50 Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 51 Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: Reloading queue from file Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: Asound.conf file unchanged, so no further update is needed Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: Output device has changed, restarting MPD Dec 30 05:43:30 volumio-rpi-201 sudo[20068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 30 05:43:30 volumio-rpi-201 sudo[20068]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: Output device has changed, restarting Shairport Sync Dec 30 05:43:30 volumio-rpi-201 sudo[20068]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 05:43:30 volumio-rpi-201 sudo[20071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 30 05:43:30 volumio-rpi-201 sudo[20071]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:30 volumio-rpi-201 systemd[1]: Stopping Music Player Daemon... Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: ___________ START PLUGINS ___________ Dec 30 05:43:30 volumio-rpi-201 systemd[1]: mpd.service: Succeeded. Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: ControllerMpd::onStart: Initializing MPD Dec 30 05:43:30 volumio-rpi-201 systemd[1]: Stopped Music Player Daemon. Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: Creating MPD Configuration file Dec 30 05:43:30 volumio-rpi-201 sudo[20078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 30 05:43:30 volumio-rpi-201 sudo[20078]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:30 volumio-rpi-201 systemd[1]: Starting Music Player Daemon... Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: [1767062610450] CoreMusicLibrary::Adding element Медиа-серверы Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:30 volumio-rpi-201 sudo[20078]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:30 volumio-rpi-201 sudo[20081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 30 05:43:30 volumio-rpi-201 sudo[20081]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 05:43:30 volumio-rpi-201 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 30 05:43:30 volumio-rpi-201 systemd[1]: mpd.service: Succeeded. Dec 30 05:43:30 volumio-rpi-201 systemd[1]: Stopped Music Player Daemon. Dec 30 05:43:30 volumio-rpi-201 systemd[1]: Starting Music Player Daemon... Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: [1767062610728] CoreMusicLibrary::Adding element Last_100 Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: [1767062610737] CoreMusicLibrary::Adding element Webradio Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: Initializing BBC Radios Dec 30 05:43:30 volumio-rpi-201 sudo[20085]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 30 05:43:30 volumio-rpi-201 sudo[20085]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:30 volumio-rpi-201 sudo[20085]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: [1767062610943] CoreMusicLibrary::Adding element Bandcamp Discover Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: Cannot find translation for source Bandcamp Discover Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: Adding Calm Radio to Browse Sources Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: [1767062610964] CoreMusicLibrary::Adding element Calm Radio Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: Cannot find translation for source Bandcamp Discover Dec 30 05:43:30 volumio-rpi-201 volumio[19921]: Cannot find translation for source Calm Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: Loading i18n strings for locale ru Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: error: ir_controller: Fetching language file: Error: i18n file complementing the system language not found. Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Updating browse sources language Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Bandcamp Discover Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Calm Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Bandcamp Discover Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Calm Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: [1767062611057] CoreMusicLibrary::Adding element Emby Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Bandcamp Discover Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Calm Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Emby Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: Creating Spotify config file Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: AutoStart - onStart Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: [now-playing] ConfigUpdater: config is up to date. Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: [1767062611346] CoreMusicLibrary::Adding element 80s80s Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Bandcamp Discover Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Calm Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Emby Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source 80s80s Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: [1767062611362] CoreMusicLibrary::Adding element Mother Earth Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Bandcamp Discover Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Calm Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Emby Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source 80s80s Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Mother Earth Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: [1767062611383] CoreMusicLibrary::Adding element Podcast Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Bandcamp Discover Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Calm Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Emby Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source 80s80s Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Mother Earth Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Podcast Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: [1767062611398] CoreMusicLibrary::Adding element Radio Paradise Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Bandcamp Discover Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Calm Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Emby Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source 80s80s Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Mother Earth Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Podcast Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Radio Paradise Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: ru-radio onStart() Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: Loading i18n strings for locale ru Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: error: ir_controller: Fetching language file: Error: i18n file complementing the system language not found. Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Updating browse sources language Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Bandcamp Discover Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Calm Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Emby Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source 80s80s Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Mother Earth Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Podcast Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Radio Paradise Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Bandcamp Discover Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Calm Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Emby Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source 80s80s Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Mother Earth Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Podcast Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Radio Paradise Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: [1767062611460] CoreMusicLibrary::Adding element Russian Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Bandcamp Discover Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Calm Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Emby Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source 80s80s Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Mother Earth Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Podcast Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Radio Paradise Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Russian Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: error: Plugin ru-radio failed to start! TypeError: that.commandRouter.addMusicService is not a function Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: [1767062611472] CoreMusicLibrary::Adding element Яндекс Музыка Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Bandcamp Discover Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Calm Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Emby Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source 80s80s Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Mother Earth Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Podcast Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Radio Paradise Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Russian Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Яндекс Музыка Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: Loading i18n strings for locale ru Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: error: ir_controller: Fetching language file: Error: i18n file complementing the system language not found. Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: [1767062611607] CoreMusicLibrary::Adding element Randomizer Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Bandcamp Discover Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Calm Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Emby Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source 80s80s Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Mother Earth Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Podcast Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Radio Paradise Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Russian Radio Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Яндекс Музыка Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: Cannot find translation for source Randomizer Dec 30 05:43:31 volumio-rpi-201 volumio[19921]: info: Volumio Calling Home Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: ERROR LOADING JSON TypeError [ERR_INVALID_ARG_TYPE]: The "path" argument must be of type string or an instance of Buffer or URL. Received undefined Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: ERROR LOADING JSON TypeError [ERR_INVALID_ARG_TYPE]: The "path" argument must be of type string or an instance of Buffer or URL. Received undefined Dec 30 05:43:32 volumio-rpi-201 sudo[20124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/irexec.lircrc /etc/lirc/lirc_options.conf /etc/lirc/lircd.conf /etc/lirc/lircd.conf.d /etc/lirc/lircmd.conf /etc/lirc/lircrc Dec 30 05:43:32 volumio-rpi-201 sudo[20124]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:32 volumio-rpi-201 sudo[20124]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: [now-playing] App is listening on port 4004. Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 52 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 53 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 54 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 55 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 56 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 57 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 58 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 59 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 60 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 61 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 62 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 63 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 64 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 65 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 66 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 67 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 68 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 69 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 70 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 71 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 72 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 73 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 74 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: Russian Radio Plugin: Loaded 80 radio stations Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::setRepeat null single undefined Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::setRandom null Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: Setting Device type: Raspberry PI Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 75 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 76 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 77 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 78 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 79 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 80 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 81 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 82 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 83 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 84 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 85 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 86 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 87 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 88 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 89 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 90 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 91 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 92 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 93 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 94 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 95 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 96 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 97 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 98 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: ir_controller: File permissions successfully set on /etc/lirc/*. Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: MPD Permissions set Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: info: MPD Permissions set Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 99 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 100 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 101 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 102 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 103 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 104 Dec 30 05:43:32 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 105 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 106 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 107 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 108 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 109 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 110 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 111 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 112 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.113 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 113 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to 192.168.0.114 from 192.168.0.104 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 114 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: Volumio called home Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: Spotify config file written Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: Discovery: adding 21034a1d-9c5a-4769-b03f-295abb34199e Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: Discovery: Found device SMSL N100 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: Discovery: Connecting to remote: 192.168.0.135 Dec 30 05:43:33 volumio-rpi-201 sudo[20128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Dec 30 05:43:33 volumio-rpi-201 sudo[20128]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetState Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetState Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:33 volumio-rpi-201 systemd[1]: Stopping go-librespot Daemon... Dec 30 05:43:33 volumio-rpi-201 systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Dec 30 05:43:33 volumio-rpi-201 systemd[1]: go-librespot-daemon.service: Succeeded. Dec 30 05:43:33 volumio-rpi-201 systemd[1]: Stopped go-librespot Daemon. Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 115 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 116 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetState Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:33 volumio-rpi-201 systemd[1]: Started go-librespot Daemon. Dec 30 05:43:33 volumio-rpi-201 go-librespot[20131]: go-librespot daemon starting... Dec 30 05:43:33 volumio-rpi-201 sudo[20128]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:33 volumio-rpi-201 sudo[20134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 30 05:43:33 volumio-rpi-201 sudo[20134]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:33 volumio-rpi-201 go-librespot[20131]: time="2025-12-30T05:43:33+03:00" level=info msg="running go-librespot 0.4.0" Dec 30 05:43:33 volumio-rpi-201 go-librespot[20131]: time="2025-12-30T05:43:33+03:00" level=debug msg="app state loaded" Dec 30 05:43:33 volumio-rpi-201 go-librespot[20131]: time="2025-12-30T05:43:33+03:00" level=debug msg="stored credentials not found" Dec 30 05:43:33 volumio-rpi-201 go-librespot[20131]: time="2025-12-30T05:43:33+03:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:33 volumio-rpi-201 sudo[20134]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: No need to fix Spotify hosts Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: Discovery: this is already registered, 21034a1d-9c5a-4769-b03f-295abb34199e Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: Discovery: Found device SMSL N100 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: Discovery: Connecting to remote: 192.168.0.135 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetQueue Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::getQueue Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getQueue Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetVisibleSources Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetQueue Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::getQueue Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getQueue Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: Listing playlists Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetVisibleSources Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetState Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetQueue Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::getQueue Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getQueue Dec 30 05:43:33 volumio-rpi-201 volumio[19921]: info: Listing playlists Dec 30 05:43:33 volumio-rpi-201 mpd[20094]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 30 05:43:33 volumio-rpi-201 mpd[20094]: output: No 'audio_output' defined in config file Dec 30 05:43:33 volumio-rpi-201 mpd[20094]: output: Successfully detected a sndio audio device Dec 30 05:43:33 volumio-rpi-201 go-librespot[20131]: time="2025-12-30T05:43:33+03:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Dec 30 05:43:33 volumio-rpi-201 go-librespot[20131]: time="2025-12-30T05:43:33+03:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Dec 30 05:43:33 volumio-rpi-201 go-librespot[20131]: time="2025-12-30T05:43:33+03:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Dec 30 05:43:33 volumio-rpi-201 mpd[20094]: zeroconf: No global port, disabling zeroconf Dec 30 05:43:33 volumio-rpi-201 systemd[1]: Started Music Player Daemon. Dec 30 05:43:33 volumio-rpi-201 sudo[20071]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:33 volumio-rpi-201 go-librespot[20131]: time="2025-12-30T05:43:33+03:00" level=info msg="zeroconf server listening on port 33685" Dec 30 05:43:33 volumio-rpi-201 sudo[20081]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: info: Upmpdcli Daemon Started Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: info: Discovery: adding 53f96169-8014-4a5a-8983-6b67662381f9 Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: info: Discovery: Found device Volumio-RPi-201 Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetState Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: info: Discovery: Connected to remote: 192.168.0.135 Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: info: Starting Shairport Sync Dec 30 05:43:34 volumio-rpi-201 sudo[20158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.0.124/Internal Storage /mnt/NAS/Internal_Storage Dec 30 05:43:34 volumio-rpi-201 sudo[20158]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: info: Starting Shairport Sync Dec 30 05:43:34 volumio-rpi-201 kernel: CIFS: Attempting to mount //192.168.0.124/Internal Storage Dec 30 05:43:34 volumio-rpi-201 sudo[20162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 30 05:43:34 volumio-rpi-201 sudo[20162]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: info: Starting Shairport Sync Dec 30 05:43:34 volumio-rpi-201 sudo[20166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 30 05:43:34 volumio-rpi-201 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 30 05:43:34 volumio-rpi-201 sudo[20166]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:34 volumio-rpi-201 systemd[1]: shairport-sync.service: Succeeded. Dec 30 05:43:34 volumio-rpi-201 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: SPOTIFY: BQCZcISdfxyvASp9-PIZWzTtSjSurV2aiVlYioRtZMylAUVaPuYdExB435lVgkmVKKf5pjBzYfaQ6iX4_WkLZw2r1aetSZbxFeh89rwcR6AIZTj_EE_Q1caDkbpyMCUUPgbF_6ObyqfDzJqi8CKl29IWz5GLywnplgwdWTqzpqOYMILPDOxaPBeCLp4hSmzWPeZjZAOEXyfM6kpQLcZI60OqGkp0XLPe80d8w5pfgB3xnJ4tXUBYGFIzSfK0LjxO5bsh8S9rHvfysn3W36ylLO73FRFbuirswA2mvIXBvQwOJ5jW-h73sBYV Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: info: New Spotify access token = BQCZcISdfxyvASp9-PIZWzTtSjSurV2aiVlYioRtZMylAUVaPuYdExB435lVgkmVKKf5pjBzYfaQ6iX4_WkLZw2r1aetSZbxFeh89rwcR6AIZTj_EE_Q1caDkbpyMCUUPgbF_6ObyqfDzJqi8CKl29IWz5GLywnplgwdWTqzpqOYMILPDOxaPBeCLp4hSmzWPeZjZAOEXyfM6kpQLcZI60OqGkp0XLPe80d8w5pfgB3xnJ4tXUBYGFIzSfK0LjxO5bsh8S9rHvfysn3W36ylLO73FRFbuirswA2mvIXBvQwOJ5jW-h73sBYV Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: info: Spotify credentials grant success - running version from March 24, 2019 Dec 30 05:43:34 volumio-rpi-201 sudo[20168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 30 05:43:34 volumio-rpi-201 sudo[20168]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:34 volumio-rpi-201 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 30 05:43:34 volumio-rpi-201 sudo[20162]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:34 volumio-rpi-201 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 30 05:43:34 volumio-rpi-201 systemd[1]: shairport-sync.service: Succeeded. Dec 30 05:43:34 volumio-rpi-201 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 30 05:43:34 volumio-rpi-201 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 30 05:43:34 volumio-rpi-201 sudo[20166]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:34 volumio-rpi-201 sudo[20168]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: error: MPD error: The expression evaluated to a falsy value: Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: assert.ok(self.idling) Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: error: The expression evaluated to a falsy value: Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: assert.ok(self.idling) Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetState Dec 30 05:43:34 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: MPD running with PID20094 Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: ,establishing connection Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: ir_controller: LIRC correctly updated. Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: ir_controller: HAT already loaded /proc/device-tree/ir_receiver! Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: Completed starting Core Plugins Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: ------------------------------------------- Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: ----- MyVolumio plugins startup ---- Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: ------------------------------------------- Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: Discovery: this is already registered, 53f96169-8014-4a5a-8983-6b67662381f9 Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: Discovery: Found device Volumio-RPi-201 Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetState Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: error: updateQueue error: null Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: Shairport-Sync Started Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: Error adding Membership: Error: addMembership EINVAL Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: Shairport-Sync Started Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: Shairport-Sync Started Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: error: updateQueue error: null Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: error: Failed to retrieve user informations: WebapiRegularError: An error occurred while communicating with Spotify's Web API. Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: Details: Spotify is unavailable in this country. Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: error: Spotify credentials failed to read user data: Dec 30 05:43:35 volumio-rpi-201 volumio[19921]: info: An error occurred while initializing Spotify Browsing facility: Dec 30 05:43:36 volumio-rpi-201 sudo[20177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service Dec 30 05:43:36 volumio-rpi-201 sudo[20177]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:36 volumio-rpi-201 lircd[18659]: lircd-0.10.1[18659]: Notice: caught signal Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[18659]: Notice: caught signal Dec 30 05:43:36 volumio-rpi-201 systemd[1]: Stopping Flexible IR remote input/output application support... Dec 30 05:43:36 volumio-rpi-201 systemd[1]: lircd.service: Main process exited, code=killed, status=15/TERM Dec 30 05:43:36 volumio-rpi-201 systemd[1]: lircd.service: Succeeded. Dec 30 05:43:36 volumio-rpi-201 systemd[1]: Stopped Flexible IR remote input/output application support. Dec 30 05:43:36 volumio-rpi-201 systemd[1]: irexec.service: Succeeded. Dec 30 05:43:36 volumio-rpi-201 systemd[1]: Starting lircd(8) initialization helper tool... Dec 30 05:43:36 volumio-rpi-201 lircd-setup[20179]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead. Dec 30 05:43:36 volumio-rpi-201 lircd-setup[20179]: parser = configparser.SafeConfigParser() Dec 30 05:43:36 volumio-rpi-201 systemd[1]: lircd-setup.service: Succeeded. Dec 30 05:43:36 volumio-rpi-201 systemd[1]: Started lircd(8) initialization helper tool. Dec 30 05:43:36 volumio-rpi-201 systemd[1]: Starting Flexible IR remote input/output application support... Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Info: lircd: Opening log, level: Info Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Version: lircd 0.10.1 Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: System info: Linux volumio-rpi-201 6.6.62-v7+ #1816 SMP Mon Nov 18 15:30:49 GMT 2024 armv7l GNU/Linux Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Info: Initial device: /dev/lirc0 Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Info: [lirc] protocol is enabled Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Info: Initial device: /dev/lirc0 Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Info: [lirc] protocol is enabled Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: driver: default Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: output: /var/run/lirc/lircd Dec 30 05:43:36 volumio-rpi-201 lircd[20180]: lircd-0.10.1[20180]: Info: lircd: Opening log, level: Info Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: nodaemon: 1 Dec 30 05:43:36 volumio-rpi-201 lircd[20180]: lircd-0.10.1[20180]: Notice: Using systemd fd Dec 30 05:43:36 volumio-rpi-201 lircd[20180]: lircd-0.10.1[20180]: Warning: Running as root Dec 30 05:43:36 volumio-rpi-201 lircd[20180]: lircd-0.10.1[20180]: Info: Using remote: lircd.conf. Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Dec 30 05:43:36 volumio-rpi-201 lircd[20180]: lircd-0.10.1[20180]: Notice: lircd(default) ready, using /var/run/lirc/lircd Dec 30 05:43:36 volumio-rpi-201 systemd[1]: Started Flexible IR remote input/output application support. Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: logfile: syslog Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: immediate-init: 0 Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: permission: 666 Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: driver-options: Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: listen: 0 Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: connect: (null) Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: userelease: 0 Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: effective_user: (null) Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: release_suffix: _EVUP Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: allow_simulate: 0 Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: repeat_max: 600 Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: configfile: /etc/lirc/lircd.conf Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Options: dynamic_codes: (null) Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Current driver: default Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Driver API version: 3 Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Driver version: 0.10.0 Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Info: lircd: Opening log, level: Info Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: Using systemd fd Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Warning: Running as root Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Info: Using remote: lircd.conf. Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: lircd(default) ready, using /var/run/lirc/lircd Dec 30 05:43:36 volumio-rpi-201 sudo[20177]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:36 volumio-rpi-201 volumio[19921]: info: ir_controller: systemctl restart lircd.service succeeded. Dec 30 05:43:36 volumio-rpi-201 sudo[20184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service Dec 30 05:43:36 volumio-rpi-201 sudo[20184]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:36 volumio-rpi-201 systemd[1]: Started Handle events from IR remotes decoded by lircd(8). Dec 30 05:43:36 volumio-rpi-201 lircd[20180]: lircd-0.10.1[20180]: Notice: accepted new client on /var/run/lirc/lircd Dec 30 05:43:36 volumio-rpi-201 lircd[20180]: lircd-0.10.1[20180]: Info: [lirc] protocol is enabled Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Notice: accepted new client on /var/run/lirc/lircd Dec 30 05:43:36 volumio-rpi-201 lircd-0.10.1[20180]: Info: [lirc] protocol is enabled Dec 30 05:43:36 volumio-rpi-201 sudo[20184]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:36 volumio-rpi-201 volumio[19921]: info: ir_controller: systemctl restart irexec.service succeeded. Dec 30 05:43:37 volumio-rpi-201 volumio-remote-updater[601]: [2025-12-30 05:43:37] [connect] Successful connection Dec 30 05:43:37 volumio-rpi-201 volumio-remote-updater[601]: [2025-12-30 05:43:37] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1767062617 101 Dec 30 05:43:37 volumio-rpi-201 volumio[19921]: 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: 117 Dec 30 05:43:37 volumio-rpi-201 sudo[20188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 30 05:43:37 volumio-rpi-201 sudo[20188]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:37 volumio-rpi-201 volumio[19921]: info: go-librespot daemon successfully initialized Dec 30 05:43:37 volumio-rpi-201 sudo[20191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 30 05:43:37 volumio-rpi-201 systemd[1]: Stopping MPD Monitor Service... Dec 30 05:43:37 volumio-rpi-201 sudo[20191]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:37 volumio-rpi-201 systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 30 05:43:37 volumio-rpi-201 systemd[1]: mpd_monitor.service: Succeeded. Dec 30 05:43:37 volumio-rpi-201 systemd[1]: Stopped MPD Monitor Service. Dec 30 05:43:37 volumio-rpi-201 systemd[1]: Started MPD Monitor Service. Dec 30 05:43:37 volumio-rpi-201 mpd_monitor.sh[20193]: MPD Monitor Service: Starting MPD Monitor Service Dec 30 05:43:37 volumio-rpi-201 sudo[20188]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:37 volumio-rpi-201 volumio[19921]: info: Successfully started MPD Monitor Dec 30 05:43:37 volumio-rpi-201 systemd[1]: Stopping MPD Monitor Service... Dec 30 05:43:37 volumio-rpi-201 systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 30 05:43:37 volumio-rpi-201 systemd[1]: mpd_monitor.service: Succeeded. Dec 30 05:43:37 volumio-rpi-201 systemd[1]: Stopped MPD Monitor Service. Dec 30 05:43:37 volumio-rpi-201 systemd[1]: Started MPD Monitor Service. Dec 30 05:43:37 volumio-rpi-201 sudo[20191]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:37 volumio-rpi-201 volumio[19921]: info: Successfully started MPD Monitor Dec 30 05:43:37 volumio-rpi-201 mpd_monitor.sh[20197]: MPD Monitor Service: Starting MPD Monitor Service Dec 30 05:43:39 volumio-rpi-201 mpd[20094]: exception: No database Dec 30 05:43:39 volumio-rpi-201 mpd[20094]: exception: No database Dec 30 05:43:39 volumio-rpi-201 volumio[19921]: error: Failed LSINFO: Error: [50@0] {lsinfo} No database Dec 30 05:43:40 volumio-rpi-201 volumio[19921]: info: Initializing connection to go-librespot Websocket Dec 30 05:43:40 volumio-rpi-201 go-librespot[20131]: time="2025-12-30T05:43:40+03:00" level=debug msg="new websocket client" Dec 30 05:43:40 volumio-rpi-201 volumio[19921]: info: Connection to go-librespot Websocket established Dec 30 05:43:40 volumio-rpi-201 sudo[20158]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:40 volumio-rpi-201 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 30 05:43:40 volumio-rpi-201 kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Dec 30 05:43:40 volumio-rpi-201 volumio[19921]: info: Cannot mount NAS Internal_Storage at system boot, trial number 2 ,retrying in 5 seconds Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: Getting Spotify volume Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 118 Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetState Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: Adding plugin bluetooth to MyMusic Plugins Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: Adding plugin multiroom to MyMusic Plugins Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: Adding plugin metavolumio to MyMusic Plugins Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: Adding plugin cd_controller to MyMusic Plugins Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: Adding plugin qobuzconnect to MyMusic Plugins Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 30 05:43:43 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 30 05:43:45 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 30 05:43:45 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 30 05:43:45 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 05:43:45 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 05:43:45 volumio-rpi-201 volumio[19921]: info: Starting MyVolumio Remote Streaming Endpoints Dec 30 05:43:45 volumio-rpi-201 volumio[19921]: info: MyVolumio login type: Token Dec 30 05:43:45 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 30 05:43:45 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 30 05:43:47 volumio-rpi-201 volumio[19921]: info: Starting Streaming Service Transparent Proxy Dec 30 05:43:47 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 30 05:43:47 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 30 05:43:47 volumio-rpi-201 volumio[19921]: info: Streaming services startup Dec 30 05:43:47 volumio-rpi-201 volumio[19921]: info: Starting Streaming Daemon Dec 30 05:43:47 volumio-rpi-201 sudo[20222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 30 05:43:47 volumio-rpi-201 sudo[20222]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:47 volumio-rpi-201 sudo[20222]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:47 volumio-rpi-201 volumio[19921]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Dec 30 05:43:48 volumio-rpi-201 volumio[19921]: error: Cannot start Volumio Streaming Daemon Dec 30 05:43:48 volumio-rpi-201 volumio[19921]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 30 05:43:48 volumio-rpi-201 volumio[19921]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 30 05:43:48 volumio-rpi-201 sudo[20230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.0.124/Internal Storage /mnt/NAS/Internal_Storage Dec 30 05:43:48 volumio-rpi-201 sudo[20230]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:48 volumio-rpi-201 kernel: CIFS: Attempting to mount //192.168.0.124/Internal Storage Dec 30 05:43:48 volumio-rpi-201 volumio[19921]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 30 05:43:49 volumio-rpi-201 volumio[19921]: info: MyVolumio token set successfully Dec 30 05:43:49 volumio-rpi-201 volumio[19921]: info: MYVOLUMIO: Adding device Dec 30 05:43:49 volumio-rpi-201 volumio[19921]: info: MYVOLUMIO: Evaluating Server Dec 30 05:43:50 volumio-rpi-201 volumio[19921]: STREAMING PROXY: Starting server on port 3245 Dec 30 05:43:50 volumio-rpi-201 volumio[19921]: Node JS runtime: 14 Dec 30 05:43:50 volumio-rpi-201 volumio[19921]: info: MyVolumio status changed Dec 30 05:43:50 volumio-rpi-201 volumio[19921]: info: Streaming services startup Dec 30 05:43:50 volumio-rpi-201 volumio[19921]: info: Starting Streaming Daemon Dec 30 05:43:50 volumio-rpi-201 volumio[19921]: info: Removing browser output: myVolumio user plan is not superstar Dec 30 05:43:50 volumio-rpi-201 volumio[19921]: info: Removing audio output: Dec 30 05:43:50 volumio-rpi-201 volumio[19921]: info: Stoppping Tunnel 1 Dec 30 05:43:50 volumio-rpi-201 sudo[20255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 30 05:43:50 volumio-rpi-201 sudo[20255]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:50 volumio-rpi-201 sudo[20255]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:50 volumio-rpi-201 sudo[20258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Dec 30 05:43:50 volumio-rpi-201 sudo[20258]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:50 volumio-rpi-201 volumio[19921]: error: Cannot start Volumio Streaming Daemon Dec 30 05:43:50 volumio-rpi-201 volumio[19921]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 30 05:43:50 volumio-rpi-201 volumio[19921]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 30 05:43:50 volumio-rpi-201 sudo[20258]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: Remote SSH Stopped Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: Setting Geolocation for MyVolumio to eu2 Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: AutoStart - Plugin is starting Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetQueue Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::getQueue Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getQueue Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: AutoStart - start playing Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: AutoStart - start playing with no specific position Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPlay Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::play index 0 Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::stop Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::play index undefined Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::startPlaybackTimer Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::clearAddPlayTracks http://abagian.ru:8098/Audio/98926/stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: sendMpdCommand stop took 18 milliseconds Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand clear Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces system playlist update Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: Ignoring MPD Status Update Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: sendMpdCommand clear took 5 milliseconds Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand add "http://abagian.ru:8098/Audio/98926/stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true" Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces system playlist update Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: Ignoring MPD Status Update Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces system playlist update Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: Ignoring MPD Status Update Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: error: updateQueue error: null Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces system playlist update Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: Ignoring MPD Status Update Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: ------------------------------ 19ms Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: sendMpdCommand add "http://abagian.ru:8098/Audio/98926/stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true" took 14 milliseconds Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: ------------------------------ 13ms Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: ------------------------------ 12ms Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand play Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces system playlist update Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: Ignoring MPD Status Update Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces system playlist update Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: Ignoring MPD Status Update Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: ------------------------------ 19ms Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: sendMpdCommand play took 11 milliseconds Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: ------------------------------ 9ms Dec 30 05:43:51 volumio-rpi-201 volumio[19921]: info: ------------------------------ 7ms Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces state update: player Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::getState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand status Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces state update: player Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::getState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand status Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces state update: player Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::getState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand status Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces state update: player Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::getState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand status Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces state update: player Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand status took 20 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::getState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand status Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand status took 19 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces state update: player Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::getState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand status Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand status took 33 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand status took 29 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand status took 21 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand playlistinfo took 16 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseTrackInfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseTrackInfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::servicePushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":192,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true","artist":null,"album":null,"uri":"http://abagian.ru:8098/Audio/98926/stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true","trackType":""} Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: CURRENT POSITION 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState stateService play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState currentStatus stop Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::servicePushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":192,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true","artist":null,"album":null,"uri":"http://abagian.ru:8098/Audio/98926/stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true","trackType":""} Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: CURRENT POSITION 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState stateService play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState currentStatus play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Received an update from plugin. extracting info from payload Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ------------------------------ 140ms Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ------------------------------ 180ms Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Updating MyVolumio device info Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand status took 160 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand playlistinfo took 150 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand playlistinfo took 149 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand playlistinfo took 148 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseTrackInfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseTrackInfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseTrackInfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::servicePushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":192,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true","artist":null,"album":null,"uri":"http://abagian.ru:8098/Audio/98926/stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true","trackType":""} Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: CURRENT POSITION 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState stateService play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState currentStatus play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Received an update from plugin. extracting info from payload Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::servicePushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":192,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true","artist":null,"album":null,"uri":"http://abagian.ru:8098/Audio/98926/stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true","trackType":""} Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: CURRENT POSITION 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState stateService play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState currentStatus play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Received an update from plugin. extracting info from payload Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::servicePushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":192,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true","artist":null,"album":null,"uri":"http://abagian.ru:8098/Audio/98926/stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true","trackType":""} Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: CURRENT POSITION 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState stateService play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState currentStatus play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Received an update from plugin. extracting info from payload Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ------------------------------ 531ms Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ------------------------------ 529ms Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ------------------------------ 526ms Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetQueue Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::getQueue Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getQueue Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces system playlist update Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Ignoring MPD Status Update Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces state update: player Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand playlistinfo took 454 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::getState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand status Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseTrackInfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::servicePushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":192,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true","artist":null,"album":null,"uri":"http://abagian.ru:8098/Audio/98926/stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true","trackType":""} Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: CURRENT POSITION 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState stateService play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState currentStatus play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Received an update from plugin. extracting info from payload Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ------------------------------ 723ms Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Successfully Added MyVolumio device Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces system playlist update Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Ignoring MPD Status Update Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces state update: player Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::getState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand status Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces system playlist update Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Ignoring MPD Status Update Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: ---------------------------- MPD announces state update: player Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::getState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand status Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ------------------------------ 143ms Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand status took 138 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ------------------------------ 19ms Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand status took 16 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ------------------------------ 15ms Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand status took 12 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand playlistinfo took 33 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand playlistinfo took 32 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: sendMpdCommand playlistinfo took 31 milliseconds Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseTrackInfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseTrackInfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::parseTrackInfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::servicePushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57,"duration":0,"samplerate":192,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Leave in Silence","artist":"Depeche Mode","album":"A Broken Frame","uri":"http://abagian.ru:8098/Audio/98926/stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true","trackType":""} Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: CURRENT POSITION 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState stateService play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState currentStatus play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Received an update from plugin. extracting info from payload Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::servicePushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":175,"duration":0,"samplerate":192,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Leave in Silence","artist":"Depeche Mode","album":"A Broken Frame","uri":"http://abagian.ru:8098/Audio/98926/stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true","trackType":""} Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: CURRENT POSITION 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState stateService play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState currentStatus play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Received an update from plugin. extracting info from payload Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: ControllerMpd::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::servicePushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":186,"duration":0,"samplerate":192,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Leave in Silence","artist":"Depeche Mode","album":"A Broken Frame","uri":"http://abagian.ru:8098/Audio/98926/stream?api_key=46320e03439846259ed31083cafa9ebb&Static=true","trackType":""} Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: verbose: CURRENT POSITION 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState stateService play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::syncState currentStatus play Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: Received an update from plugin. extracting info from payload Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:43:52 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:43:53 volumio-rpi-201 volumio[19921]: info: ------------------------------ 507ms Dec 30 05:43:53 volumio-rpi-201 volumio[19921]: info: ------------------------------ 384ms Dec 30 05:43:53 volumio-rpi-201 volumio[19921]: info: ------------------------------ 381ms Dec 30 05:43:53 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 30 05:43:54 volumio-rpi-201 volumio[19921]: info: Successfully Updated MyVolumio device Dec 30 05:43:54 volumio-rpi-201 sudo[20230]: pam_unix(sudo:session): session closed for user root Dec 30 05:43:54 volumio-rpi-201 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 30 05:43:54 volumio-rpi-201 kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Dec 30 05:43:54 volumio-rpi-201 volumio[19921]: info: Cannot mount NAS Internal_Storage at system boot, trial number 3 ,retrying in 5 seconds Dec 30 05:43:59 volumio-rpi-201 sudo[20322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.0.124/Internal Storage /mnt/NAS/Internal_Storage Dec 30 05:43:59 volumio-rpi-201 sudo[20322]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 05:43:59 volumio-rpi-201 kernel: CIFS: Attempting to mount //192.168.0.124/Internal Storage Dec 30 05:44:00 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 30 05:44:00 volumio-rpi-201 volumio[19921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 69 Dec 30 05:44:00 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetState Dec 30 05:44:00 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:44:01 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 30 05:44:01 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 05:44:01 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 30 05:44:01 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: ru-radio , handleBrowseUri Dec 30 05:44:01 volumio-rpi-201 volumio[19921]: info: Preload queue cleared Dec 30 05:44:01 volumio-rpi-201 volumio-remote-updater[601]: Test mode enabled Dec 30 05:44:01 volumio-rpi-201 volumio-remote-updater[601]: No alpha test mode Dec 30 05:44:01 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 30 05:44:01 volumio-rpi-201 volumio[19921]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

\n
    \n
  • Fix for Streaming Services playback in case of network interruptions
    • \n
\n

NEW ADDITIONS

\n
    \n
  • BLE-based onboarding setup
    • \n
\n","title":"Update v3.887","updateavailable":true} Dec 30 05:44:01 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 30 05:44:03 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: ru-radio , handleBrowseUri Dec 30 05:44:03 volumio-rpi-201 volumio[19921]: info: Preload queue cleared Dec 30 05:44:05 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:44:05 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 05:44:05 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Dec 30 05:44:05 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 30 05:44:05 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 30 05:44:05 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioGetBrowseSources Dec 30 05:44:05 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 30 05:44:05 volumio-rpi-201 sudo[20322]: pam_unix(sudo:session): session closed for user root Dec 30 05:44:05 volumio-rpi-201 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 30 05:44:05 volumio-rpi-201 kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Dec 30 05:44:05 volumio-rpi-201 volumio[19921]: info: Cannot mount NAS Internal_Storage at system boot, trial number 4 ,retrying in 5 seconds Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: Preload queue cleared Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::ClearQueue Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::stop Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::stPlaybackTimer Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::updateTrackBlock Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrackBlock Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::pushState Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushState Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::serviceStop Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::getTrack 0 Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::serviceStop Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: ControllerMpd::stop Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::clearPlayQueue Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::saveQueue Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CoreCommandRouter::volumioPushQueue Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CoreStateMachine::addQueueItems Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: CorePlayQueue::addQueueItems Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: Preload queue cleared Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: Adding Item to queue: ru-radio/avto-radio-001 Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: info: Exploding uri ru-radio/avto-radio-001 in service ru-radio Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: TypeError: thisPlugin.explodeUri(...).then(...).fail is not a function Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1386:8) Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:251:25) Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:526:23) Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:484:17) Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: at Socket.emit (events.js:315:20) Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Dec 30 05:44:06 volumio-rpi-201 volumio[19921]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 05:44:08 volumio-rpi-201 sudo[20352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-30 05:43 Dec 30 05:44:08 volumio-rpi-201 sudo[20352]: 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="5d50cd80bebce60dddccd7f5e813d656e28ca4cd" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="7840f283c310c38bfe939a4c485727a6ff6a0ce1" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 21 Oct 2025 03:46:47 PM CEST" VOLUMIO_VERSION="3.866" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e2f3a8aca3147ba51b5da8167dd6ff8"