-- Logs begin at Thu 2019-02-14 04:11:59 CST, end at Sun 2024-07-28 13:29:49 CST. -- Jul 28 13:28:00 volumio wireless.js[485]: trying... Jul 28 13:28:00 volumio sudo[830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 28 13:28:00 volumio sudo[830]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:00 volumio sudo[830]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:00 volumio wireless.js[485]: Connected to: ----BaLoHome_5G Jul 28 13:28:00 volumio wireless.js[485]: ---- Jul 28 13:28:00 volumio sudo[833]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 28 13:28:00 volumio sudo[833]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:00 volumio sudo[833]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:00 volumio wireless.js[485]: ... joined AP, wlan0 IPv4 is 192.168.0.168, ipV6 is undefined Jul 28 13:28:00 volumio wireless.js[485]: It's done! AP Jul 28 13:28:00 volumio systemd[1]: Started Wireless Services. Jul 28 13:28:00 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jul 28 13:28:00 volumio systemd[1]: Started Volumio Backend Module. Jul 28 13:28:00 volumio systemd[1]: Started Volumio Cpu Tweaker. Jul 28 13:28:00 volumio volumio-cpu-tweak[839]: Setting RT Priority for mpd Jul 28 13:28:00 volumio volumio-cpu-tweak[839]: pid 35's current scheduling policy: SCHED_OTHER Jul 28 13:28:00 volumio volumio-cpu-tweak[839]: pid 35's current scheduling priority: 0 Jul 28 13:28:00 volumio volumio-cpu-tweak[839]: Setting MPD Affinity Jul 28 13:28:00 volumio volumio-cpu-tweak[839]: pid 3's current affinity mask: f Jul 28 13:28:00 volumio volumio-cpu-tweak[839]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Jul 28 13:28:00 volumio volumio-cpu-tweak[839]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jul 28 13:28:00 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Jul 28 13:28:00 volumio ntpd[656]: Listen normally on 3 wlan0 192.168.0.168:123 Jul 28 13:28:00 volumio ntpd[656]: new interface(s) found: waking up resolver Jul 28 13:28:02 volumio volumio[838]: info: ------------------------------------------- Jul 28 13:28:02 volumio volumio[838]: info: ----- Volumio3 ---- Jul 28 13:28:02 volumio volumio[838]: info: ------------------------------------------- Jul 28 13:28:02 volumio volumio[838]: info: ----- System startup ---- Jul 28 13:28:02 volumio volumio[838]: info: ------------------------------------------- Jul 28 13:28:02 volumio volumio[838]: info: MYVOLUMIO Environment detected Jul 28 13:28:02 volumio volumio[838]: info: Plugin folders cleanup Jul 28 13:28:02 volumio volumio[838]: info: Scanning into folder /volumio/app/plugins/ Jul 28 13:28:02 volumio volumio[838]: info: Scanning category audio_interface Jul 28 13:28:02 volumio volumio[838]: info: Scanning category miscellanea Jul 28 13:28:02 volumio volumio[838]: info: Scanning category music_service Jul 28 13:28:02 volumio volumio[838]: info: Scanning category plugins.json Jul 28 13:28:02 volumio volumio[838]: info: Scanning category system_controller Jul 28 13:28:02 volumio volumio[838]: info: Scanning category user_interface Jul 28 13:28:02 volumio volumio[838]: info: Scanning into folder /data/plugins/ Jul 28 13:28:02 volumio volumio[838]: info: Scanning category miscellanea Jul 28 13:28:02 volumio volumio[838]: info: Scanning category music_service Jul 28 13:28:02 volumio volumio[838]: info: Scanning category user_interface Jul 28 13:28:02 volumio volumio[838]: info: Plugin folders cleanup completed Jul 28 13:28:02 volumio volumio[838]: info: ------------------------------------------- Jul 28 13:28:02 volumio volumio[838]: info: ----- Core plugins startup ---- Jul 28 13:28:02 volumio volumio[838]: info: ------------------------------------------- Jul 28 13:28:02 volumio volumio[838]: info: Loading plugins from folder /volumio/app/plugins/ Jul 28 13:28:02 volumio volumio[838]: info: Adding plugin upnp to MyMusic Plugins Jul 28 13:28:02 volumio volumio[838]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 28 13:28:02 volumio volumio[838]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 28 13:28:02 volumio volumio[838]: info: Loading plugins from folder /data/plugins/ Jul 28 13:28:02 volumio volumio[838]: info: Loading plugin "system"... Jul 28 13:28:02 volumio volumio[838]: info: Loading plugin "appearance"... Jul 28 13:28:03 volumio nmbd[618]: [2024/07/28 13:28:03.594094, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jul 28 13:28:03 volumio nmbd[618]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jul 28 13:28:03 volumio systemd[1]: Started Samba NMB Daemon. Jul 28 13:28:03 volumio systemd[1]: Starting Samba Winbind Daemon... Jul 28 13:28:03 volumio volumio[838]: info: Loading plugin "network"... Jul 28 13:28:03 volumio volumio[838]: info: Refreshing Cached IP Addresses Jul 28 13:28:03 volumio sudo[868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 28 13:28:03 volumio sudo[868]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:03 volumio sudo[868]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:03 volumio volumio[838]: info: Loading plugin "services"... Jul 28 13:28:03 volumio sudo[870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 28 13:28:03 volumio volumio[838]: info: Loading plugin "alsa_controller"... Jul 28 13:28:03 volumio sudo[870]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:03 volumio sudo[870]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:03 volumio sudo[873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 28 13:28:03 volumio sudo[873]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:03 volumio winbindd[865]: [2024/07/28 13:28:03.917231, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jul 28 13:28:03 volumio winbindd[865]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jul 28 13:28:03 volumio winbindd[865]: [2024/07/28 13:28:03.939164, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jul 28 13:28:03 volumio winbindd[865]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jul 28 13:28:03 volumio systemd[1]: Started Samba Winbind Daemon. Jul 28 13:28:03 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 28 13:28:03 volumio volumio[838]: info: Loading plugin "wizard"... Jul 28 13:28:03 volumio volumio[838]: info: Loading plugin "networkfs"... Jul 28 13:28:03 volumio systemd[1]: Starting Samba SMB Daemon... Jul 28 13:28:04 volumio volumio[838]: info: Starting Udev Watcher for removable devices Jul 28 13:28:04 volumio sudo[891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=eball,password=2503Emma!,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.104/Music/FLACs /mnt/NAS/FLACS Jul 28 13:28:04 volumio sudo[891]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:04 volumio winbindd[865]: [2024/07/28 13:28:04.324390, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Jul 28 13:28:04 volumio winbindd[865]: res_names->count = 3, expected 4 Jul 28 13:28:04 volumio sudo[893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=eball,password=2503Emma!,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.104/Music/MP3 /mnt/NAS/MP3 Jul 28 13:28:04 volumio sudo[893]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:04 volumio smbd[883]: [2024/07/28 13:28:04.355894, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jul 28 13:28:04 volumio systemd[1]: Started Samba SMB Daemon. Jul 28 13:28:04 volumio smbd[883]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jul 28 13:28:04 volumio systemd[1]: Reached target Multi-User System. Jul 28 13:28:04 volumio systemd[1]: Reached target Graphical Interface. Jul 28 13:28:04 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jul 28 13:28:04 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jul 28 13:28:04 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jul 28 13:28:04 volumio systemd[1]: Startup finished in 9.374s (kernel) + 30.112s (userspace) = 39.486s. Jul 28 13:28:04 volumio kernel: Key type cifs.spnego registered Jul 28 13:28:04 volumio kernel: Key type cifs.idmap registered Jul 28 13:28:04 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Jul 28 13:28:04 volumio kernel: CIFS: Attempting to mount \\192.168.0.104\Music Jul 28 13:28:04 volumio volumio[838]: info: Ignoring mount for partition: boot Jul 28 13:28:04 volumio volumio[838]: info: Ignoring mount for partition: volumio Jul 28 13:28:04 volumio volumio[838]: info: Ignoring mount for partition: volumio_data Jul 28 13:28:04 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 28 13:28:04 volumio volumio[838]: info: Loading plugin "volumio_command_line_client"... Jul 28 13:28:04 volumio volumio[838]: info: Loading plugin "upnp"... Jul 28 13:28:04 volumio volumio[838]: info: [1722194884529] Starting Upmpd Daemon Jul 28 13:28:04 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 28 13:28:04 volumio volumio[838]: info: Loading plugin "my_music"... Jul 28 13:28:04 volumio volumio[838]: info: Loading plugin "mpd"... Jul 28 13:28:04 volumio volumio[838]: info: Loading plugin "upnp_browser"... Jul 28 13:28:05 volumio volumio-remote-updater[505]: [2024-07-28 13:28:05] [connect] Successful connection Jul 28 13:28:05 volumio volumio[838]: info: Loading plugin "alarm-clock"... Jul 28 13:28:05 volumio volumio[838]: info: Loading plugin "airplay_emulation"... Jul 28 13:28:05 volumio volumio[838]: info: Starting Shairport Sync Jul 28 13:28:05 volumio volumio[838]: info: Loading plugin "last_100"... Jul 28 13:28:05 volumio volumio[838]: info: Loading plugin "webradio"... Jul 28 13:28:05 volumio volumio[838]: info: Loading plugin "i2s_dacs"... Jul 28 13:28:05 volumio volumio[838]: info: Loading plugin "volumiodiscovery"... Jul 28 13:28:05 volumio volumio[838]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 28 13:28:05 volumio volumio[838]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 28 13:28:05 volumio node[838]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 28 13:28:05 volumio volumio[838]: *** WARNING *** For more information see Jul 28 13:28:05 volumio volumio[838]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 28 13:28:05 volumio volumio[838]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 28 13:28:05 volumio volumio[838]: *** WARNING *** For more information see Jul 28 13:28:05 volumio node[838]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 28 13:28:05 volumio node[838]: *** WARNING *** For more information see Jul 28 13:28:05 volumio node[838]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 28 13:28:05 volumio node[838]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 28 13:28:05 volumio node[838]: *** WARNING *** For more information see Jul 28 13:28:05 volumio volumio[838]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 28 13:28:05 volumio volumio[838]: info: Discovery: Started advertising with name: Volumio Jul 28 13:28:05 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 28 13:28:05 volumio volumio[838]: info: Loading plugin "ytmusic"... Jul 28 13:28:06 volumio sudo[893]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:06 volumio kernel: CIFS: Attempting to mount \\192.168.0.104\Music Jul 28 13:28:06 volumio volumio[838]: info: Loading plugin "now_playing"... Jul 28 13:28:06 volumio sudo[891]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:07 volumio volumio[838]: info: Loading plugin "outputs"... Jul 28 13:28:07 volumio volumio[838]: info: Loading plugin "albumart"... Jul 28 13:28:07 volumio volumio[838]: info: Plugin example_plugin is not enabled Jul 28 13:28:07 volumio volumio[838]: info: Loading plugin "inputs"... Jul 28 13:28:07 volumio volumio[838]: info: Loading plugin "updater_comm"... Jul 28 13:28:07 volumio volumio[838]: info: Plugin mpdemulation is not enabled Jul 28 13:28:07 volumio volumio[838]: info: Loading plugin "rest_api"... Jul 28 13:28:07 volumio volumio[838]: info: Loading plugin "websocket"... Jul 28 13:28:07 volumio volumio[838]: info: Loading plugin "onkyo_control"... Jul 28 13:28:07 volumio volumio[838]: Forking 3 albumart workers Jul 28 13:28:07 volumio sudo[873]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:08 volumio volumio[838]: Starting albumart workers Jul 28 13:28:08 volumio volumio[838]: Starting albumart workers Jul 28 13:28:08 volumio volumio[838]: Starting albumart workers Jul 28 13:28:08 volumio volumio[838]: info: Applying required configuration parameters for plugin onkyo_control Jul 28 13:28:08 volumio volumio[838]: info: Loading i18n strings for locale en Jul 28 13:28:08 volumio volumio[838]: Updating browse sources language Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::initPlayerControls Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 28 13:28:08 volumio volumio[838]: Express server listening on port 3000 Jul 28 13:28:08 volumio volumio[838]: [Metrics] WebUI: 7s 241.45ms Jul 28 13:28:08 volumio volumio[838]: info: CoreStateMachine::resetVolumioState Jul 28 13:28:08 volumio volumio[838]: info: CoreStateMachine::getcurrentVolume Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::volumioRetrievevolume Jul 28 13:28:08 volumio volumio-remote-updater[505]: [2024-07-28 13:28:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1722194885 101 Jul 28 13:28:08 volumio volumio[838]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Jul 28 13:28:08 volumio volumio[838]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 28 13:28:08 volumio volumio[838]: info: Executing start script for DAC IQaudIO DAC Plus Jul 28 13:28:08 volumio volumio[838]: info: Reloading queue from file Jul 28 13:28:08 volumio volumio[838]: info: VolumeController:: Volume=100 Mute =false Jul 28 13:28:08 volumio volumio[838]: info: CoreStateMachine::pushState Jul 28 13:28:08 volumio volumio[838]: info: CorePlayQueue::getTrack 0 Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::volumioPushState Jul 28 13:28:08 volumio volumio[838]: info: CoreStateMachine::updateTrackBlock Jul 28 13:28:08 volumio volumio[838]: info: CorePlayQueue::getTrackBlock Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::volumioRetrievevolume Jul 28 13:28:08 volumio volumio[838]: info: CoreStateMachine::setRepeat false single undefined Jul 28 13:28:08 volumio volumio[838]: info: CoreStateMachine::pushState Jul 28 13:28:08 volumio volumio[838]: info: CorePlayQueue::getTrack 0 Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::volumioPushState Jul 28 13:28:08 volumio volumio[838]: info: CoreStateMachine::setRandom false Jul 28 13:28:08 volumio volumio[838]: info: CoreStateMachine::pushState Jul 28 13:28:08 volumio volumio[838]: info: CorePlayQueue::getTrack 0 Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 28 13:28:08 volumio volumio[838]: info: CoreCommandRouter::volumioPushState Jul 28 13:28:08 volumio volumio[838]: info: Setting Device type: Raspberry PI Jul 28 13:28:08 volumio volumio[838]: info: DAC script executed Jul 28 13:28:08 volumio volumio[838]: info: Completed loading Core Plugins Jul 28 13:28:08 volumio volumio[838]: info: Preparing to generate the ALSA configuration file Jul 28 13:28:09 volumio volumio[838]: info: VolumeController:: Volume=100 Mute =false Jul 28 13:28:09 volumio volumio[838]: info: CoreStateMachine::pushState Jul 28 13:28:09 volumio volumio[838]: info: CorePlayQueue::getTrack 0 Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::volumioPushState Jul 28 13:28:09 volumio volumio[838]: info: Asound.conf file unchanged, so no further update is needed Jul 28 13:28:09 volumio volumio[838]: info: Output device has changed, restarting MPD Jul 28 13:28:09 volumio sudo[997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 28 13:28:09 volumio sudo[997]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:09 volumio volumio[838]: info: Output device has changed, restarting Shairport Sync Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 28 13:28:09 volumio sudo[997]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:09 volumio sudo[999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 28 13:28:09 volumio sudo[999]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:09 volumio volumio[838]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 28 13:28:09 volumio volumio[838]: info: ___________ START PLUGINS ___________ Jul 28 13:28:09 volumio volumio[838]: info: ControllerMpd::onStart: Initializing MPD Jul 28 13:28:09 volumio volumio[838]: info: Creating MPD Configuration file Jul 28 13:28:09 volumio sudo[1007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 28 13:28:09 volumio sudo[1007]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 28 13:28:09 volumio volumio[838]: info: [1722194889158] CoreMusicLibrary::Adding element Media Servers Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 28 13:28:09 volumio sudo[1007]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:09 volumio systemd[1]: Listening on mpd.socket. Jul 28 13:28:09 volumio systemd[1]: Starting Music Player Daemon... Jul 28 13:28:09 volumio sudo[1009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 28 13:28:09 volumio sudo[1009]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 28 13:28:09 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 28 13:28:09 volumio systemd[1]: mpd.service: Succeeded. Jul 28 13:28:09 volumio systemd[1]: Stopped Music Player Daemon. Jul 28 13:28:09 volumio systemd[1]: Starting Music Player Daemon... Jul 28 13:28:09 volumio volumio[838]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 28 13:28:09 volumio volumio[838]: info: [1722194889253] CoreMusicLibrary::Adding element Last_100 Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 28 13:28:09 volumio volumio[838]: info: [1722194889256] CoreMusicLibrary::Adding element Webradio Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 28 13:28:09 volumio sudo[1016]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 28 13:28:09 volumio sudo[1016]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:09 volumio sudo[1016]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 28 13:28:09 volumio volumio[838]: info: [1722194889267] CoreMusicLibrary::Adding element YouTube Music Jul 28 13:28:09 volumio sudo[1016]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 28 13:28:09 volumio volumio[838]: Cannot find translation for source YouTube Music Jul 28 13:28:09 volumio volumio[838]: info: [now-playing] ConfigUpdater: config is up to date. Jul 28 13:28:09 volumio volumio[838]: info: ONKYO-CONTROL: *********** ONKYO PLUGIN STARTED ******** Jul 28 13:28:09 volumio volumio[838]: info: Volumio Calling Home Jul 28 13:28:09 volumio volumio[838]: info: [now-playing] App is listening on port 4004. Jul 28 13:28:09 volumio volumio[838]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Jul 28 13:28:09 volumio volumio[838]: info: Discovery: adding b3abbee1-0c64-4c83-88c4-1fc4b148a488 Jul 28 13:28:09 volumio volumio[838]: info: Discovery: Found device Volumio Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::volumioGetState Jul 28 13:28:09 volumio volumio[838]: info: CorePlayQueue::getTrack 0 Jul 28 13:28:09 volumio volumio[838]: info: MPD Permissions set Jul 28 13:28:09 volumio volumio[838]: info: MPD Permissions set Jul 28 13:28:09 volumio volumio[838]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Jul 28 13:28:09 volumio volumio[838]: info: ONKYO-CONTROL: New state: {"status":"stop","position":0,"title":"","artist":"","album":"","albumart":"/albumart","duration":0,"uri":"","seek":0,"samplerate":"","channels":"","bitdepth":"","Streaming":false,"service":"mpd","volume":100,"dbVolume":null,"mute":false,"disableVolumeControl":false,"random":false,"repeat":false,"repeatSingle":false,"updatedb":false,"consume":false} connection: {"reconnect":false,"send_delay":5000,"verify_commands":false,"port":"60128","host":"192.168.0.178"} Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:09 volumio volumio[838]: info: Discovery: adding 6d15bbf5-f871-46ee-b51c-aeefd9b3d5cf Jul 28 13:28:09 volumio volumio[838]: info: Discovery: Found device Patio Jul 28 13:28:09 volumio volumio[838]: info: Discovery: Connecting to remote: 192.168.0.31 Jul 28 13:28:09 volumio volumio[838]: info: Starting Shairport Sync Jul 28 13:28:09 volumio volumio[838]: info: Starting Shairport Sync Jul 28 13:28:09 volumio sudo[1034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 28 13:28:09 volumio sudo[1034]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:09 volumio volumio[838]: info: Starting Shairport Sync Jul 28 13:28:09 volumio sudo[1036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 28 13:28:09 volumio sudo[1036]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:09 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 28 13:28:09 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 28 13:28:09 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 28 13:28:09 volumio sudo[1040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 28 13:28:09 volumio sudo[1040]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:09 volumio volumio[838]: info: Discovery: Connected to remote: 192.168.0.31 Jul 28 13:28:09 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 28 13:28:09 volumio sudo[1034]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:09 volumio volumio[838]: info: CoreCommandRouter::volumioGetState Jul 28 13:28:09 volumio volumio[838]: info: CorePlayQueue::getTrack 0 Jul 28 13:28:09 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 28 13:28:09 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 28 13:28:09 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 28 13:28:09 volumio volumio[838]: info: Shairport-Sync Started Jul 28 13:28:09 volumio volumio[838]: Error adding Membership: Error: addMembership EINVAL Jul 28 13:28:09 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 28 13:28:09 volumio volumio[838]: info: Volumio called home Jul 28 13:28:09 volumio sudo[1036]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:09 volumio sudo[1040]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:09 volumio volumio[838]: info: Shairport-Sync Started Jul 28 13:28:09 volumio volumio[838]: info: Shairport-Sync Started Jul 28 13:28:10 volumio sudo[1049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 28 13:28:10 volumio sudo[1049]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:10 volumio sudo[1051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 28 13:28:10 volumio sudo[1051]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:10 volumio sudo[1049]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:10 volumio sudo[1051]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:10 volumio systemd[1]: systemd-fsckd.service: Succeeded. Jul 28 13:28:10 volumio volumio[838]: verbose: New Socket.io Connection to 192.168.0.168 from 192.168.0.147 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.5 Mobile/15E148 Safari/604.1 Total Clients: 4 Jul 28 13:28:10 volumio sudo[1055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 28 13:28:10 volumio sudo[1055]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:10 volumio sudo[1055]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:10 volumio sudo[1057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 28 13:28:10 volumio mpd[1021]: Jul 28 13:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 28 13:28:10 volumio sudo[1057]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:10 volumio sudo[1057]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:10 volumio volumio[838]: verbose: New Socket.io Connection to 192.168.0.168 from 192.168.0.147 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.5 Mobile/15E148 Safari/604.1 Total Clients: 4 Jul 28 13:28:10 volumio volumio[838]: info: CoreCommandRouter::volumioGetState Jul 28 13:28:10 volumio volumio[838]: info: CorePlayQueue::getTrack 0 Jul 28 13:28:10 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 28 13:28:10 volumio volumio[838]: info: Listing playlists Jul 28 13:28:10 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 28 13:28:10 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 28 13:28:10 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 28 13:28:10 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 28 13:28:10 volumio systemd[1]: Started Music Player Daemon. Jul 28 13:28:10 volumio sudo[999]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:10 volumio sudo[1009]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:10 volumio volumio[838]: info: Completed starting Core Plugins Jul 28 13:28:10 volumio volumio[838]: info: ------------------------------------------- Jul 28 13:28:10 volumio volumio[838]: info: ----- MyVolumio plugins startup ---- Jul 28 13:28:10 volumio volumio[838]: info: ------------------------------------------- Jul 28 13:28:10 volumio volumio[838]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 28 13:28:10 volumio volumio[838]: error: MPD error: The expression evaluated to a falsy value: Jul 28 13:28:10 volumio volumio[838]: assert.ok(self.idling) Jul 28 13:28:10 volumio volumio[838]: error: The expression evaluated to a falsy value: Jul 28 13:28:10 volumio volumio[838]: assert.ok(self.idling) Jul 28 13:28:10 volumio volumio[838]: info: MPD running with PID1021 Jul 28 13:28:10 volumio volumio[838]: ,establishing connection Jul 28 13:28:10 volumio volumio[838]: error: MPD error: The expression evaluated to a falsy value: Jul 28 13:28:10 volumio volumio[838]: assert.ok(self.idling) Jul 28 13:28:10 volumio volumio[838]: error: The expression evaluated to a falsy value: Jul 28 13:28:10 volumio volumio[838]: assert.ok(self.idling) Jul 28 13:28:10 volumio volumio[838]: error: updateQueue error: null Jul 28 13:28:12 volumio sh[420]: timed out Jul 28 13:28:12 volumio dhcpcd[469]: timed out Jul 28 13:28:12 volumio sh[420]: dhcpcd exited Jul 28 13:28:12 volumio dhcpcd[469]: dhcpcd exited Jul 28 13:28:12 volumio sh[420]: ifup: failed to bring up eth0 Jul 28 13:28:12 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jul 28 13:28:12 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jul 28 13:28:12 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 28 13:28:13 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Jul 28 13:28:14 volumio volumio[838]: info: CoreCommandRouter::volumioGetVisibleSources Jul 28 13:28:14 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 28 13:28:14 volumio volumio[838]: info: CoreCommandRouter::volumioGetQueue Jul 28 13:28:14 volumio volumio[838]: info: CoreStateMachine::getQueue Jul 28 13:28:14 volumio volumio[838]: info: CorePlayQueue::getQueue Jul 28 13:28:14 volumio sudo[1068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 28 13:28:14 volumio sudo[1068]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:14 volumio sudo[1070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 28 13:28:14 volumio sudo[1068]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:14 volumio sudo[1070]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:14 volumio sudo[1070]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:14 volumio sudo[1074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 28 13:28:14 volumio sudo[1074]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:14 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jul 28 13:28:14 volumio sudo[1074]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:14 volumio volumio[838]: info: Upmpdcli Daemon Started Jul 28 13:28:14 volumio volumio[1076]: Generating RSA private key, 4096 bit long modulus (2 primes) Jul 28 13:28:15 volumio volumio[838]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 28 13:28:19 volumio volumio[838]: info: Adding plugin bluetooth to MyMusic Plugins Jul 28 13:28:19 volumio volumio[838]: info: Adding plugin multiroom to MyMusic Plugins Jul 28 13:28:19 volumio volumio[838]: info: Adding plugin metavolumio to MyMusic Plugins Jul 28 13:28:19 volumio volumio[838]: info: Adding plugin cd_controller to MyMusic Plugins Jul 28 13:28:19 volumio volumio[838]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 28 13:28:19 volumio volumio[838]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 28 13:28:19 volumio volumio[838]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 28 13:28:20 volumio volumio[1076]: ..........................................................++++ Jul 28 13:28:20 volumio volumio[838]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 28 13:28:20 volumio volumio[838]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 28 13:28:20 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 28 13:28:20 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 28 13:28:20 volumio volumio[838]: info: Starting MyVolumio Remote Streaming Endpoints Jul 28 13:28:20 volumio volumio[838]: info: MyVolumio login type: Token Jul 28 13:28:20 volumio volumio[838]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 28 13:28:20 volumio volumio[838]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 28 13:28:21 volumio volumio[838]: info: Starting Streaming Service Transparent Proxy Jul 28 13:28:21 volumio volumio[838]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 28 13:28:21 volumio volumio[838]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 28 13:28:21 volumio volumio[838]: info: Streaming services startup Jul 28 13:28:21 volumio volumio[838]: info: Starting Streaming Daemon Jul 28 13:28:21 volumio sudo[1099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 28 13:28:21 volumio sudo[1099]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 28 13:28:21 volumio volumio[838]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jul 28 13:28:21 volumio sudo[1099]: pam_unix(sudo:session): session closed for user root Jul 28 13:28:21 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: ytmusic , handleBrowseUri Jul 28 13:28:21 volumio volumio[838]: info: [ytmusic-browse] browseUri: ytmusic Jul 28 13:28:21 volumio volumio[838]: error: Cannot start Volumio Streaming Daemon Jul 28 13:28:21 volumio volumio[838]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 28 13:28:21 volumio volumio[838]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 28 13:28:21 volumio volumio[838]: info: Preload queue cleared Jul 28 13:28:21 volumio volumio[838]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 28 13:28:21 volumio volumio[838]: info: Retrying Login Due to Network Error Jul 28 13:28:21 volumio volumio[838]: STREAMING PROXY: Starting server on port 3245 Jul 28 13:28:21 volumio volumio[838]: Node JS runtime: 14 Jul 28 13:28:24 volumio volumio[1076]: ................................................++++ Jul 28 13:28:24 volumio volumio[1076]: e is 65537 (0x010001) Jul 28 13:28:24 volumio volumio[1076]: writing RSA key Jul 28 13:28:25 volumio volumio[838]: Searching plugin music_service/ytmusic Jul 28 13:28:25 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 28 13:28:25 volumio volumio[838]: info: [ytmusic] InnertubeLoader: creating Innertube instance... Jul 28 13:28:25 volumio volumio[838]: (node:838) UnhandledPromiseRejectionWarning: FetchError: request to https://www.youtube.com/sw.js_data failed, reason: certificate is not yet valid Jul 28 13:28:25 volumio volumio[838]: at ClientRequest. (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:8098:18) Jul 28 13:28:25 volumio volumio[838]: at ClientRequest.emit (events.js:315:20) Jul 28 13:28:25 volumio volumio[838]: at TLSSocket.socketErrorListener (_http_client.js:469:9) Jul 28 13:28:25 volumio volumio[838]: at TLSSocket.emit (events.js:315:20) Jul 28 13:28:25 volumio volumio[838]: at emitErrorNT (internal/streams/destroy.js:106:8) Jul 28 13:28:25 volumio volumio[838]: at emitErrorCloseNT (internal/streams/destroy.js:74:3) Jul 28 13:28:25 volumio volumio[838]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jul 28 13:28:25 volumio volumio[838]: (Use `node --trace-warnings ...` to show where the warning was created) Jul 28 13:28:25 volumio volumio[838]: (node:838) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 1) Jul 28 13:28:25 volumio volumio[838]: (node:838) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Jul 28 13:28:29 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 28 13:28:29 volumio volumio[838]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 28 13:28:29 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 28 13:28:29 volumio volumio[838]: info: Received Get System Version Jul 28 13:28:29 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 28 13:28:29 volumio volumio[838]: info: Received Get System Info Jul 28 13:28:29 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 28 13:28:29 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 28 13:28:29 volumio volumio[838]: info: Discovery: Getting this device information Jul 28 13:28:29 volumio volumio[838]: info: CoreCommandRouter::volumioGetState Jul 28 13:28:29 volumio volumio[838]: info: CorePlayQueue::getTrack 0 Jul 28 13:28:29 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 28 13:28:29 volumio volumio[838]: Searching plugin music_service/ytmusic Jul 28 13:28:29 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 28 13:28:29 volumio volumio[838]: verbose: New Socket.io Connection to 192.168.0.168:3000 from 192.168.0.31 UA: node-XMLHttpRequest Total Clients: 5 Jul 28 13:28:29 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jul 28 13:28:30 volumio volumio[838]: info: CoreCommandRouter::volumioGetState Jul 28 13:28:30 volumio volumio[838]: info: CorePlayQueue::getTrack 0 Jul 28 13:28:31 volumio volumio[838]: info: MyVolumio login type: Token Jul 28 13:28:31 volumio volumio[838]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 28 13:28:31 volumio volumio[838]: info: Retrying Login Due to Network Error Jul 28 13:28:31 volumio volumio[838]: Searching plugin music_service/ytmusic Jul 28 13:28:31 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 28 13:28:35 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 28 13:28:35 volumio volumio[838]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6 Jul 28 13:28:35 volumio volumio[838]: info: CoreCommandRouter::volumioGetState Jul 28 13:28:35 volumio volumio[838]: info: CorePlayQueue::getTrack 0 Jul 28 13:28:39 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 28 13:28:39 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 28 13:28:39 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 28 13:28:39 volumio volumio-remote-updater[505]: No test mode Jul 28 13:28:39 volumio volumio-remote-updater[505]: No alpha test mode Jul 28 13:28:39 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 28 13:28:39 volumio volumio[838]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

    • Improved translations
    • Fix for controlling Volumio device from another one
    • Fix for slow playback on RPi5 with HifiBerry DAC
    • Improved speed for default albumart
    • Fix for HifiBerry DAC detection
    • Fix for Supersearch bar on Iphone
    • Fix for Network connection on Wizard



NEW ADDITIONS

    • Facility for third party UIs

 

","title":"Update v3.742","updateavailable":true} Jul 28 13:28:40 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 28 13:28:40 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:40 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:40 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 28 13:28:40 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 28 13:28:40 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 28 13:28:40 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 28 13:28:40 volumio volumio[838]: info: CoreCommandRouter::volumioGetBrowseSources Jul 28 13:28:40 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 28 13:28:41 volumio volumio[838]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jul 28 13:28:41 volumio volumio[838]: info: Completed starting MyVolumio Plugin Jul 28 13:28:41 volumio volumio[838]: info: BOOT COMPLETED Jul 28 13:28:41 volumio volumio[838]: [Metrics] CommandRouter: 39s 150.18ms Jul 28 13:28:41 volumio volumio[838]: info: CoreCommandRouter::volumiosetStartupVolume Jul 28 13:28:41 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 28 13:28:41 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 28 13:28:41 volumio volumio[838]: info: CoreCommandRouter::Close All Modals sent Jul 28 13:28:41 volumio volumio[838]: info: CoreCommandRouter::Close All Modals sent Jul 28 13:28:41 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Jul 28 13:28:41 volumio volumio[838]: info: MyVolumio login type: Token Jul 28 13:28:41 volumio volumio[838]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 28 13:28:41 volumio volumio[838]: info: Retrying Login Due to Network Error Jul 28 13:28:42 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 28 13:28:42 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 28 13:28:42 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 28 13:28:50 volumio ntpd[656]: Soliciting pool server 186.177.18.74 Jul 28 13:28:51 volumio ntpd[656]: Soliciting pool server 186.177.18.74 Jul 28 13:28:51 volumio volumio[838]: info: MyVolumio login type: Token Jul 28 13:28:51 volumio volumio[838]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 28 13:28:51 volumio volumio[838]: info: Retrying Login Due to Network Error Jul 28 13:28:52 volumio ntpd[656]: Soliciting pool server 186.177.18.74 Jul 28 13:28:53 volumio ntpd[656]: Soliciting pool server 186.177.18.74 Jul 28 13:28:58 volumio volumio[838]: Searching plugin music_service/ytmusic Jul 28 13:28:58 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 28 13:29:01 volumio volumio[838]: info: MyVolumio login type: Token Jul 28 13:29:02 volumio volumio[838]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 28 13:29:02 volumio volumio[838]: info: Retrying Login Due to Network Error Jul 28 13:29:10 volumio volumio[838]: Searching plugin music_service/ytmusic Jul 28 13:29:10 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 28 13:29:12 volumio volumio[838]: info: MyVolumio login type: Token Jul 28 13:29:12 volumio volumio[838]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 28 13:29:12 volumio volumio[838]: info: Retrying Login Due to Network Error Jul 28 13:29:13 volumio volumio[838]: Searching plugin music_service/ytmusic Jul 28 13:29:13 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 28 13:29:22 volumio volumio[838]: info: MyVolumio login type: Token Jul 28 13:29:22 volumio volumio[838]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 28 13:29:22 volumio volumio[838]: info: Retrying Login Due to Network Error Jul 28 13:29:32 volumio volumio[838]: info: MyVolumio login type: Token Jul 28 13:29:32 volumio volumio[838]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 28 13:29:32 volumio volumio[838]: info: Retrying Login Due to Network Error Jul 28 13:29:35 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 28 13:29:35 volumio volumio[838]: info: CURURI: music-library Jul 28 13:29:35 volumio volumio[838]: info: Preload queue cleared Jul 28 13:29:36 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 28 13:29:36 volumio volumio[838]: info: CURURI: music-library/NAS Jul 28 13:29:37 volumio volumio[838]: info: Preload queue cleared Jul 28 13:29:37 volumio volumio[838]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 28 13:29:37 volumio volumio[838]: info: CURURI: music-library/NAS/FLACS Jul 28 13:29:37 volumio volumio[838]: info: Preload queue cleared Jul 28 13:29:37 volumio volumio[838]: info: Preloading song: music-library/NAS/FLACS/Feel This Moment - Pitbull ft. Christina Aguilera.flac Jul 28 13:29:37 volumio volumio[838]: info: Exploding uri music-library/NAS/FLACS/Feel This Moment - Pitbull ft. Christina Aguilera.flac in service mpd Jul 28 13:29:38 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Pitbull%20feat.%20Christina%20Aguilera/%5Bnon-album%20tracks%5D/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2FFeel%20This%20Moment%20-%20Pitbull%20ft.%20Christina%20Aguilera.flac&metadata=false Jul 28 13:29:38 volumio volumio[838]: info: URI /mnt/NAS/FLACS/Feel This Moment - Pitbull ft. Christina Aguilera.flac Jul 28 13:29:42 volumio volumio[838]: info: MyVolumio login type: Token Jul 28 13:29:43 volumio volumio[838]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 28 13:29:43 volumio volumio[838]: info: Retrying Login Due to Network Error Jul 28 13:29:48 volumio volumio[838]: info: Preload queue cleared Jul 28 13:29:48 volumio volumio[838]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 28 13:29:48 volumio volumio[838]: info: CoreStateMachine::ClearQueue Jul 28 13:29:48 volumio volumio[838]: info: CoreStateMachine::stop Jul 28 13:29:48 volumio volumio[838]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 28 13:29:48 volumio volumio[838]: info: CorePlayQueue::clearPlayQueue Jul 28 13:29:48 volumio volumio[838]: info: CorePlayQueue::saveQueue Jul 28 13:29:48 volumio volumio[838]: info: CoreCommandRouter::volumioPushQueue Jul 28 13:29:48 volumio volumio[838]: info: CoreStateMachine::addQueueItems Jul 28 13:29:48 volumio volumio[838]: info: CorePlayQueue::addQueueItems Jul 28 13:29:48 volumio volumio[838]: info: Preload queue cleared Jul 28 13:29:48 volumio volumio[838]: info: Adding Item to queue: music-library/NAS/FLACS/anna von hausswolff - ceremony FLAC Jul 28 13:29:48 volumio volumio[838]: info: Exploding uri music-library/NAS/FLACS/anna von hausswolff - ceremony FLAC in service mpd Jul 28 13:29:49 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Anna%20von%20Hausswolff/Ceremony/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2Fanna%20von%20hausswolff%20-%20ceremony%20FLAC%2F01%20Epitaph%20of%20Theodor.flac&metadata=false Jul 28 13:29:49 volumio volumio[838]: info: URI /mnt/NAS/FLACS/anna von hausswolff - ceremony FLAC/01 Epitaph of Theodor.flac Jul 28 13:29:49 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Anna%20von%20Hausswolff/Ceremony/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2Fanna%20von%20hausswolff%20-%20ceremony%20FLAC%2F02%20Deathbed.flac&metadata=false Jul 28 13:29:49 volumio volumio[838]: info: URI /mnt/NAS/FLACS/anna von hausswolff - ceremony FLAC/02 Deathbed.flac Jul 28 13:29:49 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Anna%20von%20Hausswolff/Ceremony/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2Fanna%20von%20hausswolff%20-%20ceremony%20FLAC%2F03%20Mountains%20Crave.flac&metadata=false Jul 28 13:29:49 volumio volumio[838]: info: URI /mnt/NAS/FLACS/anna von hausswolff - ceremony FLAC/03 Mountains Crave.flac Jul 28 13:29:49 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Anna%20von%20Hausswolff/Ceremony/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2Fanna%20von%20hausswolff%20-%20ceremony%20FLAC%2F04%20Goodbye.flac&metadata=false Jul 28 13:29:49 volumio volumio[838]: info: URI /mnt/NAS/FLACS/anna von hausswolff - ceremony FLAC/04 Goodbye.flac Jul 28 13:29:49 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Anna%20von%20Hausswolff/Ceremony/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2Fanna%20von%20hausswolff%20-%20ceremony%20FLAC%2F05%20Red%20Sun.flac&metadata=false Jul 28 13:29:49 volumio volumio[838]: info: URI /mnt/NAS/FLACS/anna von hausswolff - ceremony FLAC/05 Red Sun.flac Jul 28 13:29:49 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Anna%20von%20Hausswolff/Ceremony/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2Fanna%20von%20hausswolff%20-%20ceremony%20FLAC%2F06%20Epitaph%20of%20Daniel.flac&metadata=false Jul 28 13:29:49 volumio volumio[838]: info: URI /mnt/NAS/FLACS/anna von hausswolff - ceremony FLAC/06 Epitaph of Daniel.flac Jul 28 13:29:49 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Anna%20von%20Hausswolff/Ceremony/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2Fanna%20von%20hausswolff%20-%20ceremony%20FLAC%2F07%20No%20Body.flac&metadata=false Jul 28 13:29:49 volumio volumio[838]: info: URI /mnt/NAS/FLACS/anna von hausswolff - ceremony FLAC/07 No Body.flac Jul 28 13:29:49 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Anna%20von%20Hausswolff/Ceremony/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2Fanna%20von%20hausswolff%20-%20ceremony%20FLAC%2F08%20Liturgy%20of%20Light.flac&metadata=false Jul 28 13:29:49 volumio volumio[838]: info: URI /mnt/NAS/FLACS/anna von hausswolff - ceremony FLAC/08 Liturgy of Light.flac Jul 28 13:29:49 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Anna%20von%20Hausswolff/Ceremony/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2Fanna%20von%20hausswolff%20-%20ceremony%20FLAC%2F09%20Harmonica.flac&metadata=false Jul 28 13:29:49 volumio volumio[838]: info: URI /mnt/NAS/FLACS/anna von hausswolff - ceremony FLAC/09 Harmonica.flac Jul 28 13:29:49 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Anna%20von%20Hausswolff/Ceremony/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2Fanna%20von%20hausswolff%20-%20ceremony%20FLAC%2F10%20Ocean.flac&metadata=false Jul 28 13:29:49 volumio volumio[838]: info: URI /mnt/NAS/FLACS/anna von hausswolff - ceremony FLAC/10 Ocean.flac Jul 28 13:29:49 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Anna%20von%20Hausswolff/Ceremony/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2Fanna%20von%20hausswolff%20-%20ceremony%20FLAC%2F11%20Sova.flac&metadata=false Jul 28 13:29:49 volumio volumio[838]: info: URI /mnt/NAS/FLACS/anna von hausswolff - ceremony FLAC/11 Sova.flac Jul 28 13:29:49 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Anna%20von%20Hausswolff/Ceremony/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2Fanna%20von%20hausswolff%20-%20ceremony%20FLAC%2F12%20Funeral%20For%20My%20Future%20Children.flac&metadata=false Jul 28 13:29:49 volumio volumio[838]: info: URI /mnt/NAS/FLACS/anna von hausswolff - ceremony FLAC/12 Funeral For My Future Children.flac Jul 28 13:29:49 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Anna%20von%20Hausswolff/Ceremony/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2Fanna%20von%20hausswolff%20-%20ceremony%20FLAC%2F13%20Sun%20Rise.flac&metadata=false Jul 28 13:29:49 volumio volumio[838]: info: URI /mnt/NAS/FLACS/anna von hausswolff - ceremony FLAC/13 Sun Rise.flac Jul 28 13:29:49 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Anna%20von%20Hausswolff/Ceremony/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2Fanna%20von%20hausswolff%20-%20ceremony%20FLAC%2FCeremony.cue&metadata=false Jul 28 13:29:49 volumio volumio[838]: info: URI /mnt/NAS/FLACS/anna von hausswolff - ceremony FLAC/Ceremony.cue Jul 28 13:29:49 volumio volumio[838]: info: ALBUMART /albumart?cacheid=452&web=Anna%20von%20Hausswolff/Ceremony/extralarge&path=%2Fmnt%2FNAS%2FFLACS%2Fanna%20von%20hausswolff%20-%20ceremony%20FLAC%2FCeremony.cue&metadata=false Jul 28 13:29:49 volumio volumio[838]: info: URI /mnt/NAS/FLACS/anna von hausswolff - ceremony FLAC/Ceremony.cue Jul 28 13:29:49 volumio volumio[838]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 28 13:29:49 volumio volumio[838]: Error: Unable to resolve or reject the same promise twice Jul 28 13:29:49 volumio volumio[838]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jul 28 13:29:49 volumio volumio[838]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Jul 28 13:29:49 volumio volumio[838]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jul 28 13:29:49 volumio volumio[838]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jul 28 13:29:49 volumio volumio[838]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jul 28 13:29:49 volumio volumio[838]: at Socket.emit (events.js:315:20) Jul 28 13:29:49 volumio volumio[838]: at addChunk (internal/streams/readable.js:309:12) Jul 28 13:29:49 volumio volumio[838]: at readableAddChunk (internal/streams/readable.js:280:11) Jul 28 13:29:49 volumio volumio[838]: at Socket.Readable.push (internal/streams/readable.js:223:10) Jul 28 13:29:49 volumio volumio[838]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Jul 28 13:29:49 volumio volumio[838]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 28 13:29:49 volumio sudo[1138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-28 13:28 Jul 28 13:29:49 volumio sudo[1138]: 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="e5e6090399db628f1586eb4951e3592507f5fd38" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="50b5825b3acc4c58b5033699bcdbbd219d6a0836" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 19 Jan 2024 06:17:59 PM CET" VOLUMIO_VERSION="3.601" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="36b9da4b4411039910a860c6fa7331da"