-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Fri 2025-01-17 19:47:26 CET. -- Jan 17 19:46:00 volumiocm5 volumio-remote-updater[725]: [2025-01-17 19:46:00] [connect] Successful connection Jan 17 19:46:00 volumiocm5 volumio-time-update[729]: volumio-time-update-util: Fetching time from Volumio... Jan 17 19:46:00 volumiocm5 volumio-time-update[729]: volumio-time-update-util: Date not found in response Jan 17 19:46:00 volumiocm5 volumio-time-update[729]: volumio-time-update-util: Retrying in 5 seconds... Jan 17 19:46:00 volumiocm5 volumio[1074]: info: ------------------------------------------- Jan 17 19:46:00 volumiocm5 volumio[1074]: info: ----- Volumio3 ---- Jan 17 19:46:00 volumiocm5 volumio[1074]: info: ------------------------------------------- Jan 17 19:46:00 volumiocm5 volumio[1074]: info: ----- System startup ---- Jan 17 19:46:00 volumiocm5 volumio[1074]: info: ------------------------------------------- Jan 17 19:46:00 volumiocm5 volumio[1074]: info: MYVOLUMIO Environment detected Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Plugin folders cleanup Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Scanning into folder /volumio/app/plugins/ Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Scanning category audio_interface Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Scanning category miscellanea Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Scanning category music_service Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Scanning category plugins.json Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Scanning category system_controller Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Scanning category user_interface Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Scanning into folder /data/plugins/ Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Scanning category music_service Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Scanning category user_interface Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Plugin folders cleanup completed Jan 17 19:46:00 volumiocm5 volumio[1074]: info: ------------------------------------------- Jan 17 19:46:00 volumiocm5 volumio[1074]: info: ----- Core plugins startup ---- Jan 17 19:46:00 volumiocm5 volumio[1074]: info: ------------------------------------------- Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Loading plugins from folder /volumio/app/plugins/ Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Adding plugin upnp to MyMusic Plugins Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Loading plugins from folder /data/plugins/ Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Loading plugin "system"... Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Loading plugin "appearance"... Jan 17 19:46:00 volumiocm5 bthelper[730]: Changing power off succeeded Jan 17 19:46:00 volumiocm5 nmbd[894]: [2025/01/17 19:46:00.715703, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 17 19:46:00 volumiocm5 nmbd[894]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jan 17 19:46:00 volumiocm5 systemd[1]: Started Samba NMB Daemon. Jan 17 19:46:00 volumiocm5 systemd[1]: Starting Samba Winbind Daemon... Jan 17 19:46:00 volumiocm5 bthelper[730]: [CHG] Controller 2C:CF:67:BE:93:C0 Class: 0x0000041c Jan 17 19:46:00 volumiocm5 bthelper[730]: Changing power on succeeded Jan 17 19:46:00 volumiocm5 bthelper[730]: [CHG] Controller 2C:CF:67:BE:93:C0 Powered: yes Jan 17 19:46:00 volumiocm5 winbindd[1110]: [2025/01/17 19:46:00.809460, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jan 17 19:46:00 volumiocm5 winbindd[1110]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jan 17 19:46:00 volumiocm5 winbindd[1110]: [2025/01/17 19:46:00.815838, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 17 19:46:00 volumiocm5 systemd[1]: Started Samba Winbind Daemon. Jan 17 19:46:00 volumiocm5 winbindd[1110]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jan 17 19:46:00 volumiocm5 systemd[1]: Starting Samba SMB Daemon... Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Loading plugin "network"... Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Refreshing Cached IP Addresses Jan 17 19:46:00 volumiocm5 sudo[1121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 19:46:00 volumiocm5 sudo[1121]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:46:00 volumiocm5 sudo[1121]: pam_unix(sudo:session): session closed for user root Jan 17 19:46:00 volumiocm5 sudo[1123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 19:46:00 volumiocm5 sudo[1123]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:46:00 volumiocm5 sudo[1123]: pam_unix(sudo:session): session closed for user root Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Loading plugin "services"... Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Loading plugin "alsa_controller"... Jan 17 19:46:00 volumiocm5 sudo[1133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 17 19:46:00 volumiocm5 sudo[1133]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:46:00 volumiocm5 smbd[1115]: [2025/01/17 19:46:00.967819, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 17 19:46:00 volumiocm5 systemd[1]: Started Samba SMB Daemon. Jan 17 19:46:00 volumiocm5 smbd[1115]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jan 17 19:46:00 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Loading plugin "wizard"... Jan 17 19:46:00 volumiocm5 volumio[1074]: info: Loading plugin "networkfs"... Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Starting Udev Watcher for removable devices Jan 17 19:46:01 volumiocm5 sudo[1150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=md_audio@yahoo.fr,password=Mongoose010271$,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.124/USB /mnt/NAS/USB Jan 17 19:46:01 volumiocm5 sudo[1150]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Mounting Device 01DB68C57D6700B0 Jan 17 19:46:01 volumiocm5 sudo[1163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/01DB68C57D6700B0 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jan 17 19:46:01 volumiocm5 sudo[1163]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:46:01 volumiocm5 sudo[1150]: pam_unix(sudo:session): session closed for user root Jan 17 19:46:01 volumiocm5 kernel: Key type cifs.spnego registered Jan 17 19:46:01 volumiocm5 kernel: Key type cifs.idmap registered Jan 17 19:46:01 volumiocm5 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. Jan 17 19:46:01 volumiocm5 kernel: CIFS: Attempting to mount //192.168.1.124/USB Jan 17 19:46:01 volumiocm5 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jan 17 19:46:01 volumiocm5 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Jan 17 19:46:01 volumiocm5 ntfs-3g[1174]: Version 2017.3.23AR.3 integrated FUSE 28 Jan 17 19:46:01 volumiocm5 ntfs-3g[1174]: Mounted /dev/sda1 (Read-Write, label "", NTFS 3.1) Jan 17 19:46:01 volumiocm5 ntfs-3g[1174]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Jan 17 19:46:01 volumiocm5 ntfs-3g[1174]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Jan 17 19:46:01 volumiocm5 ntfs-3g[1174]: Global ownership and permissions enforced, configuration type 7 Jan 17 19:46:01 volumiocm5 sudo[1163]: pam_unix(sudo:session): session closed for user root Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Ignoring mount for partition: boot Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Ignoring mount for partition: volumio Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Ignoring mount for partition: volumio_data Jan 17 19:46:01 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Loading plugin "volumio_command_line_client"... Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Loading plugin "upnp"... Jan 17 19:46:01 volumiocm5 volumio[1074]: info: [1737139561250] Starting Upmpd Daemon Jan 17 19:46:01 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Loading plugin "my_music"... Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Loading plugin "mpd"... Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Loading plugin "upnp_browser"... Jan 17 19:46:01 volumiocm5 ntpd[929]: Listen normally on 3 wlan0 192.168.211.1:123 Jan 17 19:46:01 volumiocm5 ntpd[929]: new interface(s) found: waking up resolver Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Loading plugin "alarm-clock"... Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Loading plugin "airplay_emulation"... Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Starting Shairport Sync Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Loading plugin "last_100"... Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Loading plugin "webradio"... Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Loading plugin "i2s_dacs"... Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Loading plugin "volumiodiscovery"... Jan 17 19:46:01 volumiocm5 volumio[1074]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 19:46:01 volumiocm5 node[1074]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 19:46:01 volumiocm5 node[1074]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:46:01 volumiocm5 volumio[1074]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:46:01 volumiocm5 volumio[1074]: *** WARNING *** For more information see Jan 17 19:46:01 volumiocm5 volumio[1074]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 19:46:01 volumiocm5 volumio[1074]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:46:01 volumiocm5 volumio[1074]: *** WARNING *** For more information see Jan 17 19:46:01 volumiocm5 node[1074]: *** WARNING *** For more information see Jan 17 19:46:01 volumiocm5 node[1074]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 19:46:01 volumiocm5 node[1074]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:46:01 volumiocm5 node[1074]: *** WARNING *** For more information see Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Discovery: Started advertising with name: VolumioCM5 Jan 17 19:46:01 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:46:01 volumiocm5 volumio[1074]: info: Loading plugin "ytmusic"... Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Loading plugin "outputs"... Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Loading plugin "albumart"... Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Plugin example_plugin is not enabled Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Loading plugin "inputs"... Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Loading plugin "updater_comm"... Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Plugin mpdemulation is not enabled Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Loading plugin "rest_api"... Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Loading plugin "websocket"... Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Starting Socket.io Server version 2.3.0 Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Loading plugin "Systeminfo"... Jan 17 19:46:02 volumiocm5 volumio[1074]: Forking 3 albumart workers Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Loading i18n strings for locale fr Jan 17 19:46:02 volumiocm5 volumio[1074]: Updating browse sources language Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::initPlayerControls Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: Express server listening on port 3000 Jan 17 19:46:02 volumiocm5 volumio[1074]: [Metrics] WebUI: 2s 546.92ms Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreStateMachine::resetVolumioState Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreStateMachine::getcurrentVolume Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreStateMachine::pushState Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 19:46:02 volumiocm5 volumio[1074]: Starting albumart workers Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioPushState Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Scanning new location : "USB/01DB68C57D6700B0" Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Volumio Network Manager: Network status updated: 0 Jan 17 19:46:02 volumiocm5 volumio[1074]: Starting albumart workers Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Cannot mount NAS USB at system boot, trial number 1 ,retrying in 5 seconds Jan 17 19:46:02 volumiocm5 volumio[1074]: Starting albumart workers Jan 17 19:46:02 volumiocm5 volumio-remote-updater[725]: [2025-01-17 19:46:02] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1737139560 101 Jan 17 19:46:02 volumiocm5 volumio[1074]: 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 Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Reloading queue from file Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreStateMachine::setRepeat null single undefined Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreStateMachine::pushState Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioPushState Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreStateMachine::setRandom null Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreStateMachine::pushState Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioPushState Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Setting Device type: Raspberry PI Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Completed loading Core Plugins Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Preparing to generate the ALSA configuration file Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Discovery: adding 5ac3246a-31b5-430c-8ce7-54a6b9a2a1d3 Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Discovery: Found device VolumioCM5 Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetState Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Asound.conf file written Jan 17 19:46:02 volumiocm5 sudo[1219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 17 19:46:02 volumiocm5 sudo[1219]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:46:02 volumiocm5 sudo[1219]: pam_unix(sudo:session): session closed for user root Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Output device has changed, restarting MPD Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Output device has changed, restarting Shairport Sync Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:46:02 volumiocm5 sudo[1229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:46:02 volumiocm5 sudo[1229]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:46:02 volumiocm5 sudo[1229]: pam_unix(sudo:session): session closed for user root Jan 17 19:46:02 volumiocm5 sudo[1234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:46:02 volumiocm5 sudo[1234]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:46:02 volumiocm5 systemd[1]: Stopping Music Player Daemon... Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:46:02 volumiocm5 volumio[1074]: info: ___________ START PLUGINS ___________ Jan 17 19:46:02 volumiocm5 volumio[1074]: info: ControllerMpd::onStart: Initializing MPD Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Creating MPD Configuration file Jan 17 19:46:02 volumiocm5 sudo[1257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:46:02 volumiocm5 volumio[1074]: info: [1737139562839] CoreMusicLibrary::Adding element Serveurs Média Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:46:02 volumiocm5 sudo[1257]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:46:02 volumiocm5 sudo[1259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:46:02 volumiocm5 sudo[1259]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:46:02 volumiocm5 sudo[1257]: pam_unix(sudo:session): session closed for user root Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:46:02 volumiocm5 systemd[1]: mpd.service: Succeeded. Jan 17 19:46:02 volumiocm5 systemd[1]: Stopped Music Player Daemon. Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:46:02 volumiocm5 volumio[1074]: info: [1737139562875] CoreMusicLibrary::Adding element Last_100 Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:46:02 volumiocm5 volumio[1074]: info: [1737139562875] CoreMusicLibrary::Adding element Webradio Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Initializing BBC Radios Jan 17 19:46:02 volumiocm5 systemd[1]: Starting Music Player Daemon... Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:46:02 volumiocm5 volumio[1074]: info: [1737139562900] CoreMusicLibrary::Adding element YouTube Music Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:46:02 volumiocm5 volumio[1074]: Cannot find translation for source YouTube Music Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Volumio Calling Home Jan 17 19:46:02 volumiocm5 sudo[1266]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 19:46:02 volumiocm5 sudo[1266]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:46:02 volumiocm5 sudo[1266]: pam_unix(sudo:session): session closed for user root Jan 17 19:46:02 volumiocm5 volumio[1074]: info: MPD Permissions set Jan 17 19:46:02 volumiocm5 volumio[1074]: info: MPD Permissions set Jan 17 19:46:02 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Starting Shairport Sync Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Starting Shairport Sync Jan 17 19:46:02 volumiocm5 sudo[1293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:46:02 volumiocm5 volumio[1074]: info: Starting Shairport Sync Jan 17 19:46:03 volumiocm5 sudo[1293]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:46:03 volumiocm5 sudo[1295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:46:03 volumiocm5 sudo[1295]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:46:03 volumiocm5 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:46:03 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetState Jan 17 19:46:03 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:46:03 volumiocm5 sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:46:03 volumiocm5 systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:46:03 volumiocm5 sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:46:03 volumiocm5 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:46:03 volumiocm5 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:46:03 volumiocm5 sudo[1295]: pam_unix(sudo:session): session closed for user root Jan 17 19:46:03 volumiocm5 sudo[1293]: pam_unix(sudo:session): session closed for user root Jan 17 19:46:03 volumiocm5 volumio[1074]: info: Shairport-Sync Started Jan 17 19:46:03 volumiocm5 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:46:03 volumiocm5 systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:46:03 volumiocm5 volumio[1074]: Error adding Membership: Error: addMembership EINVAL Jan 17 19:46:03 volumiocm5 volumio[1074]: info: Shairport-Sync Started Jan 17 19:46:03 volumiocm5 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:46:03 volumiocm5 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:46:03 volumiocm5 sudo[1298]: pam_unix(sudo:session): session closed for user root Jan 17 19:46:03 volumiocm5 volumio[1074]: info: Shairport-Sync Started Jan 17 19:46:03 volumiocm5 mpd[1282]: Jan 17 19:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 17 19:46:03 volumiocm5 systemd[1]: Started Music Player Daemon. Jan 17 19:46:03 volumiocm5 sudo[1234]: pam_unix(sudo:session): session closed for user root Jan 17 19:46:03 volumiocm5 sudo[1259]: pam_unix(sudo:session): session closed for user root Jan 17 19:46:03 volumiocm5 volumio[1074]: info: Completed starting Core Plugins Jan 17 19:46:03 volumiocm5 volumio[1074]: info: ------------------------------------------- Jan 17 19:46:03 volumiocm5 volumio[1074]: info: ----- MyVolumio plugins startup ---- Jan 17 19:46:03 volumiocm5 volumio[1074]: info: ------------------------------------------- Jan 17 19:46:03 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 17 19:46:03 volumiocm5 volumio[1074]: error: MPD error: The expression evaluated to a falsy value: Jan 17 19:46:03 volumiocm5 volumio[1074]: assert.ok(self.idling) Jan 17 19:46:03 volumiocm5 volumio[1074]: error: The expression evaluated to a falsy value: Jan 17 19:46:03 volumiocm5 volumio[1074]: assert.ok(self.idling) Jan 17 19:46:03 volumiocm5 volumio[1074]: info: MPD running with PID1282 Jan 17 19:46:03 volumiocm5 volumio[1074]: ,establishing connection Jan 17 19:46:03 volumiocm5 volumio[1074]: error: updateQueue error: null Jan 17 19:46:03 volumiocm5 volumio[1074]: error: updateQueue error: null Jan 17 19:46:04 volumiocm5 sh[672]: eth0: leased 192.168.1.120 for 86400 seconds Jan 17 19:46:04 volumiocm5 sh[672]: eth0: adding route to 192.168.1.0/24 Jan 17 19:46:04 volumiocm5 sh[672]: eth0: adding default route via 192.168.1.254 Jan 17 19:46:04 volumiocm5 dhcpcd[786]: eth0: leased 192.168.1.120 for 86400 seconds Jan 17 19:46:04 volumiocm5 dhcpcd[786]: eth0: adding route to 192.168.1.0/24 Jan 17 19:46:04 volumiocm5 dhcpcd[786]: eth0: adding default route via 192.168.1.254 Jan 17 19:46:04 volumiocm5 avahi-daemon[743]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.120. Jan 17 19:46:04 volumiocm5 avahi-daemon[743]: New relevant interface eth0.IPv4 for mDNS. Jan 17 19:46:04 volumiocm5 avahi-daemon[743]: Registering new address record for 192.168.1.120 on eth0.IPv4. Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 3 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 4 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 5 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 6 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 7 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 8 Jan 17 19:46:04 volumiocm5 dnsmasq[1060]: reading /etc/resolv.conf Jan 17 19:46:04 volumiocm5 dnsmasq[1060]: using nameserver 192.168.1.254#53 Jan 17 19:46:04 volumiocm5 dnsmasq[1060]: using nameserver 208.67.222.222#53 Jan 17 19:46:04 volumiocm5 dnsmasq[1060]: using nameserver 208.67.220.220#53 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 9 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 10 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 11 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 12 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 13 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 14 Jan 17 19:46:04 volumiocm5 sh[672]: forked to background, child pid 1331 Jan 17 19:46:04 volumiocm5 dhcpcd[786]: forked to background, child pid 1331 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 15 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 16 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 17 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 18 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 19 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 20 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 21 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 22 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 23 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 24 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 25 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 26 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 27 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 28 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 29 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 30 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 31 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 32 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 33 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 34 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 35 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 36 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 37 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 38 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 39 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 40 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 41 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 42 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 43 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 44 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 45 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 46 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 47 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 48 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 49 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 50 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 51 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 52 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 53 Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 54 Jan 17 19:46:04 volumiocm5 ifplugd(eth0)[947]: client: ifup: interface eth0 already configured Jan 17 19:46:04 volumiocm5 sh[672]: eth0=eth0 Jan 17 19:46:04 volumiocm5 sudo[1133]: pam_unix(sudo:session): session closed for user root Jan 17 19:46:04 volumiocm5 ifplugd(eth0)[947]: Program executed successfully. Jan 17 19:46:04 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0 Engine version: 3 Transport: polling Total Clients: 55 Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetState Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:46:04 volumiocm5 volumio[1074]: info: Received Get System Info Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 17 19:46:04 volumiocm5 volumio[1074]: info: Discovery: Getting this device information Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetState Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetState Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetVisibleSources Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetState Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetState Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 17 19:46:04 volumiocm5 volumio[1074]: info: Received Get System Info Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 17 19:46:04 volumiocm5 volumio[1074]: info: Discovery: Getting this device information Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetState Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetState Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:46:04 volumiocm5 volumio[1074]: info: Listing playlists Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetQueue Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CoreStateMachine::getQueue Jan 17 19:46:04 volumiocm5 volumio[1074]: info: CorePlayQueue::getQueue Jan 17 19:46:05 volumiocm5 volumio-time-update[729]: volumio-time-update-util: Fetching time from Volumio... Jan 17 19:46:05 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:46:05 volumiocm5 volumio-time-update[729]: volumio-time-update-util: Setting system time to: 2025-01-17 19:47:02 Jan 17 19:46:05 volumiocm5 sudo[1363]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-01-17 19:47:02 Jan 17 19:46:05 volumiocm5 sudo[1363]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:46:05 volumiocm5 dbus-daemon[738]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.15' (uid=0 pid=1364 comm="timedatectl set-time 2025-01-17 19:47:02 ") Jan 17 19:46:05 volumiocm5 systemd[1]: Starting Time & Date Service... Jan 17 19:46:05 volumiocm5 dbus-daemon[738]: [system] Successfully activated service 'org.freedesktop.timedate1' Jan 17 19:46:05 volumiocm5 systemd[1]: Started Time & Date Service. Jan 17 19:47:02 volumiocm5 systemd-timedated[1365]: Changed local time to Fri Jan 17 19:47:02 2025 Jan 17 19:47:02 volumiocm5 sudo[1363]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:02 volumiocm5 volumio[1074]: info: Discovery: Browse raised the following error Error: dns service error: unknown Jan 17 19:47:02 volumiocm5 volumio-time-update[729]: volumio-time-update-util: System time updated successfully. Jan 17 19:47:02 volumiocm5 systemd[1]: Started Volumio Time Update Utility. Jan 17 19:47:02 volumiocm5 systemd[1]: Reached target Multi-User System. Jan 17 19:47:02 volumiocm5 systemd[1]: Reached target Graphical Interface. Jan 17 19:47:02 volumiocm5 systemd[1]: Starting Update UTMP about System Runlevel Changes... Jan 17 19:47:02 volumiocm5 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jan 17 19:47:02 volumiocm5 systemd[1]: Started Update UTMP about System Runlevel Changes. Jan 17 19:47:02 volumiocm5 systemd[1]: Startup finished in 10.919s (kernel) + 11.704s (userspace) = 22.624s. Jan 17 19:47:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:02 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:03 volumiocm5 ntpd[929]: Listen normally on 4 eth0 192.168.1.120:123 Jan 17 19:47:03 volumiocm5 ntpd[929]: new interface(s) found: waking up resolver Jan 17 19:47:03 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:03 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:04 volumiocm5 sudo[1371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=md_audio@yahoo.fr,password=Mongoose010271$,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.124/USB /mnt/NAS/USB Jan 17 19:47:04 volumiocm5 sudo[1371]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:04 volumiocm5 kernel: CIFS: Attempting to mount //192.168.1.124/USB Jan 17 19:47:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:04 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:05 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:05 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:06 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:06 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:07 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:07 volumiocm5 volumio[1074]: info: Volumio Network Manager: Network status updated: 1 Jan 17 19:47:07 volumiocm5 sudo[1390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 19:47:07 volumiocm5 sudo[1390]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:07 volumiocm5 sudo[1390]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:07 volumiocm5 sudo[1392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 19:47:07 volumiocm5 sudo[1392]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:07 volumiocm5 sudo[1392]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:07 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:07 volumiocm5 sudo[1396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 17 19:47:07 volumiocm5 sudo[1396]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:08 volumiocm5 systemd[1]: Started UPnP Renderer front-end to MPD. Jan 17 19:47:08 volumiocm5 sudo[1396]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:08 volumiocm5 volumio[1074]: info: Upmpdcli Daemon Started Jan 17 19:47:08 volumiocm5 volumio[1398]: Generating RSA private key, 4096 bit long modulus (2 primes) Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jan 17 19:47:08 volumiocm5 volumio[1074]: info: Adding plugin bluetooth to MyMusic Plugins Jan 17 19:47:08 volumiocm5 volumio[1074]: info: Adding plugin multiroom to MyMusic Plugins Jan 17 19:47:08 volumiocm5 volumio[1074]: info: Adding plugin metavolumio to MyMusic Plugins Jan 17 19:47:08 volumiocm5 volumio[1074]: info: Adding plugin cd_controller to MyMusic Plugins Jan 17 19:47:08 volumiocm5 volumio[1074]: info: Adding plugin smart_inputs to MyMusic Plugins Jan 17 19:47:08 volumiocm5 volumio[1074]: info: Adding plugin tidalconnect to MyMusic Plugins Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jan 17 19:47:08 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:47:08 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:47:08 volumiocm5 volumio[1074]: info: Starting MyVolumio Remote Streaming Endpoints Jan 17 19:47:08 volumiocm5 volumio[1074]: info: MyVolumio login type: Token Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jan 17 19:47:08 volumiocm5 volumio[1074]: info: Starting Streaming Service Transparent Proxy Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 17 19:47:08 volumiocm5 volumio[1074]: info: Streaming services startup Jan 17 19:47:08 volumiocm5 volumio[1074]: info: Starting Streaming Daemon Jan 17 19:47:08 volumiocm5 sudo[1421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 17 19:47:08 volumiocm5 sudo[1421]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:08 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jan 17 19:47:08 volumiocm5 sudo[1421]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:08 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:08 volumiocm5 volumio[1074]: error: Cannot start Volumio Streaming Daemon Jan 17 19:47:08 volumiocm5 volumio[1074]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 17 19:47:08 volumiocm5 volumio[1074]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 17 19:47:09 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:09 volumiocm5 volumio[1074]: STREAMING PROXY: Starting server on port 3245 Jan 17 19:47:09 volumiocm5 volumio[1074]: Node JS runtime: 14 Jan 17 19:47:09 volumiocm5 volumio[1074]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jan 17 19:47:09 volumiocm5 volumio[1398]: ......................++++ Jan 17 19:47:09 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:09 volumiocm5 volumio[1074]: info: MyVolumio token set successfully Jan 17 19:47:09 volumiocm5 volumio[1074]: info: MYVOLUMIO: Adding device Jan 17 19:47:09 volumiocm5 volumio[1074]: info: MYVOLUMIO: Evaluating Server Jan 17 19:47:09 volumiocm5 volumio[1074]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.785&uuid=86e9c92f6a3692f44f50dd6905be8663" http://updates.volumio.org/downloader-v1/track-device Jan 17 19:47:09 volumiocm5 volumio[1074]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 17 19:47:09 volumiocm5 volumio[1074]: Dload Upload Total Spent Left Speed Jan 17 19:47:09 volumiocm5 volumio[1074]: [132B blob data] Jan 17 19:47:09 volumiocm5 volumio[1074]: retrying in 5 seconds, trial 0 Jan 17 19:47:09 volumiocm5 volumio[1074]: info: Volumio Calling Home Jan 17 19:47:09 volumiocm5 volumio[1074]: info: MyVolumio Plan changed: premium Jan 17 19:47:09 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jan 17 19:47:09 volumiocm5 volumio[1074]: info: Removing browser output: myVolumio user plan is not superstar Jan 17 19:47:09 volumiocm5 volumio[1074]: info: Removing audio output: Jan 17 19:47:09 volumiocm5 volumio[1074]: info: MYVOLUMIO: Adding device Jan 17 19:47:09 volumiocm5 volumio[1074]: info: MYVOLUMIO: Evaluating Server Jan 17 19:47:09 volumiocm5 volumio[1074]: info: Remote config written successfully Jan 17 19:47:09 volumiocm5 volumio[1074]: info: Starting Tunnel 1 Jan 17 19:47:09 volumiocm5 volumio[1074]: info: Starting Tunnel Connection Checker Jan 17 19:47:09 volumiocm5 volumio[1074]: info: Completed starting MyVolumio Plugin Jan 17 19:47:09 volumiocm5 volumio[1074]: info: Volumio called home Jan 17 19:47:09 volumiocm5 volumio[1074]: info: MYVolumio Device enabled Jan 17 19:47:09 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jan 17 19:47:09 volumiocm5 volumio[1074]: info: MyVolumio status changed Jan 17 19:47:09 volumiocm5 volumio[1074]: info: Streaming services startup Jan 17 19:47:09 volumiocm5 volumio[1074]: info: Starting Streaming Daemon Jan 17 19:47:09 volumiocm5 sudo[1464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 17 19:47:09 volumiocm5 sudo[1464]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:09 volumiocm5 sudo[1464]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:09 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jan 17 19:47:09 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [1737139630007] Starting BluetoothController Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Jan 17 19:47:10 volumiocm5 sudo[1467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jan 17 19:47:10 volumiocm5 sudo[1467]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:10 volumiocm5 sudo[1467]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:10 volumiocm5 volumio[1074]: info: MRS: MultiRoom plugin initialized Jan 17 19:47:10 volumiocm5 volumio[1074]: info: MRS: STOPPING SNAPCLIENT Jan 17 19:47:10 volumiocm5 volumio[1074]: info: MRS: Snap server stop Jan 17 19:47:10 volumiocm5 sudo[1483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jan 17 19:47:10 volumiocm5 sudo[1483]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:10 volumiocm5 volumio[1074]: info: MRS: STOPPING volumioStreaming Jan 17 19:47:10 volumiocm5 sudo[1486]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jan 17 19:47:10 volumiocm5 sudo[1486]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:10 volumiocm5 sudo[1489]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jan 17 19:47:10 volumiocm5 sudo[1489]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:10 volumiocm5 sudo[1483]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Jan 17 19:47:10 volumiocm5 sudo[1492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jan 17 19:47:10 volumiocm5 sudo[1492]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:10 volumiocm5 sudo[1492]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:10 volumiocm5 sudo[1486]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:10 volumiocm5 sudo[1489]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Jan 17 19:47:10 volumiocm5 sudo[1371]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:10 volumiocm5 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jan 17 19:47:10 volumiocm5 kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Preparing to generate the ALSA configuration file Jan 17 19:47:10 volumiocm5 volumio[1074]: error: Cannot start Volumio Streaming Daemon Jan 17 19:47:10 volumiocm5 volumio[1074]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 17 19:47:10 volumiocm5 volumio[1074]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 17 19:47:10 volumiocm5 volumio[1074]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Reading ALSA contributions from plugins. Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Setting Geolocation for MyVolumio to eu10 Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Setting Geolocation for MyVolumio to eu6 Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: MRS: Removed streaming files Jan 17 19:47:10 volumiocm5 volumio[1074]: info: MRS: volumioStreaming STOPPED Jan 17 19:47:10 volumiocm5 volumio[1074]: info: MRS: SNAPSERVER STOPPED Jan 17 19:47:10 volumiocm5 volumio[1074]: info: MRS: SNAPCLIENT STOPPED Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Cannot mount NAS USB at system boot, trial number 2 ,retrying in 5 seconds Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Asound.conf file written Jan 17 19:47:10 volumiocm5 sudo[1495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 17 19:47:10 volumiocm5 sudo[1495]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:10 volumiocm5 sudo[1495]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Output device has changed, restarting MPD Jan 17 19:47:10 volumiocm5 sudo[1500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:47:10 volumiocm5 sudo[1500]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:10 volumiocm5 sudo[1500]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Output device has changed, restarting Shairport Sync Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:47:10 volumiocm5 sudo[1503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:47:10 volumiocm5 sudo[1503]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:10 volumiocm5 systemd[1]: Stopping Music Player Daemon... Jan 17 19:47:10 volumiocm5 systemd[1]: mpd.service: Succeeded. Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:47:10 volumiocm5 volumio[1074]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:47:10 volumiocm5 systemd[1]: Stopped Music Player Daemon. Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jan 17 19:47:10 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output for this device Jan 17 19:47:10 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output Jan 17 19:47:10 volumiocm5 sudo[1512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name VolumioCM5 Jan 17 19:47:10 volumiocm5 sudo[1512]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:10 volumiocm5 systemd[1]: Starting Music Player Daemon... Jan 17 19:47:10 volumiocm5 sudo[1512]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:10 volumiocm5 sudo[1508]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 19:47:10 volumiocm5 sudo[1508]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:10 volumiocm5 sudo[1508]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:10 volumiocm5 volumio[1398]: .............................++++ Jan 17 19:47:10 volumiocm5 volumio[1398]: e is 65537 (0x010001) Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding audio output: Jan 17 19:47:10 volumiocm5 volumio[1398]: writing RSA key Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding audio output: Jan 17 19:47:10 volumiocm5 volumio[1074]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding METAVOLUMIO REST API Endpoints Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Preparing CD Folders Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding CD REST API Endpoints Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Starting UDEV Watcher for CD Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Detecting CD presence with UDEV Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding inputs REST Endpoints Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Scanning Audio Inputs Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Checking against Known Cards name Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Checking against Known Cards name Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding Server instance for streaming Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Jan 17 19:47:10 volumiocm5 volumio[1074]: error: Hi Res Audio Failed Login: Missing Login Data Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding HIGHRESAUDIO REST API Endpoints Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Jan 17 19:47:10 volumiocm5 volumio[1074]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Stopping AccessToken refresher cron Jan 17 19:47:10 volumiocm5 sudo[1529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 17 19:47:10 volumiocm5 sudo[1529]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:10 volumiocm5 volumio[1074]: info: AccessToken refresher cron started Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Stopping AccessToken refresher cron for QOBUZ Jan 17 19:47:10 volumiocm5 sudo[1529]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:10 volumiocm5 volumio[1074]: info: AccessToken refresher cron started for QOBUZ Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding TIDAL REST API Endpoints Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding QOBUZ REST API Endpoints Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Bluetooth name changed to VolumioCM5 Jan 17 19:47:10 volumiocm5 volumio[1074]: info: MPD Permissions set Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Starting Shairport Sync Jan 17 19:47:10 volumiocm5 sudo[1540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:47:10 volumiocm5 sudo[1540]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:10 volumiocm5 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:47:10 volumiocm5 systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:47:10 volumiocm5 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:47:10 volumiocm5 volumio[1074]: info: MRS: Found cast device: BboxTV-dc440e839c85caae3fe15e7afd5e7b83 Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Adding audio output: Jan 17 19:47:10 volumiocm5 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:47:10 volumiocm5 sudo[1540]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Shairport-Sync Started Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Retrieving Cloud Streaming UI Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Getting Tidal Cloud Configuration Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Getting Qobuz Cloud Configuration Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Asking plugin for UI Config Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Getting Spotify Cloud Configuration Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Asking plugin for UI Config Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Saving Spotify Acccount Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Got it Jan 17 19:47:10 volumiocm5 volumio[1074]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Got it Jan 17 19:47:10 volumiocm5 volumio[1074]: info: Got Tidal Cloud Configuration Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetBrowseSources Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetBrowseSources Jan 17 19:47:10 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetBrowseSources Jan 17 19:47:10 volumiocm5 mpd[1515]: Jan 17 19:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 17 19:47:10 volumiocm5 systemd[1]: Started Music Player Daemon. Jan 17 19:47:10 volumiocm5 sudo[1503]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:10 volumiocm5 volumio[1074]: error: updateQueue error: null Jan 17 19:47:11 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 17 19:47:11 volumiocm5 volumio[1074]: info: Successfully Added MyVolumio device Jan 17 19:47:11 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 17 19:47:11 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:11 volumiocm5 volumio[1074]: info: Successfully Added MyVolumio device Jan 17 19:47:11 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 17 19:47:11 volumiocm5 volumio[1074]: info: Updating MyVolumio device info Jan 17 19:47:11 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:47:11 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:47:11 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:47:11 volumiocm5 volumio[1074]: info: Updating MyVolumio device info Jan 17 19:47:11 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:47:11 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:47:11 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:47:12 volumiocm5 volumio[1074]: info: Successfully Updated MyVolumio device Jan 17 19:47:12 volumiocm5 volumio[1074]: info: Successfully Updated MyVolumio device Jan 17 19:47:13 volumiocm5 sudo[1560]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Jan 17 19:47:13 volumiocm5 sudo[1560]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:13 volumiocm5 systemd[1]: Started Volumio Bluetooth Module. Jan 17 19:47:13 volumiocm5 sudo[1560]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:13 volumiocm5 volumio[1074]: info: Volumio BT Module successfully started Jan 17 19:47:13 volumiocm5 sudo[1563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Jan 17 19:47:13 volumiocm5 sudo[1563]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:13 volumiocm5 volumiobt[1562]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Jan 17 19:47:13 volumiocm5 sudo[1563]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:13 volumiocm5 volumio[1074]: info: TidalConnect service stoped! Jan 17 19:47:13 volumiocm5 volumio[1074]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 17 19:47:13 volumiocm5 volumio[1074]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 17 19:47:13 volumiocm5 sudo[1575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 17 19:47:13 volumiocm5 sudo[1575]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:13 volumiocm5 systemd[1]: Started Volumio Tidal Connect Service. Jan 17 19:47:13 volumiocm5 sudo[1575]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:13 volumiocm5 volumio[1074]: info: Executing endpoint tc_getconfig Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 17 19:47:13 volumiocm5 vtcs[1577]: STARTING TidalConnect services, version: 1.4.0.34 Jan 17 19:47:13 volumiocm5 vtcs[1577]: STARTED TidalConnect services. Jan 17 19:47:13 volumiocm5 volumio[1074]: info: Executing endpoint tc_connect Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jan 17 19:47:13 volumiocm5 volumio[1074]: info: Connecting to TidalConnect Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreCommandRouter::servicePushState Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreStateMachine::pushState Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioPushState Jan 17 19:47:13 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output update for this device Jan 17 19:47:13 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:47:13 volumiocm5 volumio[1074]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Jan 17 19:47:13 volumiocm5 volumio[1074]: verbose: CURRENT POSITION 0 Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreStateMachine::syncState stateService stop Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreStateMachine::syncState currentStatus stop Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreStateMachine::pushState Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioPushState Jan 17 19:47:13 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output update for this device Jan 17 19:47:13 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output Jan 17 19:47:13 volumiocm5 volumio[1074]: info: No code Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreStateMachine::pushState Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioPushState Jan 17 19:47:13 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output update for this device Jan 17 19:47:13 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreCommandRouter::servicePushState Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreStateMachine::pushState Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioPushState Jan 17 19:47:13 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output update for this device Jan 17 19:47:13 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:47:13 volumiocm5 volumio[1074]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Jan 17 19:47:13 volumiocm5 volumio[1074]: verbose: CURRENT POSITION 0 Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreStateMachine::syncState stateService stop Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreStateMachine::syncState currentStatus stop Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreStateMachine::pushState Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioPushState Jan 17 19:47:13 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output update for this device Jan 17 19:47:13 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output Jan 17 19:47:13 volumiocm5 volumio[1074]: info: No code Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreStateMachine::pushState Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:47:13 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioPushState Jan 17 19:47:13 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output update for this device Jan 17 19:47:13 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output Jan 17 19:47:14 volumiocm5 sudo[1596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Jan 17 19:47:14 volumiocm5 sudo[1596]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:14 volumiocm5 volumiobt[1562]: pulseaudio: no process found Jan 17 19:47:14 volumiocm5 sudo[1596]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:14 volumiocm5 dbus-daemon[738]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.23' (uid=1000 pid=1604 comm="/usr/bin/pulseaudio --high-priority=true ") Jan 17 19:47:14 volumiocm5 sudo[1607]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jan 17 19:47:14 volumiocm5 sudo[1607]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:14 volumiocm5 systemd[1]: Starting RealtimeKit Scheduling Policy Service... Jan 17 19:47:14 volumiocm5 volumio[1074]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 17 19:47:14 volumiocm5 dbus-daemon[738]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Jan 17 19:47:14 volumiocm5 rtkit-daemon[1606]: Successfully called chroot. Jan 17 19:47:14 volumiocm5 rtkit-daemon[1606]: Successfully dropped privileges. Jan 17 19:47:14 volumiocm5 rtkit-daemon[1606]: Successfully limited resources. Jan 17 19:47:14 volumiocm5 rtkit-daemon[1606]: Running. Jan 17 19:47:14 volumiocm5 rtkit-daemon[1606]: Canary thread running. Jan 17 19:47:14 volumiocm5 rtkit-daemon[1606]: Watchdog thread running. Jan 17 19:47:14 volumiocm5 dbus-daemon[738]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.24' (uid=0 pid=1606 comm="/usr/lib/rtkit/rtkit-daemon ") Jan 17 19:47:14 volumiocm5 systemd[1]: Started RealtimeKit Scheduling Policy Service. Jan 17 19:47:14 volumiocm5 systemd[1]: Starting Authorization Manager... Jan 17 19:47:14 volumiocm5 systemd[1]: Started MyVolumio SSH Tunnel. Jan 17 19:47:14 volumiocm5 sudo[1607]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:14 volumiocm5 volumio[1074]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 17 19:47:14 volumiocm5 volumio[1074]: info: Remote SSH Started Jan 17 19:47:14 volumiocm5 autossh[1614]: port set to 0, monitoring disabled Jan 17 19:47:14 volumiocm5 autossh[1614]: starting ssh (count 1) Jan 17 19:47:14 volumiocm5 autossh[1614]: ssh child pid is 1617 Jan 17 19:47:14 volumiocm5 polkitd[1612]: started daemon version 0.105 using authority implementation `local' version `0.105' Jan 17 19:47:14 volumiocm5 dbus-daemon[738]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jan 17 19:47:14 volumiocm5 systemd[1]: Started Authorization Manager. Jan 17 19:47:14 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 56 Jan 17 19:47:14 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetState Jan 17 19:47:14 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:47:14 volumiocm5 volumiossh-tunnel[1613]: Warning: Permanently added '[eu6.myvolumio.org]:2222,[207.154.233.230]:2222' (RSA) to the list of known hosts. Jan 17 19:47:14 volumiocm5 pulseaudio[1604]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jan 17 19:47:14 volumiocm5 pulseaudio[1604]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jan 17 19:47:14 volumiocm5 bluetoothd[996]: Endpoint registered: sender=:1.44 path=/MediaEndpoint/A2DPSource Jan 17 19:47:14 volumiocm5 volumiobt[1562]: Applying permissions Jan 17 19:47:14 volumiocm5 volumiobt[1562]: Setting BT discoverable and pairable Jan 17 19:47:14 volumiocm5 bluetoothd[996]: Endpoint registered: sender=:1.44 path=/MediaEndpoint/A2DPSink Jan 17 19:47:14 volumiocm5 pulseaudio[1604]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Jan 17 19:47:14 volumiocm5 kernel: Bluetooth: RFCOMM TTY layer initialized Jan 17 19:47:14 volumiocm5 kernel: Bluetooth: RFCOMM socket layer initialized Jan 17 19:47:14 volumiocm5 kernel: Bluetooth: RFCOMM ver 1.11 Jan 17 19:47:14 volumiocm5 volumiobt[1562]: [CHG] Controller 2C:CF:67:BE:93:C0 Class: 0x0008041c Jan 17 19:47:14 volumiocm5 volumiobt[1562]: [55B blob data] Jan 17 19:47:14 volumiocm5 volumiobt[1562]: [bluetooth]# -e power on Jan 17 19:47:14 volumiocm5 volumiobt[1562]: Invalid command in menu main: -e Jan 17 19:47:14 volumiocm5 volumiobt[1562]: Jan 17 19:47:14 volumiocm5 volumiobt[1562]: Use "help" for a list of available commands in a menu. Jan 17 19:47:14 volumiocm5 volumiobt[1562]: Use "menu " if you want to enter any submenu. Jan 17 19:47:14 volumiocm5 volumiobt[1562]: Use "back" if you want to return to menu main. Jan 17 19:47:14 volumiocm5 volumiobt[1562]: [bluetooth]# agent on Jan 17 19:47:14 volumiocm5 volumiobt[1562]: Agent is already registered Jan 17 19:47:14 volumiocm5 volumiobt[1562]: [bluetooth]# discoverable on Jan 17 19:47:14 volumiocm5 volumiobt[1562]: [bluetooth]# pairable on Jan 17 19:47:14 volumiocm5 volumiobt[1562]: [bluetooth]# agent NoInputNoOutput Jan 17 19:47:14 volumiocm5 volumiobt[1562]: Agent is already registered Jan 17 19:47:14 volumiocm5 volumiobt[1562]: [bluetooth]# default-agent Jan 17 19:47:14 volumiocm5 volumiobt[1562]: [bluetooth]# quit Jan 17 19:47:14 volumiocm5 volumiobt[1562]: [59B blob data] Jan 17 19:47:15 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 17 19:47:15 volumiocm5 sudo[1628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=md_audio@yahoo.fr,password=Mongoose010271$,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.124/USB /mnt/NAS/USB Jan 17 19:47:15 volumiocm5 sudo[1628]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:47:15 volumiocm5 kernel: CIFS: Attempting to mount //192.168.1.124/USB Jan 17 19:47:15 volumiocm5 volumio[1074]: info: MRS: Getting audio outputs on start Jan 17 19:47:15 volumiocm5 volumio[1074]: info: MRS: Requesting all other devices output Jan 17 19:47:16 volumiocm5 volumio[1074]: info: TidalConnect service started! Jan 17 19:47:16 volumiocm5 volumio[1074]: [Metrics] CommandRouter: 19s 910.52ms Jan 17 19:47:16 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumiosetStartupVolume Jan 17 19:47:16 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:47:16 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:47:16 volumiocm5 volumio[1074]: info: CoreCommandRouter::Close All Modals sent Jan 17 19:47:16 volumiocm5 volumio[1074]: info: CoreCommandRouter::Close All Modals sent Jan 17 19:47:17 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 17 19:47:17 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 17 19:47:17 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 17 19:47:19 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 17 19:47:19 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jan 17 19:47:20 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 17 19:47:21 volumiocm5 systemd[1]: systemd-fsckd.service: Succeeded. Jan 17 19:47:21 volumiocm5 sudo[1628]: pam_unix(sudo:session): session closed for user root Jan 17 19:47:21 volumiocm5 volumio[1074]: info: Cannot mount NAS USB at system boot, trial number 3 ,retrying in 5 seconds Jan 17 19:47:21 volumiocm5 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jan 17 19:47:21 volumiocm5 kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Jan 17 19:47:22 volumiocm5 systemd[1]: systemd-hostnamed.service: Succeeded. Jan 17 19:47:23 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 17 19:47:23 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 17 19:47:23 volumiocm5 volumio[1074]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 57 Jan 17 19:47:23 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioGetState Jan 17 19:47:23 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:47:23 volumiocm5 volumio[1074]: info: BOOT COMPLETED Jan 17 19:47:24 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jan 17 19:47:24 volumiocm5 volumio[1074]: verbose: ControllerMpd::sendMpdCommand rescan Jan 17 19:47:24 volumiocm5 volumio[1074]: verbose: ControllerMpd::sendMpdCommand status Jan 17 19:47:24 volumiocm5 volumio[1074]: info: Jan 17 19:47:24 volumiocm5 volumio[1074]: ---------------------------- MPD announces state update: update Jan 17 19:47:24 volumiocm5 volumio[1074]: info: sendMpdCommand rescan took 1 milliseconds Jan 17 19:47:24 volumiocm5 volumio[1074]: info: ControllerMpd::getState Jan 17 19:47:24 volumiocm5 volumio[1074]: verbose: ControllerMpd::sendMpdCommand status Jan 17 19:47:24 volumiocm5 volumio[1074]: info: sendMpdCommand status took 8 milliseconds Jan 17 19:47:24 volumiocm5 volumio[1074]: info: sendMpdCommand status took 7 milliseconds Jan 17 19:47:24 volumiocm5 volumio[1074]: verbose: ControllerMpd::parseState Jan 17 19:47:24 volumiocm5 volumio[1074]: info: Command Router : Notfying DB Updatetrue Jan 17 19:47:24 volumiocm5 volumio[1074]: verbose: ControllerMpd::parseState Jan 17 19:47:24 volumiocm5 volumio[1074]: info: ControllerMpd::pushState Jan 17 19:47:24 volumiocm5 volumio[1074]: info: CoreCommandRouter::servicePushState Jan 17 19:47:24 volumiocm5 volumio[1074]: info: CoreStateMachine::pushState Jan 17 19:47:24 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:47:24 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioPushState Jan 17 19:47:24 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output update for this device Jan 17 19:47:24 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output Jan 17 19:47:24 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:47:24 volumiocm5 volumio[1074]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 17 19:47:24 volumiocm5 volumio[1074]: verbose: CURRENT POSITION 0 Jan 17 19:47:24 volumiocm5 volumio[1074]: info: CoreStateMachine::syncState stateService stop Jan 17 19:47:24 volumiocm5 volumio[1074]: info: CoreStateMachine::syncState currentStatus stop Jan 17 19:47:24 volumiocm5 volumio[1074]: info: CoreStateMachine::pushState Jan 17 19:47:24 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:47:24 volumiocm5 volumio[1074]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 19:47:24 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioPushState Jan 17 19:47:24 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output update for this device Jan 17 19:47:24 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output Jan 17 19:47:24 volumiocm5 volumio[1074]: info: No code Jan 17 19:47:24 volumiocm5 volumio[1074]: info: CoreStateMachine::pushState Jan 17 19:47:24 volumiocm5 volumio[1074]: info: CorePlayQueue::getTrack 0 Jan 17 19:47:24 volumiocm5 volumio[1074]: info: CoreCommandRouter::volumioPushState Jan 17 19:47:24 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output update for this device Jan 17 19:47:24 volumiocm5 volumio[1074]: info: MRS: Pushing multiroomSync output Jan 17 19:47:24 volumiocm5 volumio[1074]: info: ------------------------------ 48ms Jan 17 19:47:26 volumiocm5 volumio[1074]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 19:47:26 volumiocm5 volumio[1074]: TypeError: Cannot read property 'replace' of undefined Jan 17 19:47:26 volumiocm5 volumio[1074]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Jan 17 19:47:26 volumiocm5 volumio[1074]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Jan 17 19:47:26 volumiocm5 volumio[1074]: at listOnTimeout (internal/timers.js:554:17) Jan 17 19:47:26 volumiocm5 volumio[1074]: at processTimers (internal/timers.js:497:7) Jan 17 19:47:26 volumiocm5 volumio[1074]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 19:47:26 volumiocm5 sudo[1669]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-17 19:46 Jan 17 19:47:26 volumiocm5 sudo[1669]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"