-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Sun 2024-07-14 16:44:31 CEST. -- Jul 14 16:43:00 volumio sudo[5433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //\\\\eicloudpriv/public /mnt/NAS/Eicloud Jul 14 16:43:00 volumio sudo[5433]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:00 volumio sudo[5433]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:00 volumio volumio[5229]: info: Cannot mount NAS Eicloud at system boot, trial number 3 ,retrying in 5 seconds Jul 14 16:43:00 volumio volumio[5229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 14 16:43:02 volumio volumio[5229]: info: Adding plugin bluetooth to MyMusic Plugins Jul 14 16:43:02 volumio volumio[5229]: info: Adding plugin multiroom to MyMusic Plugins Jul 14 16:43:02 volumio volumio[5229]: info: Adding plugin metavolumio to MyMusic Plugins Jul 14 16:43:02 volumio volumio[5229]: info: Adding plugin cd_controller to MyMusic Plugins Jul 14 16:43:02 volumio volumio[5229]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 14 16:43:02 volumio volumio[5229]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 14 16:43:02 volumio volumio[5229]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 14 16:43:04 volumio volumio[5229]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 14 16:43:04 volumio volumio[5229]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 14 16:43:04 volumio volumio[5229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:04 volumio volumio[5229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:04 volumio volumio[5229]: info: Starting MyVolumio Remote Streaming Endpoints Jul 14 16:43:04 volumio volumio[5229]: info: MyVolumio not started Jul 14 16:43:04 volumio volumio[5229]: info: Initializing device activation check Jul 14 16:43:04 volumio volumio[5229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:04 volumio volumio[5229]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 14 16:43:04 volumio volumio[5229]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 14 16:43:06 volumio volumio[5229]: info: Starting Streaming Service Transparent Proxy Jul 14 16:43:06 volumio volumio[5229]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 14 16:43:06 volumio volumio[5229]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 14 16:43:06 volumio volumio[5229]: info: Streaming services startup Jul 14 16:43:06 volumio volumio[5229]: info: Starting Streaming Daemon Jul 14 16:43:06 volumio sudo[5485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 14 16:43:06 volumio sudo[5485]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:06 volumio volumio[5229]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jul 14 16:43:06 volumio sudo[5485]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:06 volumio volumio[5229]: error: Cannot start Volumio Streaming Daemon Jul 14 16:43:06 volumio volumio[5229]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 14 16:43:06 volumio volumio[5229]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 14 16:43:06 volumio sudo[5493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //\\\\eicloudpriv/public /mnt/NAS/Eicloud Jul 14 16:43:06 volumio sudo[5493]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:06 volumio sudo[5493]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:06 volumio volumio[5229]: info: Cannot mount NAS Eicloud at system boot, trial number 4 ,retrying in 5 seconds Jul 14 16:43:06 volumio volumio[5229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:43:07 volumio volumio[5229]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jul 14 16:43:07 volumio volumio[5229]: STREAMING PROXY: Starting server on port 3245 Jul 14 16:43:07 volumio volumio[5229]: Node JS runtime: 14 Jul 14 16:43:08 volumio volumio[5229]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 14 16:43:08 volumio volumio[5229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:43:11 volumio volumio[5229]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 16:43:11 volumio volumio[5229]: TypeError: Cannot read property 'replace' of undefined Jul 14 16:43:11 volumio volumio[5229]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Jul 14 16:43:11 volumio volumio[5229]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Jul 14 16:43:11 volumio volumio[5229]: at listOnTimeout (internal/timers.js:554:17) Jul 14 16:43:11 volumio volumio[5229]: at processTimers (internal/timers.js:497:7) Jul 14 16:43:11 volumio volumio[5229]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 16:43:12 volumio sudo[5508]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-14 16:42 Jul 14 16:43:12 volumio sudo[5508]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:12 volumio sudo[5508]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:12 volumio volumio-remote-updater[1433]: [2024-07-14 14:43:12] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 14 16:43:12 volumio volumio-remote-updater[1433]: [2024-07-14 14:43:12] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 14 16:43:12 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jul 14 16:43:12 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jul 14 16:43:12 volumio systemd[1]: Started dynamicswap service. Jul 14 16:43:12 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 14 16:43:13 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jul 14 16:43:13 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Jul 14 16:43:13 volumio systemd[1]: Stopped Volumio Backend Module. Jul 14 16:43:13 volumio systemd[1]: Started Volumio Backend Module. Jul 14 16:43:13 volumio systemd[1]: Started dynamicswap service. Jul 14 16:43:13 volumio systemd[1]: dynamicswap.service: Succeeded. Jul 14 16:43:15 volumio volumio[5522]: info: ------------------------------------------- Jul 14 16:43:15 volumio volumio[5522]: info: ----- Volumio3 ---- Jul 14 16:43:15 volumio volumio[5522]: info: ------------------------------------------- Jul 14 16:43:15 volumio volumio[5522]: info: ----- System startup ---- Jul 14 16:43:15 volumio volumio[5522]: info: ------------------------------------------- Jul 14 16:43:16 volumio volumio[5522]: info: MYVOLUMIO Environment detected Jul 14 16:43:16 volumio volumio[5522]: info: Plugin folders cleanup Jul 14 16:43:16 volumio volumio[5522]: info: Scanning into folder /volumio/app/plugins/ Jul 14 16:43:16 volumio volumio[5522]: info: Scanning category audio_interface Jul 14 16:43:16 volumio volumio[5522]: info: Scanning category miscellanea Jul 14 16:43:16 volumio volumio[5522]: info: Scanning category music_service Jul 14 16:43:16 volumio volumio[5522]: info: Scanning category plugins.json Jul 14 16:43:16 volumio volumio[5522]: info: Scanning category system_controller Jul 14 16:43:16 volumio volumio[5522]: info: Scanning category user_interface Jul 14 16:43:16 volumio volumio[5522]: info: Scanning into folder /data/plugins/ Jul 14 16:43:16 volumio volumio[5522]: info: Plugin folders cleanup completed Jul 14 16:43:16 volumio volumio[5522]: info: ------------------------------------------- Jul 14 16:43:16 volumio volumio[5522]: info: ----- Core plugins startup ---- Jul 14 16:43:16 volumio volumio[5522]: info: ------------------------------------------- Jul 14 16:43:16 volumio volumio[5522]: info: Loading plugins from folder /volumio/app/plugins/ Jul 14 16:43:16 volumio volumio[5522]: info: Adding plugin upnp to MyMusic Plugins Jul 14 16:43:16 volumio volumio[5522]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 14 16:43:16 volumio volumio[5522]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 14 16:43:16 volumio volumio[5522]: info: Loading plugins from folder /data/plugins/ Jul 14 16:43:16 volumio volumio[5522]: info: Loading plugin "system"... Jul 14 16:43:16 volumio volumio[5522]: info: Loading plugin "appearance"... Jul 14 16:43:17 volumio volumio-remote-updater[1433]: [2024-07-14 14:43:17] [connect] Successful connection Jul 14 16:43:17 volumio volumio[5522]: info: Loading plugin "network"... Jul 14 16:43:17 volumio volumio[5522]: info: Refreshing Cached IP Addresses Jul 14 16:43:17 volumio sudo[5549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 14 16:43:17 volumio sudo[5549]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:17 volumio volumio[5522]: info: Loading plugin "services"... Jul 14 16:43:17 volumio sudo[5551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 14 16:43:17 volumio sudo[5551]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:17 volumio sudo[5551]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:17 volumio sudo[5554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 14 16:43:17 volumio volumio[5522]: info: Loading plugin "alsa_controller"... Jul 14 16:43:17 volumio sudo[5554]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:17 volumio sudo[5549]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:18 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 14 16:43:18 volumio volumio[5522]: info: Loading plugin "wizard"... Jul 14 16:43:18 volumio volumio[5522]: info: Loading plugin "networkfs"... Jul 14 16:43:18 volumio volumio[5522]: info: Starting Udev Watcher for removable devices Jul 14 16:43:18 volumio volumio[5522]: info: Ignoring mount for partition: boot Jul 14 16:43:18 volumio volumio[5522]: info: Ignoring mount for partition: volumio Jul 14 16:43:18 volumio volumio[5522]: info: Ignoring mount for partition: volumio_data Jul 14 16:43:18 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 14 16:43:18 volumio volumio[5522]: info: Loading plugin "volumio_command_line_client"... Jul 14 16:43:18 volumio volumio[5522]: info: Loading plugin "upnp"... Jul 14 16:43:18 volumio volumio[5522]: info: [1720968198179] Starting Upmpd Daemon Jul 14 16:43:18 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 14 16:43:18 volumio volumio[5522]: info: Loading plugin "my_music"... Jul 14 16:43:18 volumio volumio[5522]: info: Loading plugin "mpd"... Jul 14 16:43:18 volumio volumio[5522]: info: Loading plugin "upnp_browser"... Jul 14 16:43:18 volumio sudo[5554]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:19 volumio volumio[5522]: info: Loading plugin "alarm-clock"... Jul 14 16:43:19 volumio volumio[5522]: info: Loading plugin "airplay_emulation"... Jul 14 16:43:19 volumio volumio[5522]: info: Starting Shairport Sync Jul 14 16:43:19 volumio volumio[5522]: info: Loading plugin "last_100"... Jul 14 16:43:19 volumio volumio[5522]: info: Loading plugin "webradio"... Jul 14 16:43:19 volumio volumio[5522]: info: Loading plugin "i2s_dacs"... Jul 14 16:43:19 volumio volumio[5522]: info: I2S DAC not set, start Auto-detection Jul 14 16:43:19 volumio volumio[5522]: info: Loading plugin "volumiodiscovery"... Jul 14 16:43:19 volumio volumio[5522]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 14 16:43:19 volumio volumio[5522]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 14 16:43:19 volumio volumio[5522]: *** WARNING *** For more information see Jul 14 16:43:19 volumio volumio[5522]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 14 16:43:19 volumio node[5522]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 14 16:43:19 volumio volumio[5522]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 14 16:43:19 volumio volumio[5522]: *** WARNING *** For more information see Jul 14 16:43:19 volumio node[5522]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 14 16:43:19 volumio node[5522]: *** WARNING *** For more information see Jul 14 16:43:19 volumio node[5522]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 14 16:43:19 volumio node[5522]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 14 16:43:19 volumio node[5522]: *** WARNING *** For more information see Jul 14 16:43:19 volumio volumio[5522]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 14 16:43:19 volumio volumio[5522]: info: Discovery: Started advertising with name: Volumio Jul 14 16:43:19 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 14 16:43:19 volumio volumio[5522]: info: Loading plugin "outputs"... Jul 14 16:43:19 volumio volumio[5522]: info: Loading plugin "albumart"... Jul 14 16:43:19 volumio volumio[5522]: info: Plugin example_plugin is not enabled Jul 14 16:43:19 volumio volumio[5522]: info: Loading plugin "inputs"... Jul 14 16:43:19 volumio volumio[5522]: info: Loading plugin "updater_comm"... Jul 14 16:43:20 volumio volumio[5522]: info: Plugin mpdemulation is not enabled Jul 14 16:43:20 volumio volumio[5522]: info: Loading plugin "rest_api"... Jul 14 16:43:20 volumio volumio[5522]: info: Loading plugin "websocket"... Jul 14 16:43:20 volumio volumio[5522]: info: Starting Socket.io Server version 2.3.0 Jul 14 16:43:20 volumio volumio[5522]: info: Loading i18n strings for locale de Jul 14 16:43:20 volumio volumio[5522]: Updating browse sources language Jul 14 16:43:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 16:43:20 volumio volumio[5522]: Forking 3 albumart workers Jul 14 16:43:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 14 16:43:20 volumio volumio[5522]: info: CoreCommandRouter::initPlayerControls Jul 14 16:43:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 14 16:43:20 volumio volumio[5522]: Express server listening on port 3000 Jul 14 16:43:20 volumio volumio[5522]: [Metrics] WebUI: 6s 109.20ms Jul 14 16:43:20 volumio volumio[5522]: info: CoreStateMachine::resetVolumioState Jul 14 16:43:20 volumio volumio[5522]: info: CoreStateMachine::getcurrentVolume Jul 14 16:43:20 volumio volumio[5522]: info: CoreCommandRouter::volumioRetrievevolume Jul 14 16:43:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:21 volumio volumio[5522]: verbose: New Socket.io Connection to 192.168.188.199 from 192.168.188.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Edg/126.0.0.0 Engine version: 3 Transport: polling Total Clients: 1 Jul 14 16:43:21 volumio volumio[5522]: verbose: New Socket.io Connection to 192.168.188.199 from 192.168.188.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Edg/126.0.0.0 Engine version: 3 Transport: polling Total Clients: 2 Jul 14 16:43:21 volumio volumio-remote-updater[1433]: [2024-07-14 14:43:21] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1720968197 101 Jul 14 16:43:21 volumio volumio[5522]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3 Jul 14 16:43:21 volumio volumio[5522]: info: Reloading queue from file Jul 14 16:43:21 volumio volumio[5522]: info: Setting Device type: Raspberry PI Jul 14 16:43:21 volumio volumio[5522]: info: CoreStateMachine::setRepeat null single undefined Jul 14 16:43:21 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:21 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:21 volumio volumio[5522]: info: CoreStateMachine::setRandom null Jul 14 16:43:21 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:21 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:21 volumio volumio[5522]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jul 14 16:43:21 volumio volumio[5522]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Jul 14 16:43:21 volumio volumio[5522]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jul 14 16:43:21 volumio volumio[5522]: info: VolumeController:: Volume=86 Mute =false Jul 14 16:43:21 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:21 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:21 volumio volumio[5522]: info: CoreStateMachine::updateTrackBlock Jul 14 16:43:21 volumio volumio[5522]: info: CorePlayQueue::getTrackBlock Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::volumioRetrievevolume Jul 14 16:43:21 volumio volumio[5522]: verbose: New Socket.io Connection to 192.168.188.199 from 192.168.188.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Edg/126.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Jul 14 16:43:21 volumio volumio[5522]: info: Completed loading Core Plugins Jul 14 16:43:21 volumio volumio[5522]: info: Preparing to generate the ALSA configuration file Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:43:21 volumio volumio[5522]: info: Discovery: adding 73c43b9c-ef1b-4a51-ab52-19c5276a216d Jul 14 16:43:21 volumio volumio[5522]: info: Discovery: Found device Volumio Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::volumioGetState Jul 14 16:43:21 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::volumioGetVisibleSources Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::volumioGetState Jul 14 16:43:21 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::volumioGetState Jul 14 16:43:21 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 14 16:43:21 volumio volumio[5522]: info: Received Get System Info Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 14 16:43:21 volumio volumio[5522]: info: Discovery: Getting this device information Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::volumioGetState Jul 14 16:43:21 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::volumioGetState Jul 14 16:43:21 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:21 volumio volumio[5522]: info: Listing playlists Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::volumioGetQueue Jul 14 16:43:21 volumio volumio[5522]: info: CoreStateMachine::getQueue Jul 14 16:43:21 volumio volumio[5522]: info: CorePlayQueue::getQueue Jul 14 16:43:21 volumio volumio[5522]: Starting albumart workers Jul 14 16:43:21 volumio volumio[5522]: Starting albumart workers Jul 14 16:43:21 volumio volumio[5522]: info: Asound.conf file unchanged, so no further update is needed Jul 14 16:43:21 volumio volumio[5522]: info: Output device has changed, restarting MPD Jul 14 16:43:21 volumio volumio[5522]: Starting albumart workers Jul 14 16:43:21 volumio volumio[5522]: info: Output device has changed, restarting Shairport Sync Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:21 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:21 volumio sudo[5608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 14 16:43:21 volumio sudo[5609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 14 16:43:21 volumio sudo[5608]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:21 volumio sudo[5609]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:21 volumio volumio[5522]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 14 16:43:21 volumio volumio[5522]: info: ___________ START PLUGINS ___________ Jul 14 16:43:21 volumio volumio[5522]: info: ControllerMpd::onStart: Initializing MPD Jul 14 16:43:21 volumio sudo[5608]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:21 volumio volumio[5522]: info: Creating MPD Configuration file Jul 14 16:43:22 volumio systemd[1]: Stopping Music Player Daemon... Jul 14 16:43:22 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 14 16:43:22 volumio volumio[5522]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 14 16:43:22 volumio volumio[5522]: info: [1720968202042] CoreMusicLibrary::Adding element Medienserver Jul 14 16:43:22 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 16:43:22 volumio sudo[5617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 14 16:43:22 volumio sudo[5617]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:22 volumio sudo[5618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 14 16:43:22 volumio sudo[5618]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:22 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:22 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:22 volumio sudo[5617]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:22 volumio systemd[1]: mpd.service: Succeeded. Jul 14 16:43:22 volumio systemd[1]: Stopped Music Player Daemon. Jul 14 16:43:22 volumio volumio[5522]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 14 16:43:22 volumio systemd[1]: Starting Music Player Daemon... Jul 14 16:43:22 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:22 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:22 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 14 16:43:22 volumio systemd[1]: mpd.service: Succeeded. Jul 14 16:43:22 volumio systemd[1]: Stopped Music Player Daemon. Jul 14 16:43:22 volumio systemd[1]: Starting Music Player Daemon... Jul 14 16:43:22 volumio volumio[5522]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 14 16:43:22 volumio volumio[5522]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 14 16:43:22 volumio volumio[5522]: info: [1720968202363] CoreMusicLibrary::Adding element Last_100 Jul 14 16:43:22 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 16:43:22 volumio volumio[5522]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 14 16:43:22 volumio volumio[5522]: info: [1720968202371] CoreMusicLibrary::Adding element Webradio Jul 14 16:43:22 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 16:43:22 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 14 16:43:22 volumio volumio[5522]: info: Initializing BBC Radios Jul 14 16:43:22 volumio volumio[5522]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jul 14 16:43:22 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:22 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 14 16:43:22 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:22 volumio sudo[5628]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 14 16:43:22 volumio sudo[5628]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:22 volumio sudo[5628]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:22 volumio volumio[5522]: info: Volumio Calling Home Jul 14 16:43:23 volumio volumio[5522]: info: MPD Permissions set Jul 14 16:43:23 volumio volumio[5522]: info: MPD Permissions set Jul 14 16:43:23 volumio volumio[5522]: info: VolumeController:: Volume=86 Mute =false Jul 14 16:43:23 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:23 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:23 volumio volumio[5522]: info: Volumio called home Jul 14 16:43:23 volumio volumio[5522]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:23 volumio volumio[5522]: info: Starting Shairport Sync Jul 14 16:43:23 volumio volumio[5522]: info: Starting Shairport Sync Jul 14 16:43:23 volumio volumio[5522]: info: Starting Shairport Sync Jul 14 16:43:23 volumio sudo[5678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 14 16:43:23 volumio sudo[5678]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:24 volumio volumio[5522]: info: CoreCommandRouter::volumioGetState Jul 14 16:43:24 volumio sudo[5680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 14 16:43:24 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:24 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 14 16:43:24 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 14 16:43:24 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 14 16:43:24 volumio sudo[5683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 14 16:43:24 volumio sudo[5680]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:24 volumio sudo[5683]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:24 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 14 16:43:24 volumio sudo[5678]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:24 volumio volumio[5522]: info: Shairport-Sync Started Jul 14 16:43:24 volumio volumio[5522]: Error adding Membership: Error: addMembership EINVAL Jul 14 16:43:24 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 14 16:43:24 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 14 16:43:24 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 14 16:43:24 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 14 16:43:24 volumio sudo[5680]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:24 volumio volumio[5522]: info: Shairport-Sync Started Jul 14 16:43:24 volumio sudo[5683]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:24 volumio volumio[5522]: info: Shairport-Sync Started Jul 14 16:43:24 volumio mpd[5640]: Jul 14 16:43 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 14 16:43:24 volumio systemd[1]: Started Music Player Daemon. Jul 14 16:43:24 volumio sudo[5618]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:24 volumio sudo[5609]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:24 volumio volumio[5522]: info: Completed starting Core Plugins Jul 14 16:43:24 volumio volumio[5522]: info: ------------------------------------------- Jul 14 16:43:24 volumio volumio[5522]: info: ----- MyVolumio plugins startup ---- Jul 14 16:43:24 volumio volumio[5522]: info: ------------------------------------------- Jul 14 16:43:24 volumio volumio[5522]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 14 16:43:25 volumio volumio[5522]: error: MPD error: The expression evaluated to a falsy value: Jul 14 16:43:25 volumio volumio[5522]: assert.ok(self.idling) Jul 14 16:43:25 volumio volumio[5522]: error: The expression evaluated to a falsy value: Jul 14 16:43:25 volumio volumio[5522]: assert.ok(self.idling) Jul 14 16:43:25 volumio volumio[5522]: error: updateQueue error: null Jul 14 16:43:25 volumio volumio[5522]: info: MPD running with PID5640 Jul 14 16:43:25 volumio volumio[5522]: ,establishing connection Jul 14 16:43:25 volumio volumio[5522]: error: updateQueue error: null Jul 14 16:43:28 volumio sudo[5696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 14 16:43:28 volumio sudo[5696]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:28 volumio sudo[5698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 14 16:43:28 volumio sudo[5698]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:28 volumio sudo[5698]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:28 volumio sudo[5696]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:28 volumio sudo[5703]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 14 16:43:28 volumio sudo[5703]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:28 volumio sudo[5703]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:28 volumio volumio[5522]: info: Upmpdcli Daemon Started Jul 14 16:43:28 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:43:28 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:43:29 volumio volumio[5522]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jul 14 16:43:32 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 14 16:43:35 volumio volumio[5522]: info: Adding plugin bluetooth to MyMusic Plugins Jul 14 16:43:35 volumio volumio[5522]: info: Adding plugin multiroom to MyMusic Plugins Jul 14 16:43:35 volumio volumio[5522]: info: Adding plugin metavolumio to MyMusic Plugins Jul 14 16:43:35 volumio volumio[5522]: info: Adding plugin cd_controller to MyMusic Plugins Jul 14 16:43:35 volumio volumio[5522]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 14 16:43:35 volumio volumio[5522]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 14 16:43:35 volumio volumio[5522]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 14 16:43:36 volumio volumio[5522]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 14 16:43:36 volumio volumio[5522]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 14 16:43:36 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:36 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:36 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:36 volumio volumio[5522]: info: Starting MyVolumio Remote Streaming Endpoints Jul 14 16:43:36 volumio volumio[5522]: info: MyVolumio not started Jul 14 16:43:36 volumio volumio[5522]: info: Initializing device activation check Jul 14 16:43:36 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:36 volumio volumio[5522]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 14 16:43:36 volumio volumio[5522]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 14 16:43:38 volumio volumio[5522]: info: Starting Streaming Service Transparent Proxy Jul 14 16:43:38 volumio volumio[5522]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 14 16:43:38 volumio volumio[5522]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 14 16:43:38 volumio volumio[5522]: info: Streaming services startup Jul 14 16:43:38 volumio volumio[5522]: info: Starting Streaming Daemon Jul 14 16:43:38 volumio sudo[5713]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 14 16:43:38 volumio sudo[5713]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:43:38 volumio sudo[5713]: pam_unix(sudo:session): session closed for user root Jul 14 16:43:38 volumio volumio[5522]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jul 14 16:43:38 volumio volumio[5522]: error: Cannot start Volumio Streaming Daemon Jul 14 16:43:38 volumio volumio[5522]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 14 16:43:38 volumio volumio[5522]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 14 16:43:38 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:43:38 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Jul 14 16:43:38 volumio volumio[5522]: info: Adding a new share Jul 14 16:43:38 volumio volumio[5522]: info: Share alias is blank Jul 14 16:43:39 volumio volumio[5522]: STREAMING PROXY: Starting server on port 3245 Jul 14 16:43:39 volumio volumio[5522]: Node JS runtime: 14 Jul 14 16:43:40 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:43:44 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jul 14 16:43:44 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand rescan Jul 14 16:43:44 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:44 volumio volumio[5522]: info: Jul 14 16:43:44 volumio volumio[5522]: ---------------------------- MPD announces state update: update Jul 14 16:43:44 volumio volumio[5522]: info: sendMpdCommand rescan took 9 milliseconds Jul 14 16:43:44 volumio volumio[5522]: info: ControllerMpd::getState Jul 14 16:43:44 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:44 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:44 volumio volumio[5522]: info: Jul 14 16:43:44 volumio volumio[5522]: ---------------------------- MPD announces state update: update Jul 14 16:43:44 volumio volumio[5522]: info: ControllerMpd::getState Jul 14 16:43:44 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:44 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:44 volumio volumio[5522]: info: Jul 14 16:43:44 volumio volumio[5522]: ---------------------------- MPD announces state update: update Jul 14 16:43:44 volumio volumio[5522]: info: ControllerMpd::getState Jul 14 16:43:44 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:44 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:44 volumio volumio[5522]: info: Jul 14 16:43:44 volumio volumio[5522]: ---------------------------- MPD announces state update: update Jul 14 16:43:44 volumio volumio[5522]: info: sendMpdCommand status took 38 milliseconds Jul 14 16:43:44 volumio volumio[5522]: info: ControllerMpd::getState Jul 14 16:43:44 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:44 volumio volumio[5522]: info: sendMpdCommand status took 34 milliseconds Jul 14 16:43:44 volumio volumio[5522]: info: sendMpdCommand status took 27 milliseconds Jul 14 16:43:44 volumio volumio[5522]: info: sendMpdCommand status took 23 milliseconds Jul 14 16:43:44 volumio volumio[5522]: info: sendMpdCommand status took 21 milliseconds Jul 14 16:43:44 volumio volumio[5522]: info: sendMpdCommand status took 17 milliseconds Jul 14 16:43:44 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:44 volumio volumio[5522]: info: Command Router : Notfying DB Updatetrue Jul 14 16:43:44 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:44 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:44 volumio volumio[5522]: info: Command Router : Notfying DB Updatefalse Jul 14 16:43:44 volumio volumio[5522]: info: CoreCommandRouter::Close All Modals sent Jul 14 16:43:44 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:44 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:44 volumio volumio[5522]: info: Command Router : Notfying DB Updatefalse Jul 14 16:43:44 volumio volumio[5522]: info: CoreCommandRouter::Close All Modals sent Jul 14 16:43:45 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:45 volumio volumio[5522]: info: ControllerMpd::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::servicePushState Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 14 16:43:45 volumio volumio[5522]: verbose: CURRENT POSITION 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::syncState stateService stop Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::syncState currentStatus stop Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: No code Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: ControllerMpd::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::servicePushState Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 14 16:43:45 volumio volumio[5522]: verbose: CURRENT POSITION 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::syncState stateService stop Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::syncState currentStatus stop Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: No code Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: ControllerMpd::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::servicePushState Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 14 16:43:45 volumio volumio[5522]: verbose: CURRENT POSITION 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::syncState stateService stop Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::syncState currentStatus stop Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: No code Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: ------------------------------ 355ms Jul 14 16:43:45 volumio volumio[5522]: info: ------------------------------ 341ms Jul 14 16:43:45 volumio volumio[5522]: info: ------------------------------ 343ms Jul 14 16:43:45 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:45 volumio volumio[5522]: info: Jul 14 16:43:45 volumio volumio[5522]: ---------------------------- MPD announces state update: update Jul 14 16:43:45 volumio volumio[5522]: info: ControllerMpd::getState Jul 14 16:43:45 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:45 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:45 volumio volumio[5522]: info: Jul 14 16:43:45 volumio volumio[5522]: ---------------------------- MPD announces state update: update Jul 14 16:43:45 volumio volumio[5522]: info: ControllerMpd::getState Jul 14 16:43:45 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:45 volumio volumio[5522]: info: sendMpdCommand status took 359 milliseconds Jul 14 16:43:45 volumio volumio[5522]: info: sendMpdCommand status took 353 milliseconds Jul 14 16:43:45 volumio volumio[5522]: info: sendMpdCommand status took 24 milliseconds Jul 14 16:43:45 volumio volumio[5522]: info: sendMpdCommand status took 22 milliseconds Jul 14 16:43:45 volumio volumio[5522]: info: sendMpdCommand status took 15 milliseconds Jul 14 16:43:45 volumio volumio[5522]: info: sendMpdCommand status took 11 milliseconds Jul 14 16:43:45 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:45 volumio volumio[5522]: info: Command Router : Notfying DB Updatefalse Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::Close All Modals sent Jul 14 16:43:45 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:45 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:45 volumio volumio[5522]: info: Command Router : Notfying DB Updatefalse Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::Close All Modals sent Jul 14 16:43:45 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:45 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:45 volumio volumio[5522]: info: Command Router : Notfying DB Updatefalse Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::Close All Modals sent Jul 14 16:43:45 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:45 volumio volumio[5522]: info: ControllerMpd::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::servicePushState Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 14 16:43:45 volumio volumio[5522]: verbose: CURRENT POSITION 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::syncState stateService stop Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::syncState currentStatus stop Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: No code Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: ControllerMpd::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::servicePushState Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 14 16:43:45 volumio volumio[5522]: verbose: CURRENT POSITION 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::syncState stateService stop Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::syncState currentStatus stop Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: No code Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: ControllerMpd::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::servicePushState Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 14 16:43:45 volumio volumio[5522]: verbose: CURRENT POSITION 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::syncState stateService stop Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::syncState currentStatus stop Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: No code Jul 14 16:43:45 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:45 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:45 volumio volumio[5522]: info: ------------------------------ 570ms Jul 14 16:43:45 volumio volumio[5522]: info: ------------------------------ 235ms Jul 14 16:43:45 volumio volumio[5522]: info: ------------------------------ 228ms Jul 14 16:43:45 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand update Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:46 volumio volumio[5522]: info: Jul 14 16:43:46 volumio volumio[5522]: ---------------------------- MPD announces state update: update Jul 14 16:43:46 volumio volumio[5522]: info: sendMpdCommand update took 6 milliseconds Jul 14 16:43:46 volumio volumio[5522]: info: ControllerMpd::getState Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:46 volumio volumio[5522]: info: Jul 14 16:43:46 volumio volumio[5522]: ---------------------------- MPD announces state update: update Jul 14 16:43:46 volumio volumio[5522]: info: ControllerMpd::getState Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:46 volumio volumio[5522]: info: sendMpdCommand status took 10 milliseconds Jul 14 16:43:46 volumio volumio[5522]: info: sendMpdCommand status took 7 milliseconds Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:46 volumio volumio[5522]: info: Command Router : Notfying DB Updatefalse Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::Close All Modals sent Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:46 volumio volumio[5522]: info: ControllerMpd::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::servicePushState Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 14 16:43:46 volumio volumio[5522]: verbose: CURRENT POSITION 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::syncState stateService stop Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::syncState currentStatus stop Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: No code Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: ------------------------------ 86ms Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:46 volumio volumio[5522]: info: Jul 14 16:43:46 volumio volumio[5522]: ---------------------------- MPD announces state update: update Jul 14 16:43:46 volumio volumio[5522]: info: ControllerMpd::getState Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:46 volumio volumio[5522]: info: Jul 14 16:43:46 volumio volumio[5522]: ---------------------------- MPD announces state update: update Jul 14 16:43:46 volumio volumio[5522]: info: ControllerMpd::getState Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:46 volumio volumio[5522]: info: sendMpdCommand status took 97 milliseconds Jul 14 16:43:46 volumio volumio[5522]: info: sendMpdCommand status took 94 milliseconds Jul 14 16:43:46 volumio volumio[5522]: info: sendMpdCommand status took 16 milliseconds Jul 14 16:43:46 volumio volumio[5522]: info: sendMpdCommand status took 13 milliseconds Jul 14 16:43:46 volumio volumio[5522]: info: sendMpdCommand status took 13 milliseconds Jul 14 16:43:46 volumio volumio[5522]: info: sendMpdCommand status took 7 milliseconds Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:46 volumio volumio[5522]: info: Command Router : Notfying DB Updatefalse Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::Close All Modals sent Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:46 volumio volumio[5522]: info: Command Router : Notfying DB Updatefalse Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::Close All Modals sent Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:46 volumio volumio[5522]: info: Command Router : Notfying DB Updatefalse Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::Close All Modals sent Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:46 volumio volumio[5522]: info: ControllerMpd::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::servicePushState Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 14 16:43:46 volumio volumio[5522]: verbose: CURRENT POSITION 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::syncState stateService stop Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::syncState currentStatus stop Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: No code Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: ControllerMpd::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::servicePushState Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 14 16:43:46 volumio volumio[5522]: verbose: CURRENT POSITION 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::syncState stateService stop Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::syncState currentStatus stop Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: No code Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: ControllerMpd::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::servicePushState Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 14 16:43:46 volumio volumio[5522]: verbose: CURRENT POSITION 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::syncState stateService stop Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::syncState currentStatus stop Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: No code Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: ------------------------------ 309ms Jul 14 16:43:46 volumio volumio[5522]: info: ------------------------------ 227ms Jul 14 16:43:46 volumio volumio[5522]: info: ------------------------------ 224ms Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:46 volumio volumio[5522]: info: Jul 14 16:43:46 volumio volumio[5522]: ---------------------------- MPD announces state update: update Jul 14 16:43:46 volumio volumio[5522]: info: ControllerMpd::getState Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:46 volumio volumio[5522]: info: Jul 14 16:43:46 volumio volumio[5522]: ---------------------------- MPD announces state update: update Jul 14 16:43:46 volumio volumio[5522]: info: ControllerMpd::getState Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::sendMpdCommand status Jul 14 16:43:46 volumio volumio[5522]: info: sendMpdCommand status took 28 milliseconds Jul 14 16:43:46 volumio volumio[5522]: info: sendMpdCommand status took 26 milliseconds Jul 14 16:43:46 volumio volumio[5522]: info: sendMpdCommand status took 25 milliseconds Jul 14 16:43:46 volumio volumio[5522]: info: sendMpdCommand status took 22 milliseconds Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:46 volumio volumio[5522]: info: Command Router : Notfying DB Updatefalse Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::Close All Modals sent Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:46 volumio volumio[5522]: info: Command Router : Notfying DB Updatefalse Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::Close All Modals sent Jul 14 16:43:46 volumio volumio[5522]: verbose: ControllerMpd::parseState Jul 14 16:43:46 volumio volumio[5522]: info: ControllerMpd::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::servicePushState Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 14 16:43:46 volumio volumio[5522]: verbose: CURRENT POSITION 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::syncState stateService stop Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::syncState currentStatus stop Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: No code Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: ControllerMpd::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::servicePushState Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 14 16:43:46 volumio volumio[5522]: verbose: CURRENT POSITION 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::syncState stateService stop Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::syncState currentStatus stop Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: No code Jul 14 16:43:46 volumio volumio[5522]: info: CoreStateMachine::pushState Jul 14 16:43:46 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:46 volumio volumio[5522]: info: CoreCommandRouter::volumioPushState Jul 14 16:43:46 volumio volumio[5522]: info: ------------------------------ 160ms Jul 14 16:43:46 volumio volumio[5522]: info: ------------------------------ 158ms Jul 14 16:43:48 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:43:51 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 14 16:43:51 volumio volumio[5522]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jul 14 16:43:51 volumio volumio[5522]: info: CoreCommandRouter::volumioGetState Jul 14 16:43:51 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:43:52 volumio volumio[5522]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jul 14 16:43:52 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:52 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 14 16:43:52 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:52 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 14 16:43:52 volumio volumio-remote-updater[1433]: No test mode Jul 14 16:43:52 volumio volumio-remote-updater[1433]: No alpha test mode Jul 14 16:43:52 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 14 16:43:52 volumio volumio[5522]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 14 16:43:52 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 14 16:43:52 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:43:56 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:56 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:56 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 14 16:43:56 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 14 16:43:56 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 14 16:43:56 volumio volumio[5522]: info: CoreCommandRouter::volumioGetBrowseSources Jul 14 16:43:56 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 14 16:43:56 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:43:58 volumio volumio[5522]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jul 14 16:43:58 volumio volumio[5522]: info: Completed starting MyVolumio Plugin Jul 14 16:43:58 volumio volumio[5522]: info: BOOT COMPLETED Jul 14 16:43:58 volumio volumio[5522]: [Metrics] CommandRouter: 42s 895.79ms Jul 14 16:43:58 volumio volumio[5522]: info: CoreCommandRouter::volumiosetStartupVolume Jul 14 16:43:58 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:43:58 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:43:58 volumio volumio[5522]: info: CoreCommandRouter::Close All Modals sent Jul 14 16:43:58 volumio volumio[5522]: info: CoreCommandRouter::Close All Modals sent Jul 14 16:43:59 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 14 16:43:59 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 14 16:43:59 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 14 16:44:00 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:44:04 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:44:08 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:44:12 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:44:19 volumio volumio[5522]: verbose: New Socket.io Connection to 192.168.188.199 from 192.168.188.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Edg/126.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Jul 14 16:44:19 volumio volumio[5522]: verbose: New Socket.io Connection to 192.168.188.199 from 192.168.188.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Edg/126.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 Jul 14 16:44:19 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:44:19 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 14 16:44:19 volumio volumio[5522]: info: CoreCommandRouter::volumioGetVisibleSources Jul 14 16:44:19 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 16:44:19 volumio volumio[5522]: info: CoreCommandRouter::volumioGetState Jul 14 16:44:19 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:44:19 volumio volumio[5522]: info: CoreCommandRouter::volumioGetState Jul 14 16:44:19 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:44:19 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 14 16:44:19 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 14 16:44:20 volumio volumio[5522]: info: Received Get System Info Jul 14 16:44:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 14 16:44:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 14 16:44:20 volumio volumio[5522]: info: Discovery: Getting this device information Jul 14 16:44:20 volumio volumio[5522]: info: CoreCommandRouter::volumioGetState Jul 14 16:44:20 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:44:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 14 16:44:20 volumio volumio[5522]: info: CoreCommandRouter::volumioGetState Jul 14 16:44:20 volumio volumio[5522]: info: CorePlayQueue::getTrack 0 Jul 14 16:44:20 volumio volumio[5522]: info: Listing playlists Jul 14 16:44:20 volumio volumio[5522]: info: CoreCommandRouter::volumioGetQueue Jul 14 16:44:20 volumio volumio[5522]: info: CoreStateMachine::getQueue Jul 14 16:44:20 volumio volumio[5522]: info: CorePlayQueue::getQueue Jul 14 16:44:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 14 16:44:20 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:44:24 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:44:28 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jul 14 16:44:28 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jul 14 16:44:28 volumio volumio[5522]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 14 16:44:30 volumio avahi-daemon[567]: wide-area.c: Query timed out. Jul 14 16:44:30 volumio avahi-daemon[567]: wide-area.c: Query timed out. Jul 14 16:44:30 volumio volumio[5522]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 16:44:30 volumio avahi-daemon[567]: wide-area.c: Query timed out. Jul 14 16:44:30 volumio avahi-daemon[567]: wide-area.c: Query timed out. Jul 14 16:44:30 volumio volumio[5522]: Error: dns service error: unknown Jul 14 16:44:30 volumio volumio[5522]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Jul 14 16:44:30 volumio volumio[5522]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Jul 14 16:44:30 volumio volumio[5522]: errorCode: -65537 Jul 14 16:44:30 volumio volumio[5522]: } Jul 14 16:44:30 volumio volumio[5522]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 16:44:31 volumio sudo[5810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-14 16:43 Jul 14 16:44:31 volumio sudo[5810]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"