-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Thu 2024-11-21 10:14:07 CET. -- Nov 21 10:13:30 volumio systemd-timedated[1033]: Changed local time to Thu Nov 21 10:13:30 2024 Nov 21 10:13:30 volumio sudo[1031]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:30 volumio volumio-time-update[515]: volumio-time-update-util: System time updated successfully. Nov 21 10:13:30 volumio systemd[1]: Started Volumio Time Update Utility. Nov 21 10:13:30 volumio systemd[1]: Reached target Multi-User System. Nov 21 10:13:30 volumio systemd[1]: Reached target Graphical Interface. Nov 21 10:13:30 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 21 10:13:30 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 21 10:13:30 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 21 10:13:30 volumio systemd[1]: Startup finished in 16.742s (kernel) + 24.415s (userspace) = 41.158s. Nov 21 10:13:30 volumio volumio[1003]: info: ------------------------------------------- Nov 21 10:13:30 volumio volumio[1003]: info: ----- Volumio3 ---- Nov 21 10:13:30 volumio volumio[1003]: info: ------------------------------------------- Nov 21 10:13:30 volumio volumio[1003]: info: ----- System startup ---- Nov 21 10:13:30 volumio volumio[1003]: info: ------------------------------------------- Nov 21 10:13:32 volumio volumio[1003]: info: MYVOLUMIO Environment detected Nov 21 10:13:32 volumio volumio[1003]: info: Plugin folders cleanup Nov 21 10:13:32 volumio volumio[1003]: info: Scanning into folder /volumio/app/plugins/ Nov 21 10:13:32 volumio volumio[1003]: info: Scanning category audio_interface Nov 21 10:13:32 volumio volumio[1003]: info: Scanning category miscellanea Nov 21 10:13:32 volumio volumio[1003]: info: Scanning category music_service Nov 21 10:13:32 volumio volumio[1003]: info: Scanning category plugins.json Nov 21 10:13:32 volumio volumio[1003]: info: Scanning category system_controller Nov 21 10:13:32 volumio volumio[1003]: info: Scanning category user_interface Nov 21 10:13:32 volumio volumio[1003]: info: Scanning into folder /data/plugins/ Nov 21 10:13:32 volumio volumio[1003]: info: Scanning category audio_interface Nov 21 10:13:32 volumio volumio[1003]: info: Plugin folders cleanup completed Nov 21 10:13:32 volumio volumio[1003]: info: ------------------------------------------- Nov 21 10:13:32 volumio volumio[1003]: info: ----- Core plugins startup ---- Nov 21 10:13:32 volumio volumio[1003]: info: ------------------------------------------- Nov 21 10:13:32 volumio volumio[1003]: info: Loading plugins from folder /volumio/app/plugins/ Nov 21 10:13:32 volumio volumio[1003]: info: Adding plugin upnp to MyMusic Plugins Nov 21 10:13:32 volumio volumio[1003]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 21 10:13:32 volumio volumio[1003]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 21 10:13:32 volumio volumio[1003]: info: Loading plugins from folder /data/plugins/ Nov 21 10:13:32 volumio volumio[1003]: info: Loading plugin "system"... Nov 21 10:13:32 volumio volumio[1003]: info: Loading plugin "appearance"... Nov 21 10:13:34 volumio volumio[1003]: info: Loading plugin "network"... Nov 21 10:13:34 volumio volumio[1003]: info: Refreshing Cached IP Addresses Nov 21 10:13:34 volumio sudo[1061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 21 10:13:34 volumio sudo[1061]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:34 volumio sudo[1061]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:34 volumio sudo[1063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 21 10:13:34 volumio sudo[1063]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:34 volumio volumio[1003]: info: Loading plugin "services"... Nov 21 10:13:34 volumio sudo[1063]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:34 volumio volumio[1003]: info: Loading plugin "alsa_controller"... Nov 21 10:13:34 volumio sudo[1071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 21 10:13:34 volumio sudo[1071]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:34 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 21 10:13:34 volumio volumio[1003]: info: Loading plugin "wizard"... Nov 21 10:13:34 volumio volumio[1003]: info: Loading plugin "networkfs"... Nov 21 10:13:34 volumio volumio[1003]: info: Starting Udev Watcher for removable devices Nov 21 10:13:34 volumio sudo[1090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.200/music /mnt/NAS/nas Nov 21 10:13:34 volumio sudo[1090]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:34 volumio volumio[1003]: info: Ignoring mount for partition: boot Nov 21 10:13:34 volumio volumio[1003]: info: Ignoring mount for partition: volumio Nov 21 10:13:34 volumio volumio[1003]: info: Ignoring mount for partition: volumio_data Nov 21 10:13:34 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 21 10:13:34 volumio volumio[1003]: info: Loading plugin "volumio_command_line_client"... Nov 21 10:13:34 volumio volumio[1003]: info: Loading plugin "upnp"... Nov 21 10:13:34 volumio volumio[1003]: info: [1732180414486] Starting Upmpd Daemon Nov 21 10:13:34 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 21 10:13:34 volumio volumio[1003]: info: Loading plugin "my_music"... Nov 21 10:13:34 volumio volumio[1003]: info: Loading plugin "mpd"... Nov 21 10:13:34 volumio kernel: Key type cifs.spnego registered Nov 21 10:13:34 volumio kernel: Key type cifs.idmap registered Nov 21 10:13:34 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Nov 21 10:13:34 volumio kernel: CIFS: Attempting to mount //192.168.0.200/music Nov 21 10:13:35 volumio volumio[1003]: info: Loading plugin "upnp_browser"... Nov 21 10:13:35 volumio sudo[1071]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:35 volumio sudo[1090]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:36 volumio volumio[1003]: info: Loading plugin "alarm-clock"... Nov 21 10:13:36 volumio volumio[1003]: info: Loading plugin "airplay_emulation"... Nov 21 10:13:36 volumio volumio[1003]: info: Starting Shairport Sync Nov 21 10:13:36 volumio volumio[1003]: info: Loading plugin "last_100"... Nov 21 10:13:36 volumio volumio[1003]: info: Loading plugin "webradio"... Nov 21 10:13:36 volumio volumio-remote-updater[502]: [2024-11-21 10:13:36] [connect] Successful connection Nov 21 10:13:36 volumio volumio[1003]: info: Loading plugin "i2s_dacs"... Nov 21 10:13:36 volumio volumio[1003]: info: Loading plugin "volumiodiscovery"... Nov 21 10:13:36 volumio volumio[1003]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 21 10:13:36 volumio volumio[1003]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 21 10:13:36 volumio volumio[1003]: *** WARNING *** For more information see Nov 21 10:13:36 volumio node[1003]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 21 10:13:36 volumio volumio[1003]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 21 10:13:36 volumio volumio[1003]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 21 10:13:36 volumio volumio[1003]: *** WARNING *** For more information see Nov 21 10:13:36 volumio node[1003]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 21 10:13:36 volumio node[1003]: *** WARNING *** For more information see Nov 21 10:13:36 volumio node[1003]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 21 10:13:36 volumio node[1003]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 21 10:13:36 volumio node[1003]: *** WARNING *** For more information see Nov 21 10:13:36 volumio volumio[1003]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 21 10:13:36 volumio volumio[1003]: info: Discovery: Started advertising with name: Volumio Nov 21 10:13:36 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 21 10:13:36 volumio volumio[1003]: info: Loading plugin "outputs"... Nov 21 10:13:36 volumio volumio[1003]: info: Loading plugin "albumart"... Nov 21 10:13:36 volumio volumio[1003]: info: Plugin example_plugin is not enabled Nov 21 10:13:36 volumio volumio[1003]: info: Loading plugin "inputs"... Nov 21 10:13:36 volumio volumio[1003]: info: Loading plugin "updater_comm"... Nov 21 10:13:37 volumio volumio[1003]: info: Plugin mpdemulation is not enabled Nov 21 10:13:37 volumio volumio[1003]: info: Loading plugin "rest_api"... Nov 21 10:13:37 volumio volumio[1003]: info: Loading plugin "websocket"... Nov 21 10:13:37 volumio volumio[1003]: info: Starting Socket.io Server version 2.3.0 Nov 21 10:13:37 volumio volumio[1003]: info: Loading plugin "fusiondsp"... Nov 21 10:13:37 volumio volumio[1003]: Forking 3 albumart workers Nov 21 10:13:37 volumio volumio[1003]: info: Applying required configuration parameters for plugin fusiondsp Nov 21 10:13:38 volumio volumio[1003]: info: Loading i18n strings for locale fr Nov 21 10:13:38 volumio volumio[1003]: Updating browse sources language Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 21 10:13:38 volumio volumio[1003]: Starting albumart workers Nov 21 10:13:38 volumio volumio[1003]: Starting albumart workers Nov 21 10:13:38 volumio volumio[1003]: Starting albumart workers Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::initPlayerControls Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 10:13:38 volumio volumio[1003]: Express server listening on port 3000 Nov 21 10:13:38 volumio volumio[1003]: [Metrics] WebUI: 8s 967.70ms Nov 21 10:13:38 volumio volumio[1003]: info: CoreStateMachine::resetVolumioState Nov 21 10:13:38 volumio volumio[1003]: info: CoreStateMachine::getcurrentVolume Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::volumioRetrievevolume Nov 21 10:13:38 volumio volumio[1003]: info: Volumio Network Manager: Network status updated: 2 Nov 21 10:13:38 volumio volumio-remote-updater[502]: [2024-11-21 10:13:38] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732180416 101 Nov 21 10:13:38 volumio volumio[1003]: 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: 1 Nov 21 10:13:38 volumio volumio[1003]: Unable to parse: Nov 21 10:13:38 volumio volumio[1003]: Simple mixer control 'Master',0 Nov 21 10:13:38 volumio volumio[1003]: Capabilities: volume volume-joined Nov 21 10:13:38 volumio volumio[1003]: Playback channels: Mono Nov 21 10:13:38 volumio volumio[1003]: Capture channels: Mono Nov 21 10:13:38 volumio volumio[1003]: Limits: 0 - 248 Nov 21 10:13:38 volumio volumio[1003]: Mono: 119 [48%] Nov 21 10:13:38 volumio volumio[1003]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:13:38 volumio volumio[1003]: info: Reloading queue from file Nov 21 10:13:38 volumio volumio[1003]: info: CoreStateMachine::setRepeat true single undefined Nov 21 10:13:38 volumio volumio[1003]: info: CoreStateMachine::pushState Nov 21 10:13:38 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState Nov 21 10:13:38 volumio volumio[1003]: info: CoreStateMachine::setRandom null Nov 21 10:13:38 volumio volumio[1003]: info: CoreStateMachine::pushState Nov 21 10:13:38 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:38 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState Nov 21 10:13:38 volumio volumio[1003]: info: Setting Device type: Raspberry PI Nov 21 10:13:38 volumio volumio[1003]: info: Completed loading Core Plugins Nov 21 10:13:38 volumio volumio[1003]: info: Preparing to generate the ALSA configuration file Nov 21 10:13:39 volumio volumio[1003]: Unable to parse: Nov 21 10:13:39 volumio volumio[1003]: Simple mixer control 'Master',0 Nov 21 10:13:39 volumio volumio[1003]: Capabilities: volume volume-joined Nov 21 10:13:39 volumio volumio[1003]: Playback channels: Mono Nov 21 10:13:39 volumio volumio[1003]: Capture channels: Mono Nov 21 10:13:39 volumio volumio[1003]: Limits: 0 - 248 Nov 21 10:13:39 volumio volumio[1003]: Mono: 119 [48%] Nov 21 10:13:39 volumio volumio[1003]: info: VolumeController:: Volume=undefined Mute =false Nov 21 10:13:39 volumio volumio[1003]: info: CoreStateMachine::pushState Nov 21 10:13:39 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState Nov 21 10:13:39 volumio volumio[1003]: info: CoreStateMachine::updateTrackBlock Nov 21 10:13:39 volumio volumio[1003]: info: CorePlayQueue::getTrackBlock Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::volumioRetrievevolume Nov 21 10:13:39 volumio volumio[1003]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 21 10:13:39 volumio volumio[1003]: info: Reading ALSA contributions from plugins. Nov 21 10:13:39 volumio volumio[1003]: info: Asound.conf file unchanged, so no further update is needed Nov 21 10:13:39 volumio volumio[1003]: info: Output device has changed, restarting MPD Nov 21 10:13:39 volumio volumio[1003]: info: Output device has changed, restarting Shairport Sync Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:13:39 volumio sudo[1178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 21 10:13:39 volumio sudo[1178]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:39 volumio sudo[1184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 21 10:13:39 volumio sudo[1184]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:39 volumio sudo[1178]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:39 volumio systemd[1]: Stopping Music Player Daemon... Nov 21 10:13:39 volumio volumio[1003]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 21 10:13:39 volumio volumio[1003]: info: ___________ START PLUGINS ___________ Nov 21 10:13:39 volumio volumio[1003]: info: ControllerMpd::onStart: Initializing MPD Nov 21 10:13:39 volumio volumio[1003]: info: Creating MPD Configuration file Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 21 10:13:39 volumio sudo[1191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 21 10:13:39 volumio volumio[1003]: info: [1732180419211] CoreMusicLibrary::Adding element Serveurs Média Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 21 10:13:39 volumio sudo[1191]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:39 volumio sudo[1191]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:39 volumio sudo[1193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 21 10:13:39 volumio sudo[1193]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:13:39 volumio systemd[1]: mpd.service: Succeeded. Nov 21 10:13:39 volumio systemd[1]: Stopped Music Player Daemon. Nov 21 10:13:39 volumio volumio[1003]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:13:39 volumio systemd[1]: Starting Music Player Daemon... Nov 21 10:13:39 volumio volumio[1003]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 21 10:13:39 volumio volumio[1003]: info: [1732180419383] CoreMusicLibrary::Adding element Last_100 Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 21 10:13:39 volumio volumio[1003]: info: [1732180419387] CoreMusicLibrary::Adding element Webradio Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 21 10:13:39 volumio volumio[1003]: info: Initializing BBC Radios Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: Loading i18n strings for locale fr Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: FusionDsp - mixtype--------------------- Hardware Nov 21 10:13:39 volumio volumio[1003]: info: Volumio Calling Home Nov 21 10:13:39 volumio sudo[1199]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 21 10:13:39 volumio sudo[1199]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:39 volumio sudo[1199]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:39 volumio volumio[1003]: info: Preparing to generate the ALSA configuration file Nov 21 10:13:39 volumio volumio[1003]: info: Discovery: adding 44857b81-7c73-4c25-8dd6-a0f0d1d2ce89 Nov 21 10:13:39 volumio volumio[1003]: info: Discovery: Found device Volumio Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Nov 21 10:13:39 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:39 volumio volumio[1003]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 21 10:13:39 volumio volumio[1003]: info: Reading ALSA contributions from plugins. Nov 21 10:13:39 volumio volumio[1003]: info: MPD Permissions set Nov 21 10:13:39 volumio volumio[1003]: info: MPD Permissions set Nov 21 10:13:39 volumio volumio[1003]: Unable to parse: Nov 21 10:13:39 volumio volumio[1003]: Simple mixer control 'Master',0 Nov 21 10:13:39 volumio volumio[1003]: Capabilities: volume volume-joined Nov 21 10:13:39 volumio volumio[1003]: Playback channels: Mono Nov 21 10:13:39 volumio volumio[1003]: Capture channels: Mono Nov 21 10:13:39 volumio volumio[1003]: Limits: 0 - 248 Nov 21 10:13:39 volumio volumio[1003]: Mono: 119 [48%] Nov 21 10:13:39 volumio volumio[1003]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Nov 21 10:13:39 volumio volumio[1003]: info: Volumio called home Nov 21 10:13:39 volumio volumio[1003]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:13:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:40 volumio volumio[1003]: Unable to parse: Nov 21 10:13:40 volumio volumio[1003]: Simple mixer control 'Master',0 Nov 21 10:13:40 volumio volumio[1003]: Capabilities: volume volume-joined Nov 21 10:13:40 volumio volumio[1003]: Playback channels: Mono Nov 21 10:13:40 volumio volumio[1003]: Capture channels: Mono Nov 21 10:13:40 volumio volumio[1003]: Limits: 0 - 248 Nov 21 10:13:40 volumio volumio[1003]: Mono: 119 [48%] Nov 21 10:13:40 volumio volumio[1003]: info: VolumeController:: Volume=undefined Mute =false Nov 21 10:13:40 volumio volumio[1003]: info: CoreStateMachine::pushState Nov 21 10:13:40 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:40 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState Nov 21 10:13:40 volumio volumio[1003]: info: Starting Shairport Sync Nov 21 10:13:40 volumio volumio[1003]: info: Starting Shairport Sync Nov 21 10:13:40 volumio volumio[1003]: info: Starting Shairport Sync Nov 21 10:13:40 volumio sudo[1228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 21 10:13:40 volumio sudo[1228]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:40 volumio sudo[1230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 21 10:13:40 volumio sudo[1230]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:40 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 21 10:13:40 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 21 10:13:40 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 21 10:13:40 volumio sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 21 10:13:40 volumio sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:40 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Nov 21 10:13:40 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:40 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 21 10:13:40 volumio sudo[1228]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:40 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 21 10:13:40 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 21 10:13:40 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 21 10:13:40 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 21 10:13:40 volumio volumio[1003]: info: Asound.conf file unchanged, so no further update is needed Nov 21 10:13:40 volumio volumio[1003]: info: Output device has changed, restarting MPD Nov 21 10:13:40 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 21 10:13:40 volumio sudo[1233]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:40 volumio sudo[1230]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:40 volumio volumio[1003]: info: Output device has changed, restarting Shairport Sync Nov 21 10:13:40 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:40 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:13:40 volumio sudo[1240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 21 10:13:40 volumio sudo[1240]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:40 volumio sudo[1242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 21 10:13:40 volumio sudo[1242]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:40 volumio sudo[1240]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:40 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 21 10:13:40 volumio systemd[1]: mpd.service: Succeeded. Nov 21 10:13:40 volumio systemd[1]: Stopped Music Player Daemon. Nov 21 10:13:40 volumio volumio[1003]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 21 10:13:40 volumio volumio[1003]: info: Shairport-Sync Started Nov 21 10:13:40 volumio volumio[1003]: Error adding Membership: Error: addMembership EINVAL Nov 21 10:13:40 volumio volumio[1003]: info: MPD Permissions set Nov 21 10:13:40 volumio volumio[1003]: info: Shairport-Sync Started Nov 21 10:13:40 volumio volumio[1003]: info: Shairport-Sync Started Nov 21 10:13:40 volumio systemd[1]: Starting Music Player Daemon... Nov 21 10:13:40 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:40 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:40 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:40 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:40 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:40 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:40 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:40 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:40 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:13:40 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:40 volumio volumio[1003]: info: Starting Shairport Sync Nov 21 10:13:40 volumio sudo[1257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 21 10:13:40 volumio sudo[1257]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:40 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 21 10:13:40 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 21 10:13:40 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 21 10:13:40 volumio sudo[1250]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 21 10:13:40 volumio sudo[1250]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:40 volumio sudo[1250]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:40 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 21 10:13:40 volumio sudo[1257]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:40 volumio volumio[1003]: info: Shairport-Sync Started Nov 21 10:13:40 volumio systemd[1]: systemd-fsckd.service: Succeeded. Nov 21 10:13:41 volumio volumio[1003]: 0+0 records in Nov 21 10:13:41 volumio volumio[1003]: 0+0 records out Nov 21 10:13:41 volumio volumio[1003]: 0 bytes copied, 0.000171042 s, 0.0 kB/s Nov 21 10:13:41 volumio volumio[1003]: info: camilladsp spawned new process with pid 1272, instance 1, run: true Nov 21 10:13:41 volumio volumio[1003]: info: camilladsp service started and running in background, instance 1 Nov 21 10:13:41 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 10:13:41 volumio volumio[1003]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 <-AAAAAAAAAAAAA Nov 21 10:13:41 volumio volumio[1003]: info: FusionDsp loaded Nov 21 10:13:41 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 21 10:13:41 volumio sudo[1278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 21 10:13:41 volumio sudo[1278]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:41 volumio volumio[1003]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 21 10:13:41 volumio volumio[1003]: info: Adding Signal Path Element [object Object] Nov 21 10:13:41 volumio volumio[1003]: info: Adding fusiondspeq DSP Signal Path Element Nov 21 10:13:41 volumio volumio[1003]: info: FusionDsp - ---- installed callbackRead Nov 21 10:13:41 volumio volumio[1003]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 21 10:13:41 volumio volumio[1003]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Nov 21 10:13:41 volumio volumio[1003]: info: FusionDsp - eq1: Nov 21 10:13:41 volumio volumio[1003]: type: Biquad Nov 21 10:13:41 volumio volumio[1003]: parameters: Nov 21 10:13:41 volumio volumio[1003]: type: Peaking Nov 21 10:13:41 volumio volumio[1003]: freq: 25 Nov 21 10:13:41 volumio volumio[1003]: q: 1.85 Nov 21 10:13:41 volumio volumio[1003]: gain: 3 Nov 21 10:13:41 volumio volumio[1003]: eq2: Nov 21 10:13:41 volumio volumio[1003]: type: Biquad Nov 21 10:13:41 volumio volumio[1003]: parameters: Nov 21 10:13:41 volumio volumio[1003]: type: Peaking Nov 21 10:13:41 volumio volumio[1003]: freq: 40 Nov 21 10:13:41 volumio volumio[1003]: q: 1.85 Nov 21 10:13:41 volumio volumio[1003]: gain: 4 Nov 21 10:13:41 volumio volumio[1003]: eq3: Nov 21 10:13:41 volumio volumio[1003]: type: Biquad Nov 21 10:13:41 volumio volumio[1003]: parameters: Nov 21 10:13:41 volumio volumio[1003]: type: Peaking Nov 21 10:13:41 volumio volumio[1003]: freq: 63 Nov 21 10:13:41 volumio volumio[1003]: q: 1.85 Nov 21 10:13:41 volumio volumio[1003]: gain: 3 Nov 21 10:13:41 volumio volumio[1003]: eq4: Nov 21 10:13:41 volumio volumio[1003]: type: Biquad Nov 21 10:13:41 volumio volumio[1003]: parameters: Nov 21 10:13:41 volumio volumio[1003]: type: Peaking Nov 21 10:13:41 volumio volumio[1003]: freq: 100 Nov 21 10:13:41 volumio volumio[1003]: q: 1.85 Nov 21 10:13:41 volumio volumio[1003]: gain: 3 Nov 21 10:13:41 volumio volumio[1003]: eq5: Nov 21 10:13:41 volumio volumio[1003]: type: Biquad Nov 21 10:13:41 volumio volumio[1003]: parameters: Nov 21 10:13:41 volumio volumio[1003]: type: Peaking Nov 21 10:13:41 volumio volumio[1003]: freq: 160 Nov 21 10:13:41 volumio volumio[1003]: q: 1.85 Nov 21 10:13:41 volumio volumio[1003]: gain: 5 Nov 21 10:13:41 volumio volumio[1003]: eq6: Nov 21 10:13:41 volumio volumio[1003]: type: Biquad Nov 21 10:13:41 volumio volumio[1003]: parameters: Nov 21 10:13:41 volumio volumio[1003]: type: Peaking Nov 21 10:13:41 volumio volumio[1003]: freq: 250 Nov 21 10:13:41 volumio volumio[1003]: q: 1.85 Nov 21 10:13:41 volumio volumio[1003]: gain: 4.5 Nov 21 10:13:41 volumio volumio[1003]: eq7: Nov 21 10:13:41 volumio volumio[1003]: type: Biquad Nov 21 10:13:41 volumio volumio[1003]: parameters: Nov 21 10:13:41 volumio volumio[1003]: type: Peaking Nov 21 10:13:41 volumio volumio[1003]: freq: 400 Nov 21 10:13:41 volumio volumio[1003]: q: 1.85 Nov 21 10:13:41 volumio volumio[1003]: gain: 2.5 Nov 21 10:13:41 volumio volumio[1003]: eq8: Nov 21 10:13:41 volumio volumio[1003]: type: Biquad Nov 21 10:13:41 volumio volumio[1003]: parameters: Nov 21 10:13:41 volumio volumio[1003]: type: Peaking Nov 21 10:13:41 volumio volumio[1003]: freq: 630 Nov 21 10:13:41 volumio volumio[1003]: q: 1.85 Nov 21 10:13:41 volumio volumio[1003]: gain: 0 Nov 21 10:13:41 volumio volumio[1003]: eq9: Nov 21 10:13:41 volumio volumio[1003]: type: Biquad Nov 21 10:13:41 volumio volumio[1003]: parameters: Nov 21 10:13:41 volumio volumio[1003]: type: Peaking Nov 21 10:13:41 volumio volumio[1003]: freq: 1000 Nov 21 10:13:41 volumio volumio[1003]: q: 1.85 Nov 21 10:13:41 volumio volumio[1003]: gain: 1.5 Nov 21 10:13:41 volumio volumio[1003]: eq10: Nov 21 10:13:41 volumio volumio[1003]: type: Biquad Nov 21 10:13:41 volumio volumio[1003]: parameters: Nov 21 10:13:41 volumio volumio[1003]: type: Peaking Nov 21 10:13:41 volumio volumio[1003]: freq: 1600 Nov 21 10:13:41 volumio volumio[1003]: q: 1.85 Nov 21 10:13:41 volumio volumio[1003]: gain: 1.5 Nov 21 10:13:41 volumio volumio[1003]: eq11: Nov 21 10:13:41 volumio volumio[1003]: type: Biquad Nov 21 10:13:41 volumio volumio[1003]: parameters: Nov 21 10:13:41 volumio volumio[1003]: type: Peaking Nov 21 10:13:41 volumio volumio[1003]: freq: 2500 Nov 21 10:13:41 volumio volumio[1003]: q: 1.85 Nov 21 10:13:41 volumio volumio[1003]: gain: 3.5 Nov 21 10:13:41 volumio volumio[1003]: eq12: Nov 21 10:13:41 volumio volumio[1003]: type: Biquad Nov 21 10:13:41 volumio volumio[1003]: parameters: Nov 21 10:13:41 volumio volumio[1003]: type: Peaking Nov 21 10:13:41 volumio volumio[1003]: freq: 4000 Nov 21 10:13:41 volumio volumio[1003]: q: 1.85 Nov 21 10:13:41 volumio volumio[1003]: gain: 4 Nov 21 10:13:41 volumio volumio[1003]: eq13: Nov 21 10:13:41 volumio volumio[1003]: type: Biquad Nov 21 10:13:41 volumio volumio[1003]: parameters: Nov 21 10:13:41 volumio volumio[1003]: type: Peaking Nov 21 10:13:41 volumio volumio[1003]: freq: 6300 Nov 21 10:13:41 volumio volumio[1003]: q: 1.85 Nov 21 10:13:41 volumio volumio[1003]: gain: 4 Nov 21 10:13:41 volumio volumio[1003]: eq14: Nov 21 10:13:41 volumio volumio[1003]: type: Biquad Nov 21 10:13:41 volumio volumio[1003]: parameters: Nov 21 10:13:41 volumio volumio[1003]: type: Peaking Nov 21 10:13:41 volumio volumio[1003]: freq: 10000 Nov 21 10:13:41 volumio volumio[1003]: q: 1.85 Nov 21 10:13:41 volumio volumio[1003]: gain: 5 Nov 21 10:13:41 volumio volumio[1003]: eq15: Nov 21 10:13:41 volumio volumio[1003]: type: Biquad Nov 21 10:13:41 volumio volumio[1003]: parameters: Nov 21 10:13:41 volumio volumio[1003]: type: Peaking Nov 21 10:13:41 volumio volumio[1003]: freq: 16000 Nov 21 10:13:41 volumio volumio[1003]: q: 1.85 Nov 21 10:13:41 volumio volumio[1003]: gain: 6.5 Nov 21 10:13:41 volumio systemd[1]: Started FusionDsp Daemon. Nov 21 10:13:41 volumio sudo[1278]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:41 volumio volumio[1003]: error: FusionDsp - WebSocket error: [object Object] Nov 21 10:13:42 volumio mpd[1261]: Nov 21 10:13 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 21 10:13:42 volumio systemd[1]: Started Music Player Daemon. Nov 21 10:13:42 volumio sudo[1193]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:42 volumio sudo[1184]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:42 volumio sudo[1242]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:42 volumio volumio[1003]: info: Completed starting Core Plugins Nov 21 10:13:42 volumio volumio[1003]: info: ------------------------------------------- Nov 21 10:13:42 volumio volumio[1003]: info: ----- MyVolumio plugins startup ---- Nov 21 10:13:42 volumio volumio[1003]: info: ------------------------------------------- Nov 21 10:13:42 volumio volumio[1003]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 21 10:13:42 volumio volumio[1003]: info: MPD running with PID1261 Nov 21 10:13:42 volumio volumio[1003]: ,establishing connection Nov 21 10:13:42 volumio volumio[1003]: error: MPD error: The expression evaluated to a falsy value: Nov 21 10:13:42 volumio volumio[1003]: assert.ok(self.idling) Nov 21 10:13:42 volumio volumio[1003]: error: The expression evaluated to a falsy value: Nov 21 10:13:42 volumio volumio[1003]: assert.ok(self.idling) Nov 21 10:13:42 volumio volumio[1003]: error: MPD error: The expression evaluated to a falsy value: Nov 21 10:13:42 volumio volumio[1003]: assert.ok(self.idling) Nov 21 10:13:42 volumio volumio[1003]: error: The expression evaluated to a falsy value: Nov 21 10:13:42 volumio volumio[1003]: assert.ok(self.idling) Nov 21 10:13:42 volumio volumio[1003]: error: MPD error: The expression evaluated to a falsy value: Nov 21 10:13:42 volumio volumio[1003]: assert.ok(self.idling) Nov 21 10:13:42 volumio volumio[1003]: error: The expression evaluated to a falsy value: Nov 21 10:13:42 volumio volumio[1003]: assert.ok(self.idling) Nov 21 10:13:42 volumio volumio[1003]: error: updateQueue error: null Nov 21 10:13:42 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 21 10:13:42 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 21 10:13:42 volumio volumio[1003]: info: Discovery: Getting this device information Nov 21 10:13:42 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Nov 21 10:13:42 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:42 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 21 10:13:42 volumio volumio[1003]: verbose: New Socket.io Connection to 192.168.0.142:3000 from 192.168.0.133 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Nov 21 10:13:42 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Nov 21 10:13:42 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:42 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 21 10:13:42 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 21 10:13:44 volumio sudo[1307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 21 10:13:44 volumio sudo[1307]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:44 volumio sudo[1307]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:44 volumio sudo[1309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 21 10:13:44 volumio sudo[1309]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:44 volumio sudo[1309]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:44 volumio sudo[1313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 21 10:13:44 volumio sudo[1313]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:44 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Nov 21 10:13:44 volumio sudo[1313]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:44 volumio volumio[1003]: info: Upmpdcli Daemon Started Nov 21 10:13:44 volumio volumio[1315]: Generating RSA private key, 4096 bit long modulus (2 primes) Nov 21 10:13:44 volumio sudo[1332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 21 10:13:44 volumio sudo[1332]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:44 volumio sudo[1332]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:44 volumio sudo[1334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 21 10:13:44 volumio sudo[1334]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:44 volumio sudo[1334]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:44 volumio volumio[1003]: verbose: New Socket.io Connection to 192.168.0.142 from 192.168.0.133 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 5 Nov 21 10:13:45 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 21 10:13:45 volumio sudo[1338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 21 10:13:45 volumio sudo[1338]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:45 volumio sudo[1338]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:45 volumio sudo[1340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 21 10:13:45 volumio sudo[1340]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:45 volumio sudo[1340]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:45 volumio volumio[1003]: verbose: New Socket.io Connection to 192.168.0.142 from 192.168.0.133 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 6 Nov 21 10:13:45 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 21 10:13:45 volumio volumio[1003]: info: CoreCommandRouter::volumioGetVisibleSources Nov 21 10:13:45 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 21 10:13:45 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Nov 21 10:13:45 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:45 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 21 10:13:45 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 21 10:13:45 volumio volumio[1003]: info: Received Get System Info Nov 21 10:13:45 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 21 10:13:45 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 21 10:13:45 volumio volumio[1003]: info: Discovery: Getting this device information Nov 21 10:13:45 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Nov 21 10:13:45 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:45 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 21 10:13:45 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Nov 21 10:13:45 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:45 volumio volumio[1003]: info: Listing playlists Nov 21 10:13:45 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 21 10:13:45 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 21 10:13:45 volumio volumio[1003]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 10:13:46 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Nov 21 10:13:46 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:46 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 21 10:13:47 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 21 10:13:47 volumio volumio[1003]: info: Received Get System Info Nov 21 10:13:47 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 21 10:13:47 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 21 10:13:47 volumio volumio[1003]: info: Discovery: Getting this device information Nov 21 10:13:47 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Nov 21 10:13:47 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:47 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 21 10:13:47 volumio volumio[1003]: info: CoreCommandRouter::volumioPlay Nov 21 10:13:47 volumio volumio[1003]: info: CoreStateMachine::play index undefined Nov 21 10:13:47 volumio volumio[1003]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 10:13:47 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:47 volumio sh[688]: timed out Nov 21 10:13:47 volumio dhcpcd[720]: timed out Nov 21 10:13:47 volumio sh[688]: dhcpcd exited Nov 21 10:13:47 volumio dhcpcd[720]: dhcpcd exited Nov 21 10:13:47 volumio sh[688]: ifup: failed to bring up eth0 Nov 21 10:13:47 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Nov 21 10:13:47 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Nov 21 10:13:47 volumio volumio[1003]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Nov 21 10:13:48 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Nov 21 10:13:49 volumio volumio[1003]: info: CoreCommandRouter::volumioGetQueue Nov 21 10:13:49 volumio volumio[1003]: info: CoreStateMachine::getQueue Nov 21 10:13:49 volumio volumio[1003]: info: CorePlayQueue::getQueue Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Nov 21 10:13:50 volumio volumio[1003]: info: Adding plugin bluetooth to MyMusic Plugins Nov 21 10:13:50 volumio volumio[1003]: info: Adding plugin multiroom to MyMusic Plugins Nov 21 10:13:50 volumio volumio[1003]: info: Adding plugin metavolumio to MyMusic Plugins Nov 21 10:13:50 volumio volumio[1003]: info: Adding plugin cd_controller to MyMusic Plugins Nov 21 10:13:50 volumio volumio[1003]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 21 10:13:50 volumio volumio[1003]: info: Adding plugin tidalconnect to MyMusic Plugins Nov 21 10:13:50 volumio volumio[1003]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Nov 21 10:13:52 volumio volumio[1003]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Nov 21 10:13:52 volumio volumio[1003]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Nov 21 10:13:52 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:13:52 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:13:52 volumio volumio[1003]: info: Starting MyVolumio Remote Streaming Endpoints Nov 21 10:13:52 volumio volumio[1003]: info: MyVolumio login type: Token Nov 21 10:13:52 volumio volumio[1003]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Nov 21 10:13:52 volumio volumio[1003]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Nov 21 10:13:53 volumio volumio[1003]: info: Starting Streaming Service Transparent Proxy Nov 21 10:13:53 volumio volumio[1003]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Nov 21 10:13:53 volumio volumio[1003]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Nov 21 10:13:53 volumio volumio[1003]: info: Streaming services startup Nov 21 10:13:53 volumio volumio[1003]: info: Starting Streaming Daemon Nov 21 10:13:53 volumio sudo[1357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 21 10:13:53 volumio sudo[1357]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:53 volumio volumio[1003]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Nov 21 10:13:53 volumio sudo[1357]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:53 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 21 10:13:53 volumio volumio[1003]: info: CURURI: music-library Nov 21 10:13:53 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 21 10:13:53 volumio volumio[1003]: info: Received Get System Info Nov 21 10:13:53 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 21 10:13:53 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 21 10:13:53 volumio volumio[1003]: info: Discovery: Getting this device information Nov 21 10:13:53 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Nov 21 10:13:53 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:53 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 21 10:13:53 volumio volumio[1003]: error: Cannot start Volumio Streaming Daemon Nov 21 10:13:53 volumio volumio[1003]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 21 10:13:53 volumio volumio[1003]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 21 10:13:53 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 21 10:13:53 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 21 10:13:53 volumio volumio[1003]: info: Discovery: Getting this device information Nov 21 10:13:53 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Nov 21 10:13:53 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:53 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 21 10:13:53 volumio volumio[1003]: info: Preload queue cleared Nov 21 10:13:54 volumio volumio[1003]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Nov 21 10:13:54 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Nov 21 10:13:54 volumio volumio[1003]: info: MyVolumio login type: Token Nov 21 10:13:54 volumio volumio[1003]: info: MyVolumio token set successfully Nov 21 10:13:54 volumio volumio[1003]: info: MYVOLUMIO: Adding device Nov 21 10:13:54 volumio volumio[1003]: info: MYVOLUMIO: Evaluating Server Nov 21 10:13:54 volumio volumio[1003]: STREAMING PROXY: Starting server on port 3245 Nov 21 10:13:54 volumio volumio[1003]: Node JS runtime: 14 Nov 21 10:13:55 volumio volumio[1003]: info: MyVolumio status changed Nov 21 10:13:55 volumio volumio[1003]: info: Streaming services startup Nov 21 10:13:55 volumio volumio[1003]: info: Starting Streaming Daemon Nov 21 10:13:55 volumio volumio[1003]: info: Removing browser output: myVolumio user plan is not superstar Nov 21 10:13:55 volumio volumio[1003]: info: Removing audio output: Nov 21 10:13:55 volumio volumio[1003]: info: Stoppping Tunnel 1 Nov 21 10:13:55 volumio sudo[1396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 21 10:13:55 volumio sudo[1396]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:55 volumio sudo[1399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Nov 21 10:13:55 volumio sudo[1396]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:55 volumio sudo[1399]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 10:13:55 volumio volumio[1003]: error: Cannot start Volumio Streaming Daemon Nov 21 10:13:55 volumio volumio[1003]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 21 10:13:55 volumio volumio[1003]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 21 10:13:55 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 21 10:13:55 volumio volumio[1003]: info: Remote SSH Stopped Nov 21 10:13:55 volumio sudo[1399]: pam_unix(sudo:session): session closed for user root Nov 21 10:13:55 volumio volumio[1003]: info: Setting Geolocation for MyVolumio to eu7 Nov 21 10:13:55 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:13:55 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:13:55 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:13:55 volumio volumio[1003]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 21 10:13:56 volumio volumio[1003]: info: Updating MyVolumio device info Nov 21 10:13:56 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:13:56 volumio volumio[1315]: ......................................................................................++++ Nov 21 10:13:56 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 21 10:13:56 volumio volumio[1003]: info: Received Get System Info Nov 21 10:13:56 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 21 10:13:56 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 21 10:13:56 volumio volumio[1003]: info: Discovery: Getting this device information Nov 21 10:13:56 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Nov 21 10:13:56 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:13:56 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 21 10:13:56 volumio volumio[1003]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 21 10:13:59 volumio volumio[1003]: info: MYVOLUMIO: Adding device Nov 21 10:13:59 volumio volumio[1003]: info: MYVOLUMIO: Evaluating Server Nov 21 10:14:00 volumio systemd[1]: systemd-timedated.service: Succeeded. Nov 21 10:14:00 volumio volumio[1003]: info: Setting Geolocation for MyVolumio to eu7 Nov 21 10:14:00 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:14:00 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:14:00 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:14:01 volumio volumio[1003]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 21 10:14:01 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 21 10:14:01 volumio volumio[1003]: info: Preload queue cleared Nov 21 10:14:01 volumio volumio[1003]: info: Updating MyVolumio device info Nov 21 10:14:01 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:14:01 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:14:01 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 10:14:01 volumio volumio[1315]: ......................................++++ Nov 21 10:14:01 volumio volumio[1315]: e is 65537 (0x010001) Nov 21 10:14:01 volumio volumio[1315]: writing RSA key Nov 21 10:14:02 volumio volumio[1003]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 21 10:14:02 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 21 10:14:02 volumio volumio[1003]: info: Preload queue cleared Nov 21 10:14:03 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 21 10:14:03 volumio volumio[1003]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 21 10:14:03 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 21 10:14:03 volumio volumio[1003]: info: Received Get System Version Nov 21 10:14:03 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 21 10:14:03 volumio volumio[1003]: info: Received Get System Info Nov 21 10:14:03 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 21 10:14:03 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 21 10:14:03 volumio volumio[1003]: info: Discovery: Getting this device information Nov 21 10:14:03 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Nov 21 10:14:03 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Nov 21 10:14:03 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 21 10:14:03 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 21 10:14:04 volumio volumio[1003]: info: Preload queue cleared Nov 21 10:14:06 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 21 10:14:06 volumio volumio[1003]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 10:14:06 volumio volumio[1003]: TypeError: Cannot read property 'length' of undefined Nov 21 10:14:06 volumio volumio[1003]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Nov 21 10:14:06 volumio volumio[1003]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Nov 21 10:14:06 volumio volumio[1003]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Nov 21 10:14:06 volumio volumio[1003]: at Parser.emit (events.js:315:20) Nov 21 10:14:06 volumio volumio[1003]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Nov 21 10:14:06 volumio volumio[1003]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Nov 21 10:14:06 volumio volumio[1003]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Nov 21 10:14:06 volumio volumio[1003]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Nov 21 10:14:06 volumio volumio[1003]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Nov 21 10:14:06 volumio volumio[1003]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Nov 21 10:14:06 volumio volumio[1003]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Nov 21 10:14:06 volumio volumio[1003]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Nov 21 10:14:06 volumio volumio[1003]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Nov 21 10:14:06 volumio volumio[1003]: at IncomingMessage.emit (events.js:327:22) Nov 21 10:14:06 volumio volumio[1003]: at endReadableNT (internal/streams/readable.js:1327:12) Nov 21 10:14:06 volumio volumio[1003]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Nov 21 10:14:06 volumio volumio[1003]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 10:14:07 volumio sudo[1469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-21 10:13 Nov 21 10:14:07 volumio sudo[1469]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"