-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2025-04-13 10:11:29 CEST. -- Apr 13 10:10:07 volumio-pk systemd-timedated[1105]: Changed local time to Sun Apr 13 10:10:07 2025 Apr 13 10:10:07 volumio-pk sudo[1103]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:07 volumio-pk volumio-time-update[707]: volumio-time-update-util: System time updated successfully. Apr 13 10:10:07 volumio-pk systemd[1]: Starting Daily apt download activities... Apr 13 10:10:07 volumio-pk systemd[1]: Starting Daily man-db regeneration... Apr 13 10:10:07 volumio-pk systemd[1]: Started Volumio Time Update Utility. Apr 13 10:10:07 volumio-pk ntpd[843]: Listen normally on 3 wlan0 10.0.1.91:123 Apr 13 10:10:07 volumio-pk ntpd[843]: new interface(s) found: waking up resolver Apr 13 10:10:08 volumio-pk nmbd[814]: [2025/04/13 10:10:08.050794, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 13 10:10:08 volumio-pk nmbd[814]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Apr 13 10:10:08 volumio-pk systemd[1]: Started Samba NMB Daemon. Apr 13 10:10:08 volumio-pk systemd[1]: Starting Samba Winbind Daemon... Apr 13 10:10:08 volumio-pk systemd[1]: man-db.service: Succeeded. Apr 13 10:10:08 volumio-pk systemd[1]: Started Daily man-db regeneration. Apr 13 10:10:08 volumio-pk winbindd[1141]: [2025/04/13 10:10:08.743532, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Apr 13 10:10:08 volumio-pk winbindd[1141]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Apr 13 10:10:08 volumio-pk volumio-remote-updater[728]: [2025-04-13 10:10:08] [connect] Successful connection Apr 13 10:10:09 volumio-pk kernel: hwmon hwmon1: Undervoltage detected! Apr 13 10:10:09 volumio-pk winbindd[1141]: [2025/04/13 10:10:09.087776, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 13 10:10:09 volumio-pk systemd[1]: Started Samba Winbind Daemon. Apr 13 10:10:09 volumio-pk winbindd[1141]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Apr 13 10:10:09 volumio-pk systemd[1]: Starting Samba SMB Daemon... Apr 13 10:10:12 volumio-pk volumio[1081]: info: ------------------------------------------- Apr 13 10:10:12 volumio-pk volumio[1081]: info: ----- Volumio3 ---- Apr 13 10:10:12 volumio-pk volumio[1081]: info: ------------------------------------------- Apr 13 10:10:12 volumio-pk volumio[1081]: info: ----- System startup ---- Apr 13 10:10:12 volumio-pk volumio[1081]: info: ------------------------------------------- Apr 13 10:10:12 volumio-pk systemd[1]: apt-daily.service: Succeeded. Apr 13 10:10:12 volumio-pk systemd[1]: Started Daily apt download activities. Apr 13 10:10:12 volumio-pk smbd[1147]: [2025/04/13 10:10:12.431847, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 13 10:10:12 volumio-pk smbd[1147]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 13 10:10:12 volumio-pk systemd[1]: Starting Daily apt upgrade and clean activities... Apr 13 10:10:12 volumio-pk systemd[1]: Started Samba SMB Daemon. Apr 13 10:10:12 volumio-pk systemd[1]: Reached target Multi-User System. Apr 13 10:10:12 volumio-pk systemd[1]: Reached target Graphical Interface. Apr 13 10:10:12 volumio-pk systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 13 10:10:12 volumio-pk systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 13 10:10:12 volumio-pk systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 13 10:10:13 volumio-pk volumio[1081]: info: MYVOLUMIO Environment detected Apr 13 10:10:13 volumio-pk volumio[1081]: info: Plugin folders cleanup Apr 13 10:10:13 volumio-pk volumio[1081]: info: Scanning into folder /volumio/app/plugins/ Apr 13 10:10:13 volumio-pk volumio[1081]: info: Scanning category audio_interface Apr 13 10:10:13 volumio-pk volumio[1081]: info: Scanning category miscellanea Apr 13 10:10:13 volumio-pk volumio[1081]: info: Scanning category music_service Apr 13 10:10:13 volumio-pk volumio[1081]: info: Scanning category plugins.json Apr 13 10:10:13 volumio-pk volumio[1081]: info: Scanning category system_controller Apr 13 10:10:13 volumio-pk volumio[1081]: info: Scanning category user_interface Apr 13 10:10:13 volumio-pk volumio[1081]: info: Scanning into folder /data/plugins/ Apr 13 10:10:13 volumio-pk volumio[1081]: info: Scanning category user_interface Apr 13 10:10:13 volumio-pk volumio[1081]: info: Plugin folders cleanup completed Apr 13 10:10:13 volumio-pk volumio[1081]: info: ------------------------------------------- Apr 13 10:10:13 volumio-pk volumio[1081]: info: ----- Core plugins startup ---- Apr 13 10:10:13 volumio-pk volumio[1081]: info: ------------------------------------------- Apr 13 10:10:13 volumio-pk volumio[1081]: info: Loading plugins from folder /volumio/app/plugins/ Apr 13 10:10:13 volumio-pk volumio[1081]: info: Adding plugin upnp to MyMusic Plugins Apr 13 10:10:13 volumio-pk volumio[1081]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 13 10:10:13 volumio-pk volumio[1081]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 13 10:10:13 volumio-pk volumio[1081]: info: Loading plugins from folder /data/plugins/ Apr 13 10:10:13 volumio-pk volumio[1081]: info: Loading plugin "system"... Apr 13 10:10:13 volumio-pk volumio[1081]: info: Loading plugin "appearance"... Apr 13 10:10:13 volumio-pk systemd[1]: apt-daily-upgrade.service: Succeeded. Apr 13 10:10:13 volumio-pk systemd[1]: Started Daily apt upgrade and clean activities. Apr 13 10:10:13 volumio-pk systemd[1]: Startup finished in 12.155s (kernel) + 31.322s (userspace) = 43.478s. Apr 13 10:10:14 volumio-pk volumio[1081]: info: Loading plugin "network"... Apr 13 10:10:14 volumio-pk volumio[1081]: info: Refreshing Cached IP Addresses Apr 13 10:10:14 volumio-pk sudo[1250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 13 10:10:14 volumio-pk sudo[1250]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:14 volumio-pk sudo[1250]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:14 volumio-pk sudo[1252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 13 10:10:14 volumio-pk sudo[1252]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:14 volumio-pk sudo[1252]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:14 volumio-pk volumio[1081]: info: Loading plugin "services"... Apr 13 10:10:14 volumio-pk volumio[1081]: info: Loading plugin "alsa_controller"... Apr 13 10:10:14 volumio-pk sudo[1261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 13 10:10:14 volumio-pk sudo[1261]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:14 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 13 10:10:14 volumio-pk volumio[1081]: info: Loading plugin "wizard"... Apr 13 10:10:14 volumio-pk volumio[1081]: info: Loading plugin "networkfs"... Apr 13 10:10:14 volumio-pk volumio[1081]: info: Starting Udev Watcher for removable devices Apr 13 10:10:14 volumio-pk volumio[1081]: info: Ignoring mount for partition: boot Apr 13 10:10:14 volumio-pk volumio[1081]: info: Ignoring mount for partition: volumio Apr 13 10:10:14 volumio-pk volumio[1081]: info: Ignoring mount for partition: volumio_data Apr 13 10:10:14 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 13 10:10:14 volumio-pk volumio[1081]: info: Loading plugin "volumio_command_line_client"... Apr 13 10:10:14 volumio-pk volumio[1081]: info: Loading plugin "upnp"... Apr 13 10:10:14 volumio-pk volumio[1081]: info: [1744531814801] Starting Upmpd Daemon Apr 13 10:10:14 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 13 10:10:14 volumio-pk volumio[1081]: info: Loading plugin "my_music"... Apr 13 10:10:14 volumio-pk volumio[1081]: info: Loading plugin "mpd"... Apr 13 10:10:15 volumio-pk systemd[1]: systemd-fsckd.service: Succeeded. Apr 13 10:10:15 volumio-pk volumio[1081]: info: Loading plugin "upnp_browser"... Apr 13 10:10:15 volumio-pk sh[613]: timed out Apr 13 10:10:15 volumio-pk dhcpcd[654]: timed out Apr 13 10:10:15 volumio-pk sh[613]: dhcpcd exited Apr 13 10:10:15 volumio-pk dhcpcd[654]: dhcpcd exited Apr 13 10:10:15 volumio-pk sh[613]: ifup: failed to bring up eth0 Apr 13 10:10:15 volumio-pk systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Apr 13 10:10:15 volumio-pk systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Apr 13 10:10:15 volumio-pk volumio[1081]: info: Loading plugin "alarm-clock"... Apr 13 10:10:16 volumio-pk volumio[1081]: info: Loading plugin "airplay_emulation"... Apr 13 10:10:16 volumio-pk volumio[1081]: info: Starting Shairport Sync Apr 13 10:10:16 volumio-pk volumio[1081]: info: Loading plugin "last_100"... Apr 13 10:10:16 volumio-pk volumio[1081]: info: Loading plugin "webradio"... Apr 13 10:10:16 volumio-pk volumio[1081]: info: Loading plugin "i2s_dacs"... Apr 13 10:10:17 volumio-pk systemd[1]: systemd-hostnamed.service: Succeeded. Apr 13 10:10:17 volumio-pk volumio[1081]: info: I2S DAC not set, start Auto-detection Apr 13 10:10:17 volumio-pk volumio[1081]: info: Loading plugin "volumiodiscovery"... Apr 13 10:10:17 volumio-pk volumio[1081]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 13 10:10:17 volumio-pk volumio[1081]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 13 10:10:17 volumio-pk volumio[1081]: *** WARNING *** For more information see Apr 13 10:10:17 volumio-pk node[1081]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 13 10:10:17 volumio-pk volumio[1081]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 13 10:10:17 volumio-pk volumio[1081]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 13 10:10:17 volumio-pk volumio[1081]: *** WARNING *** For more information see Apr 13 10:10:17 volumio-pk node[1081]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 13 10:10:17 volumio-pk node[1081]: *** WARNING *** For more information see Apr 13 10:10:17 volumio-pk node[1081]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 13 10:10:17 volumio-pk node[1081]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 13 10:10:17 volumio-pk node[1081]: *** WARNING *** For more information see Apr 13 10:10:17 volumio-pk volumio[1081]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 13 10:10:17 volumio-pk volumio[1081]: info: Discovery: Started advertising with name: Volumio-pk Apr 13 10:10:17 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 13 10:10:17 volumio-pk volumio[1081]: info: Loading plugin "outputs"... Apr 13 10:10:17 volumio-pk volumio[1081]: info: Loading plugin "albumart"... Apr 13 10:10:17 volumio-pk volumio[1081]: info: Plugin example_plugin is not enabled Apr 13 10:10:17 volumio-pk volumio[1081]: info: Loading plugin "inputs"... Apr 13 10:10:17 volumio-pk volumio[1081]: info: Loading plugin "updater_comm"... Apr 13 10:10:18 volumio-pk volumio[1081]: info: Plugin mpdemulation is not enabled Apr 13 10:10:18 volumio-pk volumio[1081]: info: Loading plugin "rest_api"... Apr 13 10:10:18 volumio-pk volumio[1081]: info: Loading plugin "websocket"... Apr 13 10:10:18 volumio-pk volumio[1081]: info: Starting Socket.io Server version 2.3.0 Apr 13 10:10:18 volumio-pk volumio[1081]: info: Plugin touch_display is not enabled Apr 13 10:10:18 volumio-pk volumio[1081]: Forking 3 albumart workers Apr 13 10:10:18 volumio-pk volumio[1081]: info: Loading i18n strings for locale en Apr 13 10:10:18 volumio-pk volumio[1081]: Updating browse sources language Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::initPlayerControls Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 10:10:18 volumio-pk volumio[1081]: Express server listening on port 3000 Apr 13 10:10:18 volumio-pk volumio[1081]: [Metrics] WebUI: 10s 419.35ms Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreStateMachine::resetVolumioState Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreStateMachine::getcurrentVolume Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioRetrievevolume Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:18 volumio-pk volumio[1081]: info: Cannot read play queue from file Apr 13 10:10:18 volumio-pk volumio[1081]: info: Volumio Network Manager: Network status updated: 2 Apr 13 10:10:18 volumio-pk sudo[1261]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:18 volumio-pk volumio[1081]: verbose: New Socket.io Connection to 10.0.1.91 from 10.0.1.28 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.3 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 1 Apr 13 10:10:18 volumio-pk volumio[1081]: verbose: New Socket.io Connection to 10.0.1.91 from 10.0.1.28 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.3 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 2 Apr 13 10:10:18 volumio-pk volumio[1081]: Starting albumart workers Apr 13 10:10:18 volumio-pk volumio[1081]: Starting albumart workers Apr 13 10:10:18 volumio-pk volumio[1081]: Starting albumart workers Apr 13 10:10:18 volumio-pk volumio[1081]: info: Setting Device type: Raspberry PI Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreStateMachine::setRepeat null single undefined Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreStateMachine::pushState Apr 13 10:10:18 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioPushState Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreStateMachine::setRandom null Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreStateMachine::pushState Apr 13 10:10:18 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioPushState Apr 13 10:10:18 volumio-pk volumio[1081]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Apr 13 10:10:18 volumio-pk volumio[1081]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115 Apr 13 10:10:18 volumio-pk volumio[1081]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Apr 13 10:10:18 volumio-pk volumio[1081]: info: VolumeController:: Volume=86 Mute =false Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreStateMachine::pushState Apr 13 10:10:18 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioPushState Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreStateMachine::updateTrackBlock Apr 13 10:10:18 volumio-pk volumio[1081]: info: CorePlayQueue::getTrackBlock Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioRetrievevolume Apr 13 10:10:18 volumio-pk volumio[1081]: info: Completed loading Core Plugins Apr 13 10:10:18 volumio-pk volumio[1081]: info: Preparing to generate the ALSA configuration file Apr 13 10:10:18 volumio-pk volumio[1081]: info: Discovery: adding dc9e099b-3af7-4b63-8fdf-f98baef06e60 Apr 13 10:10:18 volumio-pk volumio[1081]: info: Discovery: Found device Volumio-pk Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:18 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:18 volumio-pk volumio[1081]: info: Asound.conf file unchanged, so no further update is needed Apr 13 10:10:18 volumio-pk volumio[1081]: info: Output device has changed, restarting MPD Apr 13 10:10:18 volumio-pk volumio[1081]: info: Output device has changed, restarting Shairport Sync Apr 13 10:10:18 volumio-pk sudo[1324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 13 10:10:18 volumio-pk sudo[1324]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:18 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:18 volumio-pk sudo[1324]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:18 volumio-pk sudo[1326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 13 10:10:18 volumio-pk sudo[1326]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:18 volumio-pk systemd[1]: Stopping Music Player Daemon... Apr 13 10:10:18 volumio-pk volumio[1081]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 13 10:10:19 volumio-pk volumio[1081]: info: ___________ START PLUGINS ___________ Apr 13 10:10:19 volumio-pk volumio[1081]: info: ControllerMpd::onStart: Initializing MPD Apr 13 10:10:19 volumio-pk volumio[1081]: info: Creating MPD Configuration file Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 13 10:10:19 volumio-pk volumio[1081]: info: [1744531819056] CoreMusicLibrary::Adding element Media Servers Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 10:10:19 volumio-pk sudo[1335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 13 10:10:19 volumio-pk sudo[1335]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:19 volumio-pk systemd[1]: mpd.service: Succeeded. Apr 13 10:10:19 volumio-pk systemd[1]: Stopped Music Player Daemon. Apr 13 10:10:19 volumio-pk sudo[1333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 13 10:10:19 volumio-pk sudo[1333]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:19 volumio-pk systemd[1]: Starting Music Player Daemon... Apr 13 10:10:19 volumio-pk volumio[1081]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:19 volumio-pk sudo[1333]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:19 volumio-pk systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 13 10:10:19 volumio-pk systemd[1]: mpd.service: Succeeded. Apr 13 10:10:19 volumio-pk systemd[1]: Stopped Music Player Daemon. Apr 13 10:10:19 volumio-pk systemd[1]: Starting Music Player Daemon... Apr 13 10:10:19 volumio-pk volumio[1081]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 13 10:10:19 volumio-pk volumio[1081]: info: [1744531819214] CoreMusicLibrary::Adding element Last_100 Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 13 10:10:19 volumio-pk volumio[1081]: info: [1744531819222] CoreMusicLibrary::Adding element Webradio Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 13 10:10:19 volumio-pk volumio[1081]: info: Initializing BBC Radios Apr 13 10:10:19 volumio-pk sudo[1361]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 13 10:10:19 volumio-pk sudo[1361]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:19 volumio-pk sudo[1361]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: Volumio Calling Home Apr 13 10:10:19 volumio-pk volumio[1081]: info: MPD Permissions set Apr 13 10:10:19 volumio-pk volumio[1081]: info: MPD Permissions set Apr 13 10:10:19 volumio-pk volumio[1081]: info: VolumeController:: Volume=86 Mute =false Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreStateMachine::pushState Apr 13 10:10:19 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioPushState Apr 13 10:10:19 volumio-pk volumio[1081]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:19 volumio-pk volumio[1081]: info: Volumio called home Apr 13 10:10:19 volumio-pk volumio[1081]: info: Starting Shairport Sync Apr 13 10:10:19 volumio-pk volumio[1081]: info: Starting Shairport Sync Apr 13 10:10:19 volumio-pk volumio[1081]: info: Starting Shairport Sync Apr 13 10:10:19 volumio-pk sudo[1394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 13 10:10:19 volumio-pk sudo[1394]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:19 volumio-pk sudo[1396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 13 10:10:19 volumio-pk sudo[1396]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:19 volumio-pk sudo[1399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 13 10:10:19 volumio-pk systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 13 10:10:19 volumio-pk sudo[1399]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:19 volumio-pk systemd[1]: shairport-sync.service: Succeeded. Apr 13 10:10:19 volumio-pk systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 13 10:10:19 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:19 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:19 volumio-pk systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 13 10:10:19 volumio-pk sudo[1394]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:19 volumio-pk shairport-sync[1402]: free(): double free detected in tcache 2 Apr 13 10:10:19 volumio-pk systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 13 10:10:19 volumio-pk systemd[1]: shairport-sync.service: Main process exited, code=killed, status=6/ABRT Apr 13 10:10:19 volumio-pk systemd[1]: shairport-sync.service: Failed with result 'signal'. Apr 13 10:10:19 volumio-pk systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 13 10:10:19 volumio-pk systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 13 10:10:19 volumio-pk sudo[1399]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:19 volumio-pk systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 13 10:10:19 volumio-pk systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 13 10:10:19 volumio-pk systemd[1]: shairport-sync.service: Succeeded. Apr 13 10:10:19 volumio-pk systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 13 10:10:19 volumio-pk systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 13 10:10:19 volumio-pk sudo[1396]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:19 volumio-pk volumio[1081]: info: Shairport-Sync Started Apr 13 10:10:19 volumio-pk volumio[1081]: Error adding Membership: Error: addMembership EINVAL Apr 13 10:10:19 volumio-pk volumio[1081]: info: Shairport-Sync Started Apr 13 10:10:19 volumio-pk volumio[1081]: info: Shairport-Sync Started Apr 13 10:10:20 volumio-pk mpd[1381]: Apr 13 10:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 13 10:10:20 volumio-pk systemd[1]: Started Music Player Daemon. Apr 13 10:10:20 volumio-pk sudo[1335]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:20 volumio-pk sudo[1326]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:20 volumio-pk volumio[1081]: info: Completed starting Core Plugins Apr 13 10:10:20 volumio-pk volumio[1081]: info: ------------------------------------------- Apr 13 10:10:20 volumio-pk volumio[1081]: info: ----- MyVolumio plugins startup ---- Apr 13 10:10:20 volumio-pk volumio[1081]: info: ------------------------------------------- Apr 13 10:10:20 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 13 10:10:20 volumio-pk volumio[1081]: error: MPD error: The expression evaluated to a falsy value: Apr 13 10:10:20 volumio-pk volumio[1081]: assert.ok(self.idling) Apr 13 10:10:20 volumio-pk volumio[1081]: error: The expression evaluated to a falsy value: Apr 13 10:10:20 volumio-pk volumio[1081]: assert.ok(self.idling) Apr 13 10:10:20 volumio-pk volumio[1081]: error: updateQueue error: null Apr 13 10:10:20 volumio-pk volumio[1081]: info: MPD running with PID1381 Apr 13 10:10:20 volumio-pk volumio[1081]: ,establishing connection Apr 13 10:10:20 volumio-pk volumio[1081]: error: updateQueue error: null Apr 13 10:10:20 volumio-pk volumio[1081]: verbose: New Socket.io Connection to 10.0.1.91 from 10.0.1.28 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.3 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 4 Apr 13 10:10:20 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:20 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:21 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetVisibleSources Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 13 10:10:21 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:21 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: Listing playlists Apr 13 10:10:21 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:21 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetVisibleSources Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 13 10:10:21 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:21 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: Listing playlists Apr 13 10:10:21 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:21 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetVisibleSources Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 13 10:10:21 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:21 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: Listing playlists Apr 13 10:10:21 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:21 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:21 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:21 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:21 volumio-pk kernel: hwmon hwmon1: Voltage normalised Apr 13 10:10:23 volumio-pk volumio-remote-updater[728]: [2025-04-13 10:10:23] [connect] Successful connection Apr 13 10:10:24 volumio-pk volumio-remote-updater[728]: [2025-04-13 10:10:24] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1744531823 101 Apr 13 10:10:24 volumio-pk volumio[1081]: 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: 5 Apr 13 10:10:24 volumio-pk sudo[1429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 13 10:10:24 volumio-pk sudo[1429]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:24 volumio-pk sudo[1429]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:24 volumio-pk sudo[1431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 13 10:10:24 volumio-pk sudo[1431]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:24 volumio-pk sudo[1431]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:24 volumio-pk sudo[1435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 13 10:10:24 volumio-pk sudo[1435]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:24 volumio-pk systemd[1]: Started UPnP Renderer front-end to MPD. Apr 13 10:10:24 volumio-pk sudo[1435]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:24 volumio-pk volumio[1081]: info: Upmpdcli Daemon Started Apr 13 10:10:25 volumio-pk volumio[1437]: Generating RSA private key, 4096 bit long modulus (2 primes) Apr 13 10:10:25 volumio-pk volumio[1081]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 13 10:10:26 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 13 10:10:28 volumio-pk volumio[1081]: info: Adding plugin bluetooth to MyMusic Plugins Apr 13 10:10:28 volumio-pk volumio[1081]: info: Adding plugin multiroom to MyMusic Plugins Apr 13 10:10:28 volumio-pk volumio[1081]: info: Adding plugin metavolumio to MyMusic Plugins Apr 13 10:10:28 volumio-pk volumio[1081]: info: Adding plugin cd_controller to MyMusic Plugins Apr 13 10:10:28 volumio-pk volumio[1081]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 13 10:10:28 volumio-pk volumio[1081]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 13 10:10:28 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 13 10:10:29 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 13 10:10:29 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 13 10:10:29 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:29 volumio-pk volumio[1081]: info: Starting MyVolumio Remote Streaming Endpoints Apr 13 10:10:29 volumio-pk volumio[1081]: info: MyVolumio login type: Token Apr 13 10:10:29 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 13 10:10:29 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 13 10:10:30 volumio-pk volumio[1081]: info: Starting Streaming Service Transparent Proxy Apr 13 10:10:30 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 13 10:10:30 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 13 10:10:30 volumio-pk volumio[1081]: info: Streaming services startup Apr 13 10:10:30 volumio-pk volumio[1081]: info: Starting Streaming Daemon Apr 13 10:10:30 volumio-pk sudo[1463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 13 10:10:30 volumio-pk sudo[1463]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:30 volumio-pk sudo[1463]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:30 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 13 10:10:30 volumio-pk volumio[1081]: error: Cannot start Volumio Streaming Daemon Apr 13 10:10:30 volumio-pk volumio[1081]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 13 10:10:30 volumio-pk volumio[1081]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 13 10:10:30 volumio-pk volumio[1081]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 13 10:10:30 volumio-pk volumio[1081]: STREAMING PROXY: Starting server on port 3245 Apr 13 10:10:30 volumio-pk volumio[1081]: Node JS runtime: 14 Apr 13 10:10:31 volumio-pk volumio[1081]: info: MyVolumio token set successfully Apr 13 10:10:31 volumio-pk volumio[1081]: info: MYVOLUMIO: Adding device Apr 13 10:10:31 volumio-pk volumio[1081]: info: MYVOLUMIO: Evaluating Server Apr 13 10:10:31 volumio-pk volumio[1081]: info: MyVolumio Plan changed: premium Apr 13 10:10:31 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Apr 13 10:10:31 volumio-pk volumio[1081]: info: Removing browser output: myVolumio user plan is not superstar Apr 13 10:10:31 volumio-pk volumio[1081]: info: Removing audio output: Apr 13 10:10:31 volumio-pk volumio[1081]: info: MYVOLUMIO: Adding device Apr 13 10:10:31 volumio-pk volumio[1081]: info: MYVOLUMIO: Evaluating Server Apr 13 10:10:31 volumio-pk sudo[1488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 13 10:10:31 volumio-pk sudo[1488]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:31 volumio-pk volumio[1081]: info: Remote config written successfully Apr 13 10:10:31 volumio-pk volumio[1081]: info: Starting Tunnel 1 Apr 13 10:10:31 volumio-pk volumio[1081]: info: Starting Tunnel Connection Checker Apr 13 10:10:31 volumio-pk sudo[1488]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:31 volumio-pk volumio[1081]: info: Completed starting MyVolumio Plugin Apr 13 10:10:31 volumio-pk sudo[1490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 13 10:10:31 volumio-pk sudo[1490]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:31 volumio-pk sudo[1490]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:31 volumio-pk volumio[1081]: verbose: New Socket.io Connection to 10.0.1.91 from 10.0.1.28 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.3 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 6 Apr 13 10:10:31 volumio-pk sudo[1494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 13 10:10:31 volumio-pk sudo[1494]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:31 volumio-pk sudo[1494]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:31 volumio-pk sudo[1496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 13 10:10:31 volumio-pk sudo[1496]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:31 volumio-pk sudo[1496]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:32 volumio-pk volumio[1437]: .............................................................................++++ Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:32 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:32 volumio-pk volumio[1081]: info: MYVolumio Device enabled Apr 13 10:10:32 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Apr 13 10:10:32 volumio-pk volumio[1081]: info: MyVolumio status changed Apr 13 10:10:32 volumio-pk volumio[1081]: info: Streaming services startup Apr 13 10:10:32 volumio-pk volumio[1081]: info: Starting Streaming Daemon Apr 13 10:10:32 volumio-pk sudo[1515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 13 10:10:32 volumio-pk sudo[1515]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:32 volumio-pk volumio[1081]: info: Setting Geolocation for MyVolumio to eu6 Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:32 volumio-pk sudo[1515]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:32 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:32 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:32 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:32 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:32 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:32 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:32 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:32 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetVisibleSources Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:32 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:32 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 13 10:10:32 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:32 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:32 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:32 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:32 volumio-pk volumio[1081]: info: Listing playlists Apr 13 10:10:32 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:32 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:32 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:32 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:32 volumio-pk volumio[1081]: error: Cannot start Volumio Streaming Daemon Apr 13 10:10:32 volumio-pk volumio[1081]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 13 10:10:32 volumio-pk volumio[1081]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 13 10:10:32 volumio-pk volumio[1081]: verbose: New Socket.io Connection to 10.0.1.91 from 10.0.1.28 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.3 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 6 Apr 13 10:10:32 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Apr 13 10:10:32 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Apr 13 10:10:32 volumio-pk volumio[1081]: info: [1744531832488] Starting BluetoothController Apr 13 10:10:32 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Apr 13 10:10:33 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Apr 13 10:10:33 volumio-pk sudo[1518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Apr 13 10:10:33 volumio-pk sudo[1518]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:33 volumio-pk sudo[1518]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:33 volumio-pk volumio[1081]: info: MRS: MultiRoom plugin initialized Apr 13 10:10:33 volumio-pk volumio[1081]: info: MRS: STOPPING SNAPCLIENT Apr 13 10:10:33 volumio-pk volumio[1081]: info: MRS: Snap server stop Apr 13 10:10:33 volumio-pk sudo[1534]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Apr 13 10:10:33 volumio-pk sudo[1534]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:33 volumio-pk volumio[1081]: info: MRS: STOPPING volumioStreaming Apr 13 10:10:33 volumio-pk sudo[1537]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Apr 13 10:10:33 volumio-pk sudo[1537]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:33 volumio-pk sudo[1534]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:33 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Apr 13 10:10:33 volumio-pk sudo[1537]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:33 volumio-pk sudo[1542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Apr 13 10:10:33 volumio-pk sudo[1542]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:33 volumio-pk sudo[1542]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:33 volumio-pk sudo[1540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Apr 13 10:10:33 volumio-pk sudo[1540]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:33 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Apr 13 10:10:33 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Apr 13 10:10:33 volumio-pk sudo[1540]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:33 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Apr 13 10:10:33 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Apr 13 10:10:33 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Apr 13 10:10:33 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Apr 13 10:10:33 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Apr 13 10:10:33 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Apr 13 10:10:33 volumio-pk volumio[1081]: info: Preparing to generate the ALSA configuration file Apr 13 10:10:33 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 13 10:10:33 volumio-pk volumio[1081]: info: Updating MyVolumio device info Apr 13 10:10:33 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:33 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:33 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:34 volumio-pk volumio[1081]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 13 10:10:34 volumio-pk volumio[1081]: info: Reading ALSA contributions from plugins. Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:34 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:34 volumio-pk volumio[1081]: info: Setting Geolocation for MyVolumio to eu7 Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:34 volumio-pk volumio[1081]: info: MRS: Removed streaming files Apr 13 10:10:34 volumio-pk volumio[1081]: info: MRS: volumioStreaming STOPPED Apr 13 10:10:34 volumio-pk volumio[1081]: info: MRS: SNAPSERVER STOPPED Apr 13 10:10:34 volumio-pk volumio[1081]: info: MRS: SNAPCLIENT STOPPED Apr 13 10:10:34 volumio-pk volumio[1081]: error: Cannot delete local playlist /data/playlist/Pink Floyd : Error: ENOENT: no such file or directory, unlink '/data/playlist/Pink Floyd' Apr 13 10:10:34 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:34 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:34 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:34 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:34 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:34 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:34 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:34 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetVisibleSources Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:34 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:34 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 13 10:10:34 volumio-pk volumio[1081]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 13 10:10:34 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:34 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:34 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:34 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:34 volumio-pk volumio[1081]: info: Listing playlists Apr 13 10:10:34 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:34 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:34 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:34 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:34 volumio-pk volumio[1081]: info: Asound.conf file written Apr 13 10:10:34 volumio-pk sudo[1546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 13 10:10:34 volumio-pk sudo[1546]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:34 volumio-pk sudo[1546]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:34 volumio-pk volumio[1081]: No state is present for card vc4hdmi0 Apr 13 10:10:34 volumio-pk volumio[1081]: Found hardware: "vc4-hdmi" "" "" "" "" Apr 13 10:10:34 volumio-pk volumio[1081]: Hardware is initialized using a generic method Apr 13 10:10:34 volumio-pk volumio[1081]: No state is present for card vc4hdmi0 Apr 13 10:10:34 volumio-pk volumio[1081]: No state is present for card vc4hdmi1 Apr 13 10:10:34 volumio-pk volumio[1081]: Found hardware: "vc4-hdmi" "" "" "" "" Apr 13 10:10:34 volumio-pk volumio[1081]: Hardware is initialized using a generic method Apr 13 10:10:34 volumio-pk volumio[1081]: No state is present for card vc4hdmi1 Apr 13 10:10:34 volumio-pk volumio[1081]: info: Output device has changed, restarting MPD Apr 13 10:10:34 volumio-pk sudo[1551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 13 10:10:34 volumio-pk sudo[1551]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:34 volumio-pk volumio[1081]: info: Output device has changed, restarting Shairport Sync Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:34 volumio-pk sudo[1551]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:34 volumio-pk sudo[1553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 13 10:10:34 volumio-pk sudo[1553]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:34 volumio-pk systemd[1]: Stopping Music Player Daemon... Apr 13 10:10:34 volumio-pk volumio[1081]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 13 10:10:34 volumio-pk volumio[1081]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:34 volumio-pk systemd[1]: mpd.service: Succeeded. Apr 13 10:10:34 volumio-pk systemd[1]: Stopped Music Player Daemon. Apr 13 10:10:34 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 13 10:10:34 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Apr 13 10:10:34 volumio-pk volumio[1081]: info: MRS: Pushing multiroomSync output for this device Apr 13 10:10:34 volumio-pk volumio[1081]: info: MRS: Pushing multiroomSync output Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding audio output: Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding audio output: Apr 13 10:10:34 volumio-pk sudo[1563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio-pk Apr 13 10:10:34 volumio-pk sudo[1563]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:34 volumio-pk systemd[1]: Starting Music Player Daemon... Apr 13 10:10:34 volumio-pk volumio[1081]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:34 volumio-pk sudo[1563]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:34 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding METAVOLUMIO REST API Endpoints Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Apr 13 10:10:34 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Apr 13 10:10:34 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Apr 13 10:10:34 volumio-pk volumio[1081]: info: Preparing CD Folders Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding CD REST API Endpoints Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Apr 13 10:10:34 volumio-pk volumio[1081]: info: Starting UDEV Watcher for CD Apr 13 10:10:34 volumio-pk volumio[1081]: info: Detecting CD presence with UDEV Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Apr 13 10:10:34 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding inputs REST Endpoints Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Apr 13 10:10:34 volumio-pk volumio[1081]: info: Scanning Audio Inputs Apr 13 10:10:34 volumio-pk sudo[1560]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 13 10:10:34 volumio-pk sudo[1560]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:34 volumio-pk sudo[1560]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:34 volumio-pk volumio[1081]: info: Checking against Known Cards name Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding Server instance for streaming Apr 13 10:10:34 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Apr 13 10:10:34 volumio-pk volumio[1081]: error: Hi Res Audio Failed Login: Missing Login Data Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding HIGHRESAUDIO REST API Endpoints Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Apr 13 10:10:34 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Apr 13 10:10:34 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Apr 13 10:10:34 volumio-pk volumio[1081]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Apr 13 10:10:34 volumio-pk volumio[1081]: info: Stopping AccessToken refresher cron Apr 13 10:10:34 volumio-pk sudo[1573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 13 10:10:34 volumio-pk sudo[1573]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:34 volumio-pk volumio[1081]: info: AccessToken refresher cron started Apr 13 10:10:34 volumio-pk volumio[1081]: info: Stopping AccessToken refresher cron for QOBUZ Apr 13 10:10:34 volumio-pk sudo[1573]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:34 volumio-pk volumio[1081]: info: AccessToken refresher cron started for QOBUZ Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding TIDAL REST API Endpoints Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding QOBUZ REST API Endpoints Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 10:10:34 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:34 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:34 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:34 volumio-pk volumio[1081]: info: Successfully Added MyVolumio device Apr 13 10:10:34 volumio-pk volumio[1081]: info: Successfully Added MyVolumio device Apr 13 10:10:34 volumio-pk volumio[1081]: info: Successfully Updated MyVolumio device Apr 13 10:10:34 volumio-pk volumio[1081]: info: Bluetooth name changed to Volumio-pk Apr 13 10:10:34 volumio-pk volumio[1081]: info: MPD Permissions set Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:34 volumio-pk volumio[1081]: info: Starting Shairport Sync Apr 13 10:10:34 volumio-pk sudo[1595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 13 10:10:34 volumio-pk sudo[1595]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:34 volumio-pk systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 13 10:10:34 volumio-pk systemd[1]: shairport-sync.service: Succeeded. Apr 13 10:10:34 volumio-pk systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 13 10:10:34 volumio-pk volumio[1081]: info: MRS: Found cast device: TPM171E-712ec097ddb16f470e0f4ca989285f5e Apr 13 10:10:34 volumio-pk volumio[1081]: info: Adding audio output: Apr 13 10:10:34 volumio-pk systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 13 10:10:34 volumio-pk sudo[1595]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:34 volumio-pk volumio[1081]: info: Shairport-Sync Started Apr 13 10:10:34 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 13 10:10:35 volumio-pk volumio[1081]: info: Updating MyVolumio device info Apr 13 10:10:35 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:35 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:35 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:35 volumio-pk mpd[1571]: Apr 13 10:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 13 10:10:35 volumio-pk systemd[1]: Started Music Player Daemon. Apr 13 10:10:35 volumio-pk sudo[1553]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:35 volumio-pk volumio[1081]: error: updateQueue error: null Apr 13 10:10:35 volumio-pk volumio[1081]: info: Successfully Updated MyVolumio device Apr 13 10:10:36 volumio-pk sudo[1608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Apr 13 10:10:36 volumio-pk sudo[1608]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:36 volumio-pk systemd[1]: Started MyVolumio SSH Tunnel. Apr 13 10:10:36 volumio-pk sudo[1608]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:36 volumio-pk volumio[1081]: info: Remote SSH Started Apr 13 10:10:36 volumio-pk autossh[1611]: port set to 0, monitoring disabled Apr 13 10:10:36 volumio-pk autossh[1611]: starting ssh (count 1) Apr 13 10:10:36 volumio-pk autossh[1611]: ssh child pid is 1614 Apr 13 10:10:37 volumio-pk systemd[1]: systemd-timedated.service: Succeeded. Apr 13 10:10:37 volumio-pk volumio[1081]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:37 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:37 volumio-pk volumiossh-tunnel[1610]: Warning: Permanently added '[eu7.myvolumio.org]:2222,[167.71.43.69]:2222' (RSA) to the list of known hosts. Apr 13 10:10:37 volumio-pk sudo[1618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Apr 13 10:10:37 volumio-pk sudo[1618]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:37 volumio-pk systemd[1]: Started Volumio Bluetooth Module. Apr 13 10:10:37 volumio-pk sudo[1618]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:37 volumio-pk volumio[1081]: info: Volumio BT Module successfully started Apr 13 10:10:37 volumio-pk sudo[1621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Apr 13 10:10:37 volumio-pk sudo[1621]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:37 volumio-pk volumiobt[1620]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Apr 13 10:10:37 volumio-pk sudo[1621]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:37 volumio-pk volumio[1081]: info: TidalConnect service stoped! Apr 13 10:10:37 volumio-pk volumio[1081]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 13 10:10:37 volumio-pk volumio[1081]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 13 10:10:37 volumio-pk sudo[1633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 13 10:10:37 volumio-pk sudo[1633]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:37 volumio-pk systemd[1]: Started Volumio Tidal Connect Service. Apr 13 10:10:37 volumio-pk sudo[1633]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:37 volumio-pk volumio[1081]: info: Executing endpoint tc_getconfig Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 13 10:10:37 volumio-pk vtcs[1635]: STARTING TidalConnect services, version: 1.5.0.45 Apr 13 10:10:37 volumio-pk vtcs[1635]: STARTED TidalConnect services. Apr 13 10:10:37 volumio-pk volumio[1081]: info: Executing endpoint tc_connect Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 13 10:10:37 volumio-pk volumio[1081]: info: Connecting to TidalConnect Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreCommandRouter::servicePushState Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreStateMachine::pushState Apr 13 10:10:37 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioPushState Apr 13 10:10:37 volumio-pk volumio[1081]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:10:37 volumio-pk volumio[1081]: info: MRS: Pushing multiroomSync output Apr 13 10:10:37 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:37 volumio-pk volumio[1081]: 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} Apr 13 10:10:37 volumio-pk volumio[1081]: verbose: CURRENT POSITION 0 Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreStateMachine::syncState stateService stop Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreStateMachine::pushState Apr 13 10:10:37 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioPushState Apr 13 10:10:37 volumio-pk volumio[1081]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:10:37 volumio-pk volumio[1081]: info: MRS: Pushing multiroomSync output Apr 13 10:10:37 volumio-pk volumio[1081]: info: No code Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreStateMachine::pushState Apr 13 10:10:37 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioPushState Apr 13 10:10:37 volumio-pk volumio[1081]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:10:37 volumio-pk volumio[1081]: info: MRS: Pushing multiroomSync output Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreCommandRouter::servicePushState Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreStateMachine::pushState Apr 13 10:10:37 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioPushState Apr 13 10:10:37 volumio-pk volumio[1081]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:10:37 volumio-pk volumio[1081]: info: MRS: Pushing multiroomSync output Apr 13 10:10:37 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:37 volumio-pk volumio[1081]: 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} Apr 13 10:10:37 volumio-pk volumio[1081]: verbose: CURRENT POSITION 0 Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreStateMachine::syncState stateService stop Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreStateMachine::syncState currentStatus stop Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreStateMachine::pushState Apr 13 10:10:37 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioPushState Apr 13 10:10:37 volumio-pk volumio[1081]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:10:37 volumio-pk volumio[1081]: info: MRS: Pushing multiroomSync output Apr 13 10:10:37 volumio-pk volumio[1081]: info: No code Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreStateMachine::pushState Apr 13 10:10:37 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:37 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioPushState Apr 13 10:10:37 volumio-pk volumio[1081]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:10:37 volumio-pk volumio[1081]: info: MRS: Pushing multiroomSync output Apr 13 10:10:38 volumio-pk volumio[1437]: ...................................................................++++ Apr 13 10:10:38 volumio-pk volumio[1437]: e is 65537 (0x010001) Apr 13 10:10:38 volumio-pk volumio[1437]: writing RSA key Apr 13 10:10:38 volumio-pk sudo[1670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Apr 13 10:10:38 volumio-pk sudo[1670]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:38 volumio-pk volumiobt[1620]: pulseaudio: no process found Apr 13 10:10:38 volumio-pk sudo[1670]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:38 volumio-pk dbus-daemon[711]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.22' (uid=1000 pid=1674 comm="/usr/bin/pulseaudio --high-priority=true ") Apr 13 10:10:38 volumio-pk systemd[1]: Starting RealtimeKit Scheduling Policy Service... Apr 13 10:10:38 volumio-pk volumio[1081]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 10:10:38 volumio-pk dbus-daemon[711]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Apr 13 10:10:38 volumio-pk systemd[1]: Started RealtimeKit Scheduling Policy Service. Apr 13 10:10:38 volumio-pk rtkit-daemon[1675]: Successfully called chroot. Apr 13 10:10:38 volumio-pk rtkit-daemon[1675]: Successfully dropped privileges. Apr 13 10:10:38 volumio-pk rtkit-daemon[1675]: Successfully limited resources. Apr 13 10:10:38 volumio-pk rtkit-daemon[1675]: Running. Apr 13 10:10:38 volumio-pk rtkit-daemon[1675]: Canary thread running. Apr 13 10:10:38 volumio-pk rtkit-daemon[1675]: Watchdog thread running. Apr 13 10:10:38 volumio-pk dbus-daemon[711]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.23' (uid=0 pid=1675 comm="/usr/lib/rtkit/rtkit-daemon ") Apr 13 10:10:38 volumio-pk systemd[1]: Starting Authorization Manager... Apr 13 10:10:38 volumio-pk volumio[1081]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 10:10:38 volumio-pk polkitd[1679]: started daemon version 0.105 using authority implementation `local' version `0.105' Apr 13 10:10:38 volumio-pk dbus-daemon[711]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Apr 13 10:10:38 volumio-pk systemd[1]: Started Authorization Manager. Apr 13 10:10:38 volumio-pk pulseaudio[1674]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 13 10:10:38 volumio-pk pulseaudio[1674]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 13 10:10:38 volumio-pk volumiobt[1620]: Applying permissions Apr 13 10:10:38 volumio-pk volumiobt[1620]: Setting BT discoverable and pairable Apr 13 10:10:38 volumio-pk bluetoothd[822]: Endpoint registered: sender=:1.43 path=/MediaEndpoint/A2DPSource Apr 13 10:10:38 volumio-pk bluetoothd[822]: Endpoint registered: sender=:1.43 path=/MediaEndpoint/A2DPSink Apr 13 10:10:38 volumio-pk pulseaudio[1674]: 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 Apr 13 10:10:38 volumio-pk volumiobt[1620]: [CHG] Controller D8:3A:DD:03:D1:66 UUIDs: 00001112-0000-1000-8000-00805f9b34fb Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [91B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [55B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [117B blob data] Apr 13 10:10:38 volumio-pk volumiobt[1620]: [bluetooth]# -e power on Apr 13 10:10:38 volumio-pk volumiobt[1620]: Invalid command in menu main: -e Apr 13 10:10:38 volumio-pk volumiobt[1620]: Apr 13 10:10:38 volumio-pk volumiobt[1620]: Use "help" for a list of available commands in a menu. Apr 13 10:10:38 volumio-pk volumiobt[1620]: Use "menu " if you want to enter any submenu. Apr 13 10:10:38 volumio-pk volumiobt[1620]: Use "back" if you want to return to menu main. Apr 13 10:10:38 volumio-pk volumiobt[1620]: [bluetooth]# agent on Apr 13 10:10:38 volumio-pk volumiobt[1620]: Agent is already registered Apr 13 10:10:38 volumio-pk volumiobt[1620]: [bluetooth]# discoverable on Apr 13 10:10:38 volumio-pk volumiobt[1620]: [bluetooth]# pairable on Apr 13 10:10:38 volumio-pk volumiobt[1620]: [bluetooth]# agent NoInputNoOutput Apr 13 10:10:38 volumio-pk volumiobt[1620]: Agent is already registered Apr 13 10:10:38 volumio-pk volumiobt[1620]: [bluetooth]# default-agent Apr 13 10:10:38 volumio-pk kernel: Bluetooth: RFCOMM TTY layer initialized Apr 13 10:10:38 volumio-pk kernel: Bluetooth: RFCOMM socket layer initialized Apr 13 10:10:38 volumio-pk kernel: Bluetooth: RFCOMM ver 1.11 Apr 13 10:10:38 volumio-pk volumiobt[1620]: [bluetooth]# quit Apr 13 10:10:38 volumio-pk volumiobt[1620]: [59B blob data] Apr 13 10:10:39 volumio-pk volumio[1081]: info: MRS: Getting audio outputs on start Apr 13 10:10:39 volumio-pk volumio[1081]: info: MRS: Requesting all other devices output Apr 13 10:10:40 volumio-pk sudo[1690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 13 10:10:40 volumio-pk sudo[1690]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:40 volumio-pk sudo[1690]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:40 volumio-pk sudo[1692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 13 10:10:40 volumio-pk sudo[1692]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:40 volumio-pk sudo[1692]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:40 volumio-pk volumio[1081]: verbose: New Socket.io Connection to 10.0.1.91 from 10.0.1.28 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.3 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 7 Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:40 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:40 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:40 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:40 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:40 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:40 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:40 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:40 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:40 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetVisibleSources Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:40 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:40 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 13 10:10:40 volumio-pk volumio[1081]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 13 10:10:40 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:40 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:40 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:40 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:40 volumio-pk volumio[1081]: info: Listing playlists Apr 13 10:10:40 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:40 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:40 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:40 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:40 volumio-pk volumio[1081]: info: Received Get System Info Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 10:10:40 volumio-pk volumio[1081]: info: Discovery: Getting this device information Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:40 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:40 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 13 10:10:40 volumio-pk volumio[1081]: info: TidalConnect service started! Apr 13 10:10:40 volumio-pk volumio[1081]: [Metrics] CommandRouter: 28s 409.63ms Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::volumiosetStartupVolume Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::Close All Modals sent Apr 13 10:10:40 volumio-pk volumio[1081]: info: CoreCommandRouter::Close All Modals sent Apr 13 10:10:41 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:41 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:41 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 13 10:10:41 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 13 10:10:41 volumio-pk volumio[1081]: xcb_connection_has_error() returned true Apr 13 10:10:41 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 13 10:10:41 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 13 10:10:42 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 13 10:10:44 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 13 10:10:44 volumio-pk volumio[1081]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 13 10:10:44 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:44 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:44 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 10:10:44 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 13 10:10:47 volumio-pk volumio[1081]: info: Enabling plugin touch_display Apr 13 10:10:47 volumio-pk volumio[1081]: info: Loading plugin "touch_display"... Apr 13 10:10:47 volumio-pk volumio[1081]: info: PLUGIN START: touch_display Apr 13 10:10:47 volumio-pk volumio[1081]: info: Loading i18n strings for locale en Apr 13 10:10:47 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 13 10:10:47 volumio-pk sudo[1752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Apr 13 10:10:47 volumio-pk sudo[1752]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:47 volumio-pk sudo[1755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Apr 13 10:10:47 volumio-pk sudo[1755]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:47 volumio-pk volumio[1081]: info: BOOT COMPLETED Apr 13 10:10:47 volumio-pk volumio[1081]: info: touch_display: Backlight interface detected. Apr 13 10:10:47 volumio-pk sudo[1757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 13 10:10:47 volumio-pk sudo[1757]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:47 volumio-pk volumio[1081]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Apr 13 10:10:47 volumio-pk systemd[1]: Reloading. Apr 13 10:10:47 volumio-pk sudo[1752]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:47 volumio-pk volumio[1081]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Apr 13 10:10:47 volumio-pk sudo[1761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Apr 13 10:10:47 volumio-pk sudo[1761]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:47 volumio-pk sudo[1761]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:47 volumio-pk sudo[1764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/class/backlight/10-0045/brightness Apr 13 10:10:47 volumio-pk sudo[1764]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:47 volumio-pk sudo[1764]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:47 volumio-pk volumio[1081]: info: touch_display: systemctl stop getty@tty1.service succeeded. Apr 13 10:10:48 volumio-pk volumio[1081]: info: touch_display: File permissions for backlight brightness control set. Apr 13 10:10:48 volumio-pk volumio[1081]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Apr 13 10:10:48 volumio-pk systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 13 10:10:48 volumio-pk systemd[1]: Reloading. Apr 13 10:10:48 volumio-pk sudo[1755]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:48 volumio-pk volumio[1081]: info: touch_display: systemctl disable getty@tty1.service succeeded. Apr 13 10:10:48 volumio-pk systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 13 10:10:48 volumio-pk sudo[1757]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:48 volumio-pk volumio[1081]: info: touch_display: systemctl daemon-reload succeeded. Apr 13 10:10:48 volumio-pk sudo[1795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Apr 13 10:10:48 volumio-pk sudo[1795]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:10:49 volumio-pk systemd[1]: Started Volumio Kiosk. Apr 13 10:10:49 volumio-pk sudo[1795]: pam_unix(sudo:session): session closed for user root Apr 13 10:10:49 volumio-pk volumio[1081]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Apr 13 10:10:49 volumio-pk volumio[1081]: info: touch_display: Volumio Kiosk started. Apr 13 10:10:49 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:49 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:49 volumio-pk volumio[1081]: info: Done. Apr 13 10:10:49 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetState Apr 13 10:10:49 volumio-pk volumio[1081]: info: CorePlayQueue::getTrack 0 Apr 13 10:10:49 volumio-pk volumio[1081]: info: touch_display: X display number found: Apr 13 10:10:49 volumio-pk startx[1797]: xauth: file /home/volumio/.Xauthority does not exist Apr 13 10:10:49 volumio-pk startx[1797]: X.Org X Server 1.20.4 Apr 13 10:10:49 volumio-pk startx[1797]: X Protocol Version 11, Revision 0 Apr 13 10:10:49 volumio-pk startx[1797]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Apr 13 10:10:49 volumio-pk startx[1797]: Current Operating System: Linux volumio-pk 6.6.62-v7l+ #1816 SMP Mon Nov 18 15:33:33 GMT 2024 armv7l Apr 13 10:10:49 volumio-pk startx[1797]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory numa_policy=interleave snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_hdmi=0 video=HDMI-A-1:640x480M@60D smsc95xx.macaddr=D8:3A:DD:03:D1:64 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=31894860-154d-4623-adeb-3744ffaa6b75 imgfile=/volumio_current.sqsh bootpart=UUID=8E61-2966 datapart=UUID=ddd2acb8-eb82-4115-8903-a4448dfe67a8 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Apr 13 10:10:49 volumio-pk startx[1797]: Build Date: 04 April 2023 07:50:56AM Apr 13 10:10:49 volumio-pk startx[1797]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Apr 13 10:10:49 volumio-pk startx[1797]: Current version of pixman: 0.36.0 Apr 13 10:10:49 volumio-pk startx[1797]: Before reporting problems, check http://wiki.x.org Apr 13 10:10:49 volumio-pk startx[1797]: to make sure that you have the latest version. Apr 13 10:10:49 volumio-pk startx[1797]: Markers: (--) probed, (**) from config file, (==) default setting, Apr 13 10:10:49 volumio-pk startx[1797]: (++) from command line, (!!) notice, (II) informational, Apr 13 10:10:49 volumio-pk startx[1797]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Apr 13 10:10:49 volumio-pk startx[1797]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun Apr 13 10:10:49 2025 Apr 13 10:10:49 volumio-pk startx[1797]: (==) Using config directory: "/etc/X11/xorg.conf.d" Apr 13 10:10:49 volumio-pk startx[1797]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Apr 13 10:10:49 volumio-pk volumio[1081]: info: touch_display: X display number found: 0 Apr 13 10:10:49 volumio-pk volumio[1081]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 13 10:10:49 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 13 10:10:49 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:10:49 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 10:10:49 volumio-pk volumio[1081]: info: touch_display: X display number found: 0 Apr 13 10:10:49 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:49 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:10:49 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 13 10:10:49 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 13 10:10:49 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 13 10:10:49 volumio-pk volumio[1081]: info: CoreCommandRouter::volumioGetBrowseSources Apr 13 10:10:49 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 13 10:10:49 volumio-pk volumio-remote-updater[728]: No test mode Apr 13 10:10:49 volumio-pk volumio-remote-updater[728]: No alpha test mode Apr 13 10:10:49 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 13 10:10:49 volumio-pk volumio[1081]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 13 10:10:49 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 13 10:10:50 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 13 10:10:52 volumio-pk ntpd[843]: Soliciting pool server 81.27.192.20 Apr 13 10:10:53 volumio-pk ntpd[843]: Soliciting pool server 162.159.200.1 Apr 13 10:10:53 volumio-pk ntpd[843]: Soliciting pool server 89.203.251.72 Apr 13 10:10:54 volumio-pk ntpd[843]: Soliciting pool server 81.200.57.13 Apr 13 10:10:54 volumio-pk ntpd[843]: Soliciting pool server 194.182.84.241 Apr 13 10:10:55 volumio-pk ntpd[843]: Soliciting pool server 147.251.48.140 Apr 13 10:10:55 volumio-pk ntpd[843]: Soliciting pool server 195.58.34.161 Apr 13 10:10:55 volumio-pk ntpd[843]: Soliciting pool server 5.1.56.123 Apr 13 10:10:56 volumio-pk ntpd[843]: Soliciting pool server 2001:470:6f:483::1 Apr 13 10:10:56 volumio-pk ntpd[843]: Soliciting pool server 80.211.220.41 Apr 13 10:10:56 volumio-pk ntpd[843]: Soliciting pool server 93.99.104.53 Apr 13 10:10:57 volumio-pk ntpd[843]: Soliciting pool server 195.58.34.65 Apr 13 10:10:57 volumio-pk ntpd[843]: Soliciting pool server 162.159.200.123 Apr 13 10:10:59 volumio-pk kernel: vc4-drm gpu: [drm] *ERROR* [CRTC:103:pixelvalve-2] flip_done timed out Apr 13 10:11:02 volumio-pk ntpd[843]: receive: Unexpected origin timestamp 0xeba5f014.e671fa87 does not match aorg 0000000000.00000000 from server@93.99.104.53 xmt 0xeba5f016.17863eb8 Apr 13 10:11:02 volumio-pk ntpd[843]: receive: Unexpected origin timestamp 0xeba5f014.e674a3cd does not match aorg 0000000000.00000000 from server@80.211.220.41 xmt 0xeba5f016.17b19736 Apr 13 10:11:02 volumio-pk ntpd[843]: receive: Unexpected origin timestamp 0xeba5f014.e677d765 does not match aorg 0000000000.00000000 from server@194.182.84.241 xmt 0xeba5f016.17e61674 Apr 13 10:11:02 volumio-pk ntpd[843]: receive: Unexpected origin timestamp 0xeba5f014.e6764b58 does not match aorg 0000000000.00000000 from server@5.1.56.123 xmt 0xeba5f016.18296888 Apr 13 10:11:02 volumio-pk ntpd[843]: receive: Unexpected origin timestamp 0xeba5f014.e6770a3f does not match aorg 0000000000.00000000 from server@81.200.57.13 xmt 0xeba5f016.1839bb95 Apr 13 10:11:02 volumio-pk ntpd[843]: receive: Unexpected origin timestamp 0xeba5f014.e67587c0 does not match aorg 0000000000.00000000 from server@195.58.34.161 xmt 0xeba5f016.1d4cb20a Apr 13 10:11:10 volumio-pk volumio[1081]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 10:11:11 volumio-pk kernel: vc4-drm gpu: [drm] *ERROR* flip_done timed out Apr 13 10:11:11 volumio-pk kernel: vc4-drm gpu: [drm] *ERROR* [CRTC:103:pixelvalve-2] commit wait timed out Apr 13 10:11:21 volumio-pk kernel: vc4-drm gpu: [drm] *ERROR* flip_done timed out Apr 13 10:11:21 volumio-pk kernel: vc4-drm gpu: [drm] *ERROR* [CONNECTOR:32:HDMI-A-1] commit wait timed out Apr 13 10:11:26 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 10:11:26 volumio-pk volumio[1081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 13 10:11:28 volumio-pk sudo[1895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Apr 13 10:11:28 volumio-pk sudo[1895]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:11:28 volumio-pk sudo[1895]: pam_unix(sudo:session): session closed for user root Apr 13 10:11:28 volumio-pk sudo[1898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Apr 13 10:11:28 volumio-pk sudo[1898]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:11:28 volumio-pk sudo[1901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Apr 13 10:11:28 volumio-pk sudo[1901]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:11:28 volumio-pk volumio[1081]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Apr 13 10:11:28 volumio-pk volumio[1081]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 10:11:28 volumio-pk systemd[1]: Created slice system-getty.slice. Apr 13 10:11:28 volumio-pk volumio[1081]: TypeError: Cannot read property 'split' of undefined Apr 13 10:11:28 volumio-pk volumio[1081]: at /data/plugins/user_interface/touch_display/index.js:1258:37 Apr 13 10:11:28 volumio-pk volumio[1081]: at ChildProcess.exithandler (child_process.js:299:7) Apr 13 10:11:28 volumio-pk volumio[1081]: at ChildProcess.emit (events.js:315:20) Apr 13 10:11:28 volumio-pk volumio[1081]: at maybeClose (internal/child_process.js:1048:16) Apr 13 10:11:28 volumio-pk volumio[1081]: at Socket. (internal/child_process.js:439:11) Apr 13 10:11:28 volumio-pk volumio[1081]: at Socket.emit (events.js:315:20) Apr 13 10:11:28 volumio-pk volumio[1081]: at Pipe. (net.js:673:12) Apr 13 10:11:28 volumio-pk volumio[1081]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 10:11:28 volumio-pk sudo[1904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Apr 13 10:11:28 volumio-pk sudo[1904]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 10:11:29 volumio-pk sudo[1916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-13 10:10 Apr 13 10:11:29 volumio-pk sudo[1916]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"